builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1495645190.04 results: success (0) revision: 37d777d872002597198405f22eefa9199e5103af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.038470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.038963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.039239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.055257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.055556) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 09:59:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-05-24 09:59:50 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.200338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.200643) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:50.252456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 09:59:50.254797) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37d777d872002597198405f22eefa9199e5103af --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 37d777d872002597198405f22eefa9199e5103af --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 09:59:50,380 truncating revision to first 12 chars 2017-05-24 09:59:50,380 Setting DEBUG logging. 2017-05-24 09:59:50,380 attempt 1/10 2017-05-24 09:59:50,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37d777d87200?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 09:59:51,218 unpacking tar archive at: mozilla-central-37d777d87200/testing/mozharness/ program finished with exit code 0 elapsedTime=1.123537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 09:59:51.390400) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:51.390717) ========= script_repo_revision: 37d777d872002597198405f22eefa9199e5103af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:51.394107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:51.394388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 09:59:51.402494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 09:59:51.402767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:51 INFO - MultiFileLogger online at 20170524 09:59:51 in /builds/slave/test 09:59:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:59:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:51 INFO - {'append_to_log': False, 09:59:51 INFO - 'base_work_dir': '/builds/slave/test', 09:59:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:59:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:51 INFO - 'branch': 'Firefox-Non-PGO', 09:59:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:51 INFO - 'config_files': ('talos/linux_config.py',), 09:59:51 INFO - 'default_actions': ('clobber', 09:59:51 INFO - 'read-buildbot-config', 09:59:51 INFO - 'download-and-extract', 09:59:51 INFO - 'populate-webroot', 09:59:51 INFO - 'create-virtualenv', 09:59:51 INFO - 'install', 09:59:51 INFO - 'run-tests'), 09:59:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:51 INFO - 'download_minidump_stackwalk': True, 09:59:51 INFO - 'download_symbols': 'ondemand', 09:59:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:51 INFO - 'gecko_profile': False, 09:59:51 INFO - 'gecko_profile_interval': 0, 09:59:51 INFO - 'installer_path': 'installer.exe', 09:59:51 INFO - 'log_level': 'info', 09:59:51 INFO - 'log_name': 'talos', 09:59:51 INFO - 'log_to_console': True, 09:59:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:51 INFO - 'opt_config_files': (), 09:59:51 INFO - 'pip_index': False, 09:59:51 INFO - 'suite': 'dromaeojs-e10s', 09:59:51 INFO - 'system_bits': '32', 09:59:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:51 INFO - 'title': 'talos-linux64-ix-006', 09:59:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:51 INFO - 'use_talos_json': True, 09:59:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:51 INFO - 'work_dir': 'build'} 09:59:51 INFO - [mozharness: 2017-05-24 16:59:51.632422Z] Running clobber step. 09:59:51 INFO - Running pre-action listener: _resource_record_pre_action 09:59:51 INFO - Running main action method: clobber 09:59:51 INFO - rmtree: /builds/slave/test/build 09:59:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:52 INFO - Running post-action listener: _resource_record_post_action 09:59:52 INFO - [mozharness: 2017-05-24 16:59:52.638977Z] Finished clobber step (success) 09:59:52 INFO - [mozharness: 2017-05-24 16:59:52.639078Z] Running read-buildbot-config step. 09:59:52 INFO - Running pre-action listener: _resource_record_pre_action 09:59:52 INFO - Running main action method: read_buildbot_config 09:59:52 INFO - Using buildbot properties: 09:59:52 INFO - { 09:59:52 INFO - "project": "", 09:59:52 INFO - "product": "firefox", 09:59:52 INFO - "who": "bhearsum@mozilla.com", 09:59:52 INFO - "installer_path": "public/build/target.tar.bz2", 09:59:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:59:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:59:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:59:52 INFO - "stage_platform": "linux64", 09:59:52 INFO - "basedir": "/builds/slave/test", 09:59:52 INFO - "buildnumber": 848, 09:59:52 INFO - "platform": "ubuntu64_hw", 09:59:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:59:52 INFO - "slavebuilddir": "test", 09:59:52 INFO - "taskId": "Xrc8GaFDRyiMQoetur7bWg", 09:59:52 INFO - "branch": "mozilla-central", 09:59:52 INFO - "script_repo_revision": "production", 09:59:52 INFO - "revision": "37d777d872002597198405f22eefa9199e5103af", 09:59:52 INFO - "slavename": "talos-linux64-ix-006", 09:59:52 INFO - "repo_path": "mozilla-central" 09:59:52 INFO - } 09:59:52 INFO - Finding installer, test and symbols from parent task. 09:59:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xrc8GaFDRyiMQoetur7bWg'}, attempt #1 09:59:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xrc8GaFDRyiMQoetur7bWg'}, attempt #1 09:59:53 INFO - Task dependencies: P3jmION2Qoa1DZZEpebAGg 09:59:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg'}, attempt #1 09:59:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 09:59:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/test_packages.json 09:59:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.crashreporter-symbols.zip 09:59:54 INFO - Running post-action listener: _resource_record_post_action 09:59:54 INFO - [mozharness: 2017-05-24 16:59:54.029552Z] Finished read-buildbot-config step (success) 09:59:54 INFO - [mozharness: 2017-05-24 16:59:54.029774Z] Running download-and-extract step. 09:59:54 INFO - Running pre-action listener: _resource_record_pre_action 09:59:54 INFO - Running main action method: download_and_extract 09:59:54 INFO - mkdir: /builds/slave/test/build/tests 09:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:54 INFO - trying https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.test_packages.json 09:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:59:54 INFO - Downloaded 986 bytes. 09:59:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:59:54 INFO - Using the following test package requirements: 09:59:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:59:54 INFO - u'common': [u'target.common.tests.zip'], 09:59:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:59:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:59:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:59:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:59:54 INFO - u'mozbase': [u'target.common.tests.zip'], 09:59:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:59:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:59:54 INFO - u'web-platform': [u'target.common.tests.zip', 09:59:54 INFO - u'target.web-platform.tests.zip'], 09:59:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:59:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:59:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip 09:59:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:59:54 INFO - Fetch https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip into memory 09:59:55 INFO - Content-Length response header: 63523787 09:59:55 INFO - Bytes received: 63523787 10:00:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip 10:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.common.tests.zip into memory 10:00:07 INFO - Content-Length response header: 63523787 10:00:07 INFO - Bytes received: 63523787 10:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.talos.tests.zip 10:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.talos.tests.zip into memory 10:00:21 INFO - Content-Length response header: 14411859 10:00:21 INFO - Bytes received: 14411859 10:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:21 INFO - trying https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 10:00:21 INFO - Downloading https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:00:22 INFO - Downloaded 54820386 bytes. 10:00:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 10:00:22 INFO - mkdir: /builds/slave/test/properties 10:00:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:22 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:22 INFO - Contents: 10:00:22 INFO - build_url:https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 10:00:22 INFO - Running post-action listener: _resource_record_post_action 10:00:22 INFO - Running post-action listener: set_extra_try_arguments 10:00:22 INFO - [mozharness: 2017-05-24 17:00:22.774208Z] Finished download-and-extract step (success) 10:00:22 INFO - [mozharness: 2017-05-24 17:00:22.774305Z] Running populate-webroot step. 10:00:22 INFO - Running pre-action listener: _resource_record_pre_action 10:00:22 INFO - Running main action method: populate_webroot 10:00:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:22 INFO - '--tppagecycles', 10:00:22 INFO - '7'], 10:00:22 INFO - 'tests': ['tsvgm']}}, 10:00:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['damp', 'tps']}, 10:00:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'tests': ['damp', 'tps']}, 10:00:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['dromaeo_dom']}, 10:00:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:00:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:00:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:00:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['a11yr', 10:00:22 INFO - 'ts_paint', 10:00:22 INFO - 'tpaint', 10:00:22 INFO - 'sessionrestore', 10:00:22 INFO - 'sessionrestore_no_auto_restore', 10:00:22 INFO - 'tabpaint']}, 10:00:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:00:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:00:22 INFO - 'bloom_basic_ref']}, 10:00:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['tsvgx', 10:00:22 INFO - 'tsvgr_opacity', 10:00:22 INFO - 'tart', 10:00:22 INFO - 'tscrollx', 10:00:22 INFO - 'cart', 10:00:22 INFO - 'tsvg_static']}, 10:00:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:22 INFO - 'tsvgr_opacity', 10:00:22 INFO - 'tart', 10:00:22 INFO - 'tscrollx', 10:00:22 INFO - 'cart', 10:00:22 INFO - 'tsvg_static']}, 10:00:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'talos_options': ['--disable-e10s'], 10:00:22 INFO - 'tests': ['tp5o']}, 10:00:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:00:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'talos_options': ['--disable-e10s', 10:00:22 INFO - '--xperf_path', 10:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:22 INFO - 'tests': ['tp5n']}, 10:00:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:00:22 INFO - 'talos_options': ['--xperf_path', 10:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:22 INFO - 'tests': ['tp5n']}}, 10:00:22 INFO - 'talos.zip': {'path': '', 10:00:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:22 INFO - Running post-action listener: _resource_record_post_action 10:00:22 INFO - [mozharness: 2017-05-24 17:00:22.788235Z] Finished populate-webroot step (success) 10:00:22 INFO - [mozharness: 2017-05-24 17:00:22.788324Z] Running create-virtualenv step. 10:00:22 INFO - Running pre-action listener: _resource_record_pre_action 10:00:22 INFO - Running main action method: create_virtualenv 10:00:22 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:00:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:22 INFO - Using real prefix '/usr' 10:00:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:25 INFO - Installing pip.................done. 10:00:25 INFO - Return code: 0 10:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:00:25 INFO - Reading from file tmpfile_stdout 10:00:25 INFO - Output received: 10:00:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:00:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:00:25 INFO - Using env: {'DISPLAY': ':0', 10:00:25 INFO - 'HOME': '/home/cltbld', 10:00:25 INFO - 'LANG': 'en_US.UTF-8', 10:00:25 INFO - 'LANGUAGE': 'en_US:en', 10:00:25 INFO - 'LOGNAME': 'cltbld', 10:00:25 INFO - 'MAIL': '/var/mail/cltbld', 10:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:25 INFO - 'MOZ_NO_REMOTE': '1', 10:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:25 INFO - 'NO_EM_RESTART': '1', 10:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:25 INFO - 'PWD': '/builds/slave/test', 10:00:25 INFO - 'SHELL': '/bin/bash', 10:00:25 INFO - 'SHLVL': '1', 10:00:25 INFO - 'TERM': 'linux', 10:00:25 INFO - 'TMOUT': '86400', 10:00:25 INFO - 'USER': 'cltbld', 10:00:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:25 INFO - '_': '/tools/buildbot/bin/python'} 10:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:00:25 INFO - Cleaning up... 10:00:25 INFO - Return code: 0 10:00:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:00:25 INFO - Using env: {'DISPLAY': ':0', 10:00:25 INFO - 'HOME': '/home/cltbld', 10:00:25 INFO - 'LANG': 'en_US.UTF-8', 10:00:25 INFO - 'LANGUAGE': 'en_US:en', 10:00:25 INFO - 'LOGNAME': 'cltbld', 10:00:25 INFO - 'MAIL': '/var/mail/cltbld', 10:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:25 INFO - 'MOZ_NO_REMOTE': '1', 10:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:25 INFO - 'NO_EM_RESTART': '1', 10:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:25 INFO - 'PWD': '/builds/slave/test', 10:00:25 INFO - 'SHELL': '/bin/bash', 10:00:25 INFO - 'SHLVL': '1', 10:00:25 INFO - 'TERM': 'linux', 10:00:25 INFO - 'TMOUT': '86400', 10:00:25 INFO - 'USER': 'cltbld', 10:00:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:25 INFO - '_': '/tools/buildbot/bin/python'} 10:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:25 INFO - Downloading/unpacking psutil>=3.1.1 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:27 INFO - Installing collected packages: psutil 10:00:27 INFO - Running setup.py install for psutil 10:00:27 INFO - building 'psutil._psutil_linux' extension 10:00:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:00:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:00:27 INFO - building 'psutil._psutil_posix' extension 10:00:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:00:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:27 INFO - Successfully installed psutil 10:00:27 INFO - Cleaning up... 10:00:27 INFO - Return code: 0 10:00:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:00:27 INFO - Using env: {'DISPLAY': ':0', 10:00:27 INFO - 'HOME': '/home/cltbld', 10:00:27 INFO - 'LANG': 'en_US.UTF-8', 10:00:27 INFO - 'LANGUAGE': 'en_US:en', 10:00:27 INFO - 'LOGNAME': 'cltbld', 10:00:27 INFO - 'MAIL': '/var/mail/cltbld', 10:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:27 INFO - 'MOZ_NO_REMOTE': '1', 10:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:27 INFO - 'NO_EM_RESTART': '1', 10:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:27 INFO - 'PWD': '/builds/slave/test', 10:00:27 INFO - 'SHELL': '/bin/bash', 10:00:27 INFO - 'SHLVL': '1', 10:00:27 INFO - 'TERM': 'linux', 10:00:27 INFO - 'TMOUT': '86400', 10:00:27 INFO - 'USER': 'cltbld', 10:00:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:27 INFO - '_': '/tools/buildbot/bin/python'} 10:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:29 INFO - Installing collected packages: mozsystemmonitor 10:00:29 INFO - Running setup.py install for mozsystemmonitor 10:00:29 INFO - Successfully installed mozsystemmonitor 10:00:29 INFO - Cleaning up... 10:00:29 INFO - Return code: 0 10:00:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:00:29 INFO - Using env: {'DISPLAY': ':0', 10:00:29 INFO - 'HOME': '/home/cltbld', 10:00:29 INFO - 'LANG': 'en_US.UTF-8', 10:00:29 INFO - 'LANGUAGE': 'en_US:en', 10:00:29 INFO - 'LOGNAME': 'cltbld', 10:00:29 INFO - 'MAIL': '/var/mail/cltbld', 10:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:29 INFO - 'MOZ_NO_REMOTE': '1', 10:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:29 INFO - 'NO_EM_RESTART': '1', 10:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:29 INFO - 'PWD': '/builds/slave/test', 10:00:29 INFO - 'SHELL': '/bin/bash', 10:00:29 INFO - 'SHLVL': '1', 10:00:29 INFO - 'TERM': 'linux', 10:00:29 INFO - 'TMOUT': '86400', 10:00:29 INFO - 'USER': 'cltbld', 10:00:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:29 INFO - '_': '/tools/buildbot/bin/python'} 10:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:30 INFO - warning: no files found matching '*.txt' 10:00:30 INFO - no previously-included directories found matching 'build' 10:00:30 INFO - no previously-included directories found matching 'dist' 10:00:30 INFO - no previously-included directories found matching '.git*' 10:00:30 INFO - Installing collected packages: jsonschema, functools32 10:00:30 INFO - Running setup.py install for functools32 10:00:30 INFO - warning: no files found matching '*.txt' 10:00:30 INFO - no previously-included directories found matching 'build' 10:00:30 INFO - no previously-included directories found matching 'dist' 10:00:30 INFO - no previously-included directories found matching '.git*' 10:00:30 INFO - Successfully installed jsonschema functools32 10:00:30 INFO - Cleaning up... 10:00:30 INFO - Return code: 0 10:00:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:00:30 INFO - Using env: {'DISPLAY': ':0', 10:00:30 INFO - 'HOME': '/home/cltbld', 10:00:30 INFO - 'LANG': 'en_US.UTF-8', 10:00:30 INFO - 'LANGUAGE': 'en_US:en', 10:00:30 INFO - 'LOGNAME': 'cltbld', 10:00:30 INFO - 'MAIL': '/var/mail/cltbld', 10:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:30 INFO - 'MOZ_NO_REMOTE': '1', 10:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:30 INFO - 'NO_EM_RESTART': '1', 10:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:30 INFO - 'PWD': '/builds/slave/test', 10:00:30 INFO - 'SHELL': '/bin/bash', 10:00:30 INFO - 'SHLVL': '1', 10:00:30 INFO - 'TERM': 'linux', 10:00:30 INFO - 'TMOUT': '86400', 10:00:30 INFO - 'USER': 'cltbld', 10:00:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:30 INFO - '_': '/tools/buildbot/bin/python'} 10:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:00:31 INFO - Cleaning up... 10:00:31 INFO - Return code: 0 10:00:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:00:31 INFO - Using env: {'DISPLAY': ':0', 10:00:31 INFO - 'HOME': '/home/cltbld', 10:00:31 INFO - 'LANG': 'en_US.UTF-8', 10:00:31 INFO - 'LANGUAGE': 'en_US:en', 10:00:31 INFO - 'LOGNAME': 'cltbld', 10:00:31 INFO - 'MAIL': '/var/mail/cltbld', 10:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:31 INFO - 'MOZ_NO_REMOTE': '1', 10:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:31 INFO - 'NO_EM_RESTART': '1', 10:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:31 INFO - 'PWD': '/builds/slave/test', 10:00:31 INFO - 'SHELL': '/bin/bash', 10:00:31 INFO - 'SHLVL': '1', 10:00:31 INFO - 'TERM': 'linux', 10:00:31 INFO - 'TMOUT': '86400', 10:00:31 INFO - 'USER': 'cltbld', 10:00:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:31 INFO - '_': '/tools/buildbot/bin/python'} 10:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:32 INFO - Downloading docopt-0.6.1.tar.gz 10:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:33 INFO - Running setup.py install for blobuploader 10:00:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:33 INFO - Running setup.py install for requests 10:00:33 INFO - Running setup.py install for docopt 10:00:33 INFO - Successfully installed blobuploader requests docopt 10:00:33 INFO - Cleaning up... 10:00:33 INFO - Return code: 0 10:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:33 INFO - Using env: {'DISPLAY': ':0', 10:00:33 INFO - 'HOME': '/home/cltbld', 10:00:33 INFO - 'LANG': 'en_US.UTF-8', 10:00:33 INFO - 'LANGUAGE': 'en_US:en', 10:00:33 INFO - 'LOGNAME': 'cltbld', 10:00:33 INFO - 'MAIL': '/var/mail/cltbld', 10:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:33 INFO - 'MOZ_NO_REMOTE': '1', 10:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:33 INFO - 'NO_EM_RESTART': '1', 10:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:33 INFO - 'PWD': '/builds/slave/test', 10:00:33 INFO - 'SHELL': '/bin/bash', 10:00:33 INFO - 'SHLVL': '1', 10:00:33 INFO - 'TERM': 'linux', 10:00:33 INFO - 'TMOUT': '86400', 10:00:33 INFO - 'USER': 'cltbld', 10:00:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:33 INFO - '_': '/tools/buildbot/bin/python'} 10:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:33 INFO - Running setup.py (path:/tmp/pip-CmUAAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:33 INFO - Running setup.py (path:/tmp/pip-dYMdJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:33 INFO - Running setup.py (path:/tmp/pip-mLv3Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:34 INFO - Running setup.py (path:/tmp/pip-nl3jUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:34 INFO - Running setup.py (path:/tmp/pip-KZr5sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:34 INFO - Running setup.py (path:/tmp/pip-KET8a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:34 INFO - Running setup.py (path:/tmp/pip-hCmgk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:34 INFO - Running setup.py (path:/tmp/pip-PbTj8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:34 INFO - Running setup.py (path:/tmp/pip-Li9nh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:34 INFO - Running setup.py (path:/tmp/pip-lGy1Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:34 INFO - Running setup.py (path:/tmp/pip-RkZRPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:34 INFO - Running setup.py (path:/tmp/pip-wdf2yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:34 INFO - Running setup.py (path:/tmp/pip-NixOry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:34 INFO - Running setup.py (path:/tmp/pip-G4Hs7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:34 INFO - Running setup.py (path:/tmp/pip-uxELnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:34 INFO - Running setup.py (path:/tmp/pip-kfwwwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:34 INFO - Running setup.py (path:/tmp/pip-xvVrzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:35 INFO - Running setup.py install for manifestparser 10:00:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Running setup.py install for mozcrash 10:00:35 INFO - Running setup.py install for mozdebug 10:00:35 INFO - Running setup.py install for mozdevice 10:00:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Running setup.py install for mozfile 10:00:35 INFO - Running setup.py install for mozhttpd 10:00:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Running setup.py install for mozinfo 10:00:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Running setup.py install for mozInstall 10:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:35 INFO - Running setup.py install for mozleak 10:00:35 INFO - Running setup.py install for mozlog 10:00:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Running setup.py install for moznetwork 10:00:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Running setup.py install for mozprocess 10:00:36 INFO - Running setup.py install for mozprofile 10:00:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Running setup.py install for mozrunner 10:00:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Running setup.py install for mozscreenshot 10:00:36 INFO - Running setup.py install for moztest 10:00:36 INFO - Running setup.py install for mozversion 10:00:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:36 INFO - Cleaning up... 10:00:36 INFO - Return code: 0 10:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:36 INFO - Using env: {'DISPLAY': ':0', 10:00:36 INFO - 'HOME': '/home/cltbld', 10:00:36 INFO - 'LANG': 'en_US.UTF-8', 10:00:36 INFO - 'LANGUAGE': 'en_US:en', 10:00:36 INFO - 'LOGNAME': 'cltbld', 10:00:36 INFO - 'MAIL': '/var/mail/cltbld', 10:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:36 INFO - 'MOZ_NO_REMOTE': '1', 10:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:36 INFO - 'NO_EM_RESTART': '1', 10:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:36 INFO - 'PWD': '/builds/slave/test', 10:00:36 INFO - 'SHELL': '/bin/bash', 10:00:36 INFO - 'SHLVL': '1', 10:00:36 INFO - 'TERM': 'linux', 10:00:36 INFO - 'TMOUT': '86400', 10:00:36 INFO - 'USER': 'cltbld', 10:00:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:36 INFO - '_': '/tools/buildbot/bin/python'} 10:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:37 INFO - Running setup.py (path:/tmp/pip-F9SHiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:37 INFO - Running setup.py (path:/tmp/pip-zSuYHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:37 INFO - Running setup.py (path:/tmp/pip-vc6JYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:37 INFO - Running setup.py (path:/tmp/pip-tknIqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:37 INFO - Running setup.py (path:/tmp/pip-twI1WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:37 INFO - Running setup.py (path:/tmp/pip-daM8n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:37 INFO - Running setup.py (path:/tmp/pip-2ls0q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:37 INFO - Running setup.py (path:/tmp/pip-iAFNUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:37 INFO - Running setup.py (path:/tmp/pip-OBVDoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:37 INFO - Running setup.py (path:/tmp/pip-ztujPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:37 INFO - Running setup.py (path:/tmp/pip-Wlwv_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:37 INFO - Running setup.py (path:/tmp/pip-7Z7vKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:37 INFO - Running setup.py (path:/tmp/pip-s0kzpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:37 INFO - Running setup.py (path:/tmp/pip-1wtZCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:38 INFO - Running setup.py (path:/tmp/pip-YmmG4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:38 INFO - Running setup.py (path:/tmp/pip-eNRBhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:38 INFO - Running setup.py (path:/tmp/pip-18hgGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:39 INFO - Downloading blessings-1.6.tar.gz 10:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:39 INFO - Installing collected packages: blessings 10:00:39 INFO - Running setup.py install for blessings 10:00:39 INFO - Successfully installed blessings 10:00:39 INFO - Cleaning up... 10:00:39 INFO - Return code: 0 10:00:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:39 INFO - Reading from file tmpfile_stdout 10:00:39 INFO - Current package versions: 10:00:39 INFO - argparse == 1.2.1 10:00:39 INFO - blessings == 1.6 10:00:39 INFO - blobuploader == 1.2.4 10:00:39 INFO - docopt == 0.6.1 10:00:39 INFO - functools32 == 3.2.3-2 10:00:39 INFO - jsonschema == 2.5.1 10:00:39 INFO - manifestparser == 1.1 10:00:39 INFO - mozInstall == 1.12 10:00:39 INFO - mozcrash == 1.0 10:00:39 INFO - mozdebug == 0.1 10:00:39 INFO - mozdevice == 0.50 10:00:39 INFO - mozfile == 1.2 10:00:39 INFO - mozhttpd == 0.7 10:00:39 INFO - mozinfo == 0.9 10:00:39 INFO - mozleak == 0.1 10:00:39 INFO - mozlog == 3.4 10:00:39 INFO - moznetwork == 0.27 10:00:39 INFO - mozprocess == 0.25 10:00:39 INFO - mozprofile == 0.28 10:00:39 INFO - mozrunner == 6.13 10:00:39 INFO - mozscreenshot == 0.1 10:00:39 INFO - mozsystemmonitor == 0.3 10:00:39 INFO - moztest == 0.8 10:00:39 INFO - mozversion == 1.4 10:00:39 INFO - psutil == 3.1.1 10:00:39 INFO - requests == 1.2.3 10:00:39 INFO - wsgiref == 0.1.2 10:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:39 INFO - Using env: {'DISPLAY': ':0', 10:00:39 INFO - 'HOME': '/home/cltbld', 10:00:39 INFO - 'LANG': 'en_US.UTF-8', 10:00:39 INFO - 'LANGUAGE': 'en_US:en', 10:00:39 INFO - 'LOGNAME': 'cltbld', 10:00:39 INFO - 'MAIL': '/var/mail/cltbld', 10:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:39 INFO - 'MOZ_NO_REMOTE': '1', 10:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:39 INFO - 'NO_EM_RESTART': '1', 10:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:39 INFO - 'PWD': '/builds/slave/test', 10:00:39 INFO - 'SHELL': '/bin/bash', 10:00:39 INFO - 'SHLVL': '1', 10:00:39 INFO - 'TERM': 'linux', 10:00:39 INFO - 'TMOUT': '86400', 10:00:39 INFO - 'USER': 'cltbld', 10:00:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:39 INFO - '_': '/tools/buildbot/bin/python'} 10:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:00:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:00:41 INFO - Installing collected packages: marionette-driver 10:00:41 INFO - Running setup.py install for marionette-driver 10:00:41 INFO - Successfully installed marionette-driver 10:00:41 INFO - Cleaning up... 10:00:41 INFO - Return code: 0 10:00:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:00:41 INFO - Using env: {'DISPLAY': ':0', 10:00:41 INFO - 'HOME': '/home/cltbld', 10:00:41 INFO - 'LANG': 'en_US.UTF-8', 10:00:41 INFO - 'LANGUAGE': 'en_US:en', 10:00:41 INFO - 'LOGNAME': 'cltbld', 10:00:41 INFO - 'MAIL': '/var/mail/cltbld', 10:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:41 INFO - 'MOZ_NO_REMOTE': '1', 10:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:41 INFO - 'NO_EM_RESTART': '1', 10:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:41 INFO - 'PWD': '/builds/slave/test', 10:00:41 INFO - 'SHELL': '/bin/bash', 10:00:41 INFO - 'SHLVL': '1', 10:00:41 INFO - 'TERM': 'linux', 10:00:41 INFO - 'TMOUT': '86400', 10:00:41 INFO - 'USER': 'cltbld', 10:00:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:41 INFO - '_': '/tools/buildbot/bin/python'} 10:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:41 INFO - Cleaning up... 10:00:41 INFO - Return code: 0 10:00:41 INFO - Running post-action listener: _resource_record_post_action 10:00:41 INFO - Running post-action listener: _start_resource_monitoring 10:00:41 INFO - Starting resource monitoring. 10:00:41 INFO - [mozharness: 2017-05-24 17:00:41.612807Z] Finished create-virtualenv step (success) 10:00:41 INFO - [mozharness: 2017-05-24 17:00:41.613280Z] Running install step. 10:00:41 INFO - Running pre-action listener: _resource_record_pre_action 10:00:41 INFO - Running main action method: install 10:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:41 INFO - Reading from file tmpfile_stdout 10:00:41 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:41 INFO - Reading from file tmpfile_stdout 10:00:41 INFO - Output received: 10:00:41 INFO - Usage: mozinstall [options] installer 10:00:41 INFO - Options: 10:00:41 INFO - -h, --help show this help message and exit 10:00:41 INFO - -d DEST, --destination=DEST 10:00:41 INFO - Directory to install application into. [default: 10:00:41 INFO - "/builds/slave/test"] 10:00:41 INFO - --app=APP Application being installed. [default: firefox] 10:00:41 INFO - mkdir: /builds/slave/test/build/application 10:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:00:57 INFO - Reading from file tmpfile_stdout 10:00:57 INFO - Output received: 10:00:57 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:57 INFO - Running post-action listener: _resource_record_post_action 10:00:57 INFO - [mozharness: 2017-05-24 17:00:57.541956Z] Finished install step (success) 10:00:57 INFO - [mozharness: 2017-05-24 17:00:57.542228Z] Running run-tests step. 10:00:57 INFO - Running pre-action listener: _resource_record_pre_action 10:00:57 INFO - Running main action method: run_tests 10:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:57 INFO - Python 2.7.3 10:00:57 INFO - Return code: 0 10:00:57 INFO - grabbing minidump binary from tooltool 10:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20107a0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2011b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:00:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:00:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:00:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:57 INFO - Return code: 0 10:00:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:57 INFO - ENV: RUST_BACKTRACE is now 1 10:00:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:00:57 INFO - Using env: {'DISPLAY': ':0', 10:00:57 INFO - 'HOME': '/home/cltbld', 10:00:57 INFO - 'LANG': 'en_US.UTF-8', 10:00:57 INFO - 'LANGUAGE': 'en_US:en', 10:00:57 INFO - 'LOGNAME': 'cltbld', 10:00:57 INFO - 'MAIL': '/var/mail/cltbld', 10:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:57 INFO - 'MOZ_NO_REMOTE': '1', 10:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:57 INFO - 'NO_EM_RESTART': '1', 10:00:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:57 INFO - 'PWD': '/builds/slave/test', 10:00:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:57 INFO - 'RUST_BACKTRACE': '1', 10:00:57 INFO - 'SHELL': '/bin/bash', 10:00:57 INFO - 'SHLVL': '1', 10:00:57 INFO - 'TERM': 'linux', 10:00:57 INFO - 'TMOUT': '86400', 10:00:57 INFO - 'USER': 'cltbld', 10:00:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092', 10:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:57 INFO - '_': '/tools/buildbot/bin/python'} 10:00:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:00:57 INFO - mozversion application_buildid: 20170524163240 10:00:57 INFO - mozversion application_changeset: 37d777d872002597198405f22eefa9199e5103af 10:00:57 INFO - mozversion application_display_name: Nightly 10:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:57 INFO - mozversion application_name: Firefox 10:00:57 INFO - mozversion application_remotingname: firefox 10:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:00:57 INFO - mozversion application_vendor: Mozilla 10:00:57 INFO - mozversion application_version: 55.0a1 10:00:57 INFO - mozversion platform_buildid: 20170524163240 10:00:57 INFO - mozversion platform_changeset: 37d777d872002597198405f22eefa9199e5103af 10:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:00:57 INFO - mozversion platform_version: 55.0a1 10:00:57 INFO - using testdate: 1495645257 10:00:57 INFO - actual date: 1495645257 10:00:57 INFO - starting webserver on 'localhost:50459' 10:00:57 INFO - SUITE-START | Running 2 tests 10:00:57 INFO - TEST-START | dromaeo_css 10:00:57 INFO - operating with platform_type : linux_ 10:00:57 INFO - Initialising browser for dromaeo_css test... 10:00:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50459/getInfo.html -profile /tmp/tmpdh3MhN/profile 10:00:57 INFO - TEST-INFO | started process 7983 (/builds/slave/test/build/application/firefox/firefox http://localhost:50459/getInfo.html) 10:01:32 INFO - TEST-INFO | 7983: killed by SIGTERM 10:01:32 INFO - Browser initialized. 10:01:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:32 INFO - TEST-INFO | started process 8183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdh3MhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:44 INFO - PID 8183 | RSS: Main: 172445696 10:01:44 INFO - PID 8183 | 10:04:49 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50459/tests/dromaeo/cssquery-ext.html) 10:04:50 INFO - PID 8183 | RSS: Main: 169615360 10:04:50 INFO - PID 8183 | 10:07:52 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-ext.html (next: http://localhost:50459/tests/dromaeo/cssquery-jquery.html) 10:07:53 INFO - PID 8183 | RSS: Main: 175632384 10:07:53 INFO - PID 8183 | 10:10:54 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50459/tests/dromaeo/cssquery-mootools.html) 10:10:55 INFO - PID 8183 | RSS: Main: 174399488 10:10:55 INFO - PID 8183 | 10:13:57 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50459/tests/dromaeo/cssquery-prototype.html) 10:13:57 INFO - PID 8183 | RSS: Main: 178167808 10:13:57 INFO - PID 8183 | 10:17:00 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50459/tests/dromaeo/cssquery-yui.html) 10:17:01 INFO - PID 8183 | RSS: Main: 176889856 10:17:01 INFO - PID 8183 | 10:20:02 INFO - PID 8183 | Cycle 1(1): loaded http://localhost:50459/tests/dromaeo/cssquery-yui.html (next: http://localhost:50459/tests/dromaeo/cssquery-dojo.html) 10:20:03 INFO - PID 8183 | RSS: Main: 174678016 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | __start_tp_report 10:20:03 INFO - PID 8183 | _x_x_mozilla_page_load 10:20:03 INFO - PID 8183 | _x_x_mozilla_page_load_details 10:20:03 INFO - PID 8183 | |i|pagename|runs| 10:20:03 INFO - PID 8183 | |0;dojo.html;2698.703142654308;2711.2137480130764;2722.714115017923;2737.0146747171016;2741.259859837844;5044.949550504494;5243.947560524393;5250.369955605328;5265.052290587692;5267.209918512225;5117.846464606058;5175.689458632484;5181.896362072756;5185.403678576955;5198.428172900987;4618.237990731525;4672.042231342567;4685.64857635677;4715.976420117895;4727.716337019772;4552.294394368878;4709.576138147566;4712.104700106986;4740.549647783455;4766.332713420124;4577.473590537097;4676.953230467686;4683.414573178353;4751.382320298357;4802.97598512007;4618.145643056046;4620.491745907947;4671.462781780071;4714.222153344694;4716.646251531115;4645.117427688729;4651.953480465186;4661.650376221797;4667.22990706533;4708.95291047092;5138.845834624967;5189.065968125736;5243.056249875021;5263.552598029172;5281.234221037928;5593.860153496154;5658.801941932013;5673.546116310686;5717.371089180187;5730.598858079936;5692.288463942007;5693.516051135658;5693.800716974927;5698.458646428583;5722.313322401297;5273.789048438096;5275.920861187085;5276.15581506957;5277.445868183824;5317.069512835238;5674.631148975303;5736.913946290725;5742.626729262584;5750.539956803529;5802.419758024248;5494.450554944474;5569.749361278752;5582.553395728332;5587.720613969285;5591.8881622368135;5696.658200507983;5708.971455142698;5711.314642242957;5715.2855893013375;5715.942840571624;5544.112941929272;5645.745941432645;5651.943480565142;5668.95124401987;5674.574406919498;5505.944940550623;5564.054110801174;5570.08093664549;5605.80379686709;5703.942960570341;4797.904041919142;4808.519148085234;4813.446453657874;4836.661433699607;4854.68444551103;4088.4071809587444;4094.9795251023556;4108.137291168888;4116.835326586903;4194.3708443733685;4656.837010704609;4710.057988402334;4737.45519265282;4753.04939012199;4761.809527618856;5510.6969116698165;5636.774529018793;5636.943630563642;5639.943600563942;5664.348599910981;4743.241081427024;4752.453467851241;4758.357621721093;4762.333273341735;4803.087413391444;5059.595232381401;5071.137906555894;5078.923816142761;5087.771050302746;5120.718360490135;5079.77141028662;5099.852533180005;5143.125668636416;5151.974240128776;5215.634905556726;5565.693886836263;5662.009148399096;5739.540836733135;5783.3638299787835;5801.854953626024;5120.052790233819;5157.406898206755;5163.870903227449;5166.767495462788;5235.319408476874;5569.220309156803;5638.2670252866865;5640.717964101696;5640.71796410186;5645.604807663424;5726.914096288476;5745.368009519033;5751.1373294006235;5757.740901659519;5759.481646651821;5403.351597808288;5454.318210223722;5462.481064298885;5509.779608815603;5516.503514683537;5544.861378465571;5545.195946587803;5548.528375088163;5548.861278468071;5583.832485025456;5465.535429488538;5477.4248703887115;5478.424765399575;5491.780328786964;5540.36285827135;5373.838784836461;5440.673559586279;5455.563554915677;5551.139573366135;5601.159826025966;5368.812091576776;5369.973150134224;5371.543418809445;5377.623566350318;5414.160805075219 10:20:03 INFO - PID 8183 | |1;ext.html;634.8761991411676;684.5584597934333;702.9648517574121;1159.7506536094738;1208.70990962169;34139.82930085349;35184.296314073734;35279.64720352796;35335.2932941341;35546.46680299791;32784.344313113725;33016.50475242873;33071.338573228524;33092.834535827285;33154;6405.950095969291;6534.60792352458;6648.202215734119;6816.079829223066;6896.655167241618;6766.8308292292595;6849.623270720109;6859.314068593126;6868.896966545481;6883.139607549057;6831.11195544581;6893.896591551131;6899.482538809584;6902.689378977933;6903.929890866923;6847;6847.657617119125;6869.656517174121;6883.690233939485;6889.862202755967;6777.220619628756;6801.115854938876;6807.217170025411;6810.829729256759;6819.761308354184;31547.526787098213;31676.524852127237;31780.841095794603;31966.840165799254;32103.839480802446;3005.5641931919968;3019.773516986213;3027.5458681197774;3031.8180909145303;3046.5887105240954;24663.876680616482;24709.629355559682;24823.379415514577;24853.5029299413;24987;2803.201087690019;2826.5760135979563;2843.445528122017;2854.0866922584783;2858.9857050714822;145547;146395.2680236592;146727;150653;153928.46071539255;40018.599814001485;40087.39868901969;40226.59773402287;40353;40358.385664573674;41358;41802.58197417987;41925.371119433235;43372.56627433685;43940.78029609896;12353.258804471761;12360.629181124581;12400.75198496025;12401.379931003414;12422.192557483735;9703.369280996712;9734.75663108428;9754.804903901882;9766.46284454362;9807.313488055768;12805.679858003625;12880.613581592566;12929.353532323534;12974.610761677164;13183.802242966363;5419.295491586068;5420.457954204627;5448.237246785453;5463.399026107125;5554.416786237468;863.5250612163285;880.8062226310202;908.5411867007119;925.1997022575424;944.7826999790087;21215.575688486144;21482.355529334145;21538.676919846213;21609.747349964247;21703;989.7871957529165;992.454150217392;1011.8482227665762;1026.8921763214905;1035.6064695415844;10904.61833835812;11290.209685321948;11347.659570212907;11452.312861228353;11493.540258389738;175515;176269;176718;176728;176959;40217;40472.595274046886;40485.59514404877;40535;40677.796611016754;1216.4465168348556;1243.8880500754976;1257.528426839935;1259.212991880075;1266.050462153385;19140.61718765589;20151.79848201499;20826.895865520575;20838.228750555765;21077.6838347428;29384.265393364483;29475.820967161075;29579.40841183207;29629.703702962695;29687.25781855471;146740;147133;147303;147865;148254;29592.112236632936;29745.25636859096;29868.253293667833;29891.55162672518;29927.102186934426;34772.304553909285;36165.819170903975;36557.26885462329;36690.89927302185;36759.95640479599;27091.864540677172;27315.45369092567;27365.179044628694;27790;28449.857750711115;26834.329141771614;27142.457150857266;27705.86147069252;27795.44409111847;28637.713622863506;28490;28537.42925141527;28701.85649071741;28890.566641500816;29212.26969325784;25684.486310274064;26188.476230475666;26286.86856565705;26583.734162658126;27382.315442114108;19323;21864.781352186274;21893.781062189173;22054.228102016354;22085.33743987683 10:20:03 INFO - PID 8183 | |2;jquery.html;395.229302859424;405.58022446767603;413.4996654048601;423.37974866820105;433.5187941385062;17211.569710757238;17955.371561995333;17961.999999999985;18628.441146765585;19171.904140479277;18203;18452.354167604135;18552.35066772663;18570.814291857077;18598.81401185988;5368.516833484986;5376.220448035023;5431;5536.031194540959;5548.306461692288;5269.736513174345;5334.199870019509;5334.27987221724;5339.8398048058425;5340.359156901177;5218.634695571312;5301.549368303698;5320.813771517997;5327.813526526553;5333.093374126388;5405.243265942771;5454.890902181974;5475.698836563987;5480.095784195603;5485.259489968863;4864.440589332236;4889.1443997300685;4928.236123400843;4948.7278199699;4964.180910149821;21289.574208515896;21506.784932150636;21533;21537.892310538347;21644.567108657895;1545.5440645009749;1561.8281988981203;1569.0272031340642;1569.9607509812347;1576.9448069317634;14407.135571865616;14588.270586470633;14645.780313295309;14969.925150374178;14990.62523436912;2015.8387329013644;2092.06902928197;2114.767375588684;2134.3703607435846;2136.6260904341834;90590.547047265;92402;92777.53611231901;96181.5190924048;98453;10737.302075365076;10762;10906.182036347305;11137.053350465301;11158.386288754034;14853.851461485247;15389.691216388306;15452.38190472391;15477;15484.225788710519;7783.2216778322845;7791.532508049535;7898.68405263783;8054.114047454776;8067.596620168968;7268.928355418786;7315.085614298213;7330.266973302627;7516.285952834472;7533.54798712079;6915.111622463727;6924;7007.305105579274;7052.435805135577;7234.782956511313;1974.2892558678864;1980.920763169486;1991.2974406882197;2002.589469158819;2127.2660931978444;832.2592892325835;857.8498762716499;865.3812524045338;875.3347455933537;903.5527413930147;16558.337666493448;16621.916890415712;16640;17184.398546050827;17285.91357043207;854.9658013679508;868.5440143924491;882.0738224863995;893.4505279253212;897.0984160918366;9047.32145089121;9478.668246611336;9586.233101351874;9587.712368628952;9668.129868311886;362670;363462;363869;364938;370868;66681.33318666751;71347;72792.2720772796;72927;73499;1087.7063192938022;1111.0889070961896;1150.8216226484908;1154.9422528873522;1157.7742340243572;17163.425486177173;17843.286268549113;18397.356092537233;18466.907665461586;18483.445496635122;38657.613423865405;38683;39281;39613.207735845695;40732.79633601813;49257;49344;50169.49830501794;50201.748991256274;51287.23069153891;7947.125816160102;8003.479773814916;8081.676732930617;8263.380246481418;8348.286806787697;11716;13056.21662700241;13408.798868017182;13422.731545369234;13622;11426.600068997544;11455.255408398427;11603.477843496894;11681.240719353214;11743.41282935867;10868.369744538066;11085.334879907232;11144.88855111471;11258.66224013281;11583.189176757545;11633.185677002528;11722.531098755955;12003.699907502032;12159.452824622736;12298.323592202158;7946.801329966797;8019.077806052145;8156.388270879589;8230.818833009376;8403.831923361377;10786.568537258421;10797.92020797914;10949.726256843642;10989.560417583207;11269.887301127212 10:20:03 INFO - PID 8183 | |3;mootools.html;1225.5955534673556;1249.0819247852826;1267.0497127154633;1271.2944315904674;1286.8713128687132;10166.796664066715;10513;10645.520951557179;10663.520141593628;10744.086752626035;10320.225983051263;10500.894991050087;10503.212259080561;10558.419286939215;10568.260221784478;2174.3259589527256;2207.75714671386;2210.8341874359407;2214.202886960693;2219.511707424364;2134.8612340197915;2166.447555873258;2175.0755928730305;2176.6517357222847;2177.46652070243;2091.7803630618796;2129.5421484380854;2131.7868213178635;2134.2103421733905;2146.5170336674278;2044.2436298569476;2074.73028506294;2090.822280106193;2093.685947107946;2099.5276062885728;2046.0562465657686;2050.63088644044;2087.321620473352;2088.9164433422643;2197.9560408791895;10311.535980880803;10432.68701938943;10475.58097676092;10543.789124217472;10582.417967011812;5462.6995515246645;5622.91565626516;5648.943510564924;5662.801801936954;5668.943310566883;3308.106811160997;3428.3143371325837;3476.5828100628087;3481.930361392783;3498.142954976022;1092.0608276881876;1098.692366137475;1108.1245815805503;1116.4417791104447;1133.1048471707425;15747.05517668932;15858.286377113058;15862.44481443144;15900.443484478103;15941.282642281241;4652.255639097796;4807.735574543363;4919.950800492021;4946.604271658259;4997.275395067695;11129.054030407344;11149.888501114885;11152.665420037412;11179.4969226385;11249.268797528299;5468.890622187534;5661.943380566224;5710.5717071219;5713.685747283939;5739.253896993448;5082.33929589151;5220.738963051908;5249.42256351801;5274.97362513185;5294.92057619136;3774.8678796241998;3778.962210377916;3871.070942973666;3907.8632247871187;3998.300297447935;1132.7904337697553;1138.2032577195996;1141.0301243942583;1151.4703236511298;1152.1128730877178;627.6108812536256;652.4649787174566;670.1489108831854;672.3411057164006;681.7204945972128;5969.880602388015;6085.817425477154;6105.358937311607;6175.413335733098;6394;826.9710560130487;839.8194388206565;844.1178967978354;859.1451505751817;872.9956350218336;3986.661133803659;4019.31671615826;4042.7372220805555;4059.086705491241;4093.508778946486;13709.245991470565;14045.297735113203;14140.43438262458;14220.928895355457;14300.785488217685;13862.514811981533;13941.721165576631;13999.440022399194;14037.1577705338;14103.294835258195;7325.340719335285;7547.622618869144;7618.4667073305445;7667;7691.730789422343;5907.586468947305;6062.484688801501;6065.272167339947;6087.2999605044215;6181.381861813783;11812.645620631394;12031.578894738643;12047.638570842888;12176.39118044112;12280.631581052583;11865.525378984745;12518.248905065726;12529.874701252871;12564.120511564102;12592.244465332109;7812.53124812513;7918.049834019955;7932.206779322021;7987.880181797162;8014.599270036591;9327.766805829908;9481.478518681539;9583.424994500352;9614.759631009281;9630.662926797528;8031.879521807061;8068.515889046676;8173.795655108432;8235.13531079228;8237.341012718849;7794.298513133618;7824.178461261486;7841.059072911287;7947.205279472238;7959.124496305518;7418.48070635072;7547.396208303432;7577.128630207597;7600.695972161273;7604.695812167452;5183.870403239949;5393.8112166074;5398.676079435247;5406.080966235828;5678.801241956677;5481.808136715196;5564.276644036411;5568.359638641608;5647.604667673223;5744.511716504144 10:20:03 INFO - PID 8183 | |4;prototype.html;371.9702423806094;379.9696024318054;390.9061825161962;393.231232939603;397.29480172693445;5287.462018231242;5444.733160103936;5454.454554544549;5456.836294911154;5469.261649677293;5254.448282930294;5305.532927188857;5306.548943339821;5306.70813105279;5318.627696061278;4038.3336749436307;4040.8585699500522;4046.231216068952;4053.3109371406786;4056.655184309337;3922.2743792398355;4064.634182923536;4071.4707088078508;4075.2664520386465;4085.611866872642;4017.678585713136;4027.335489644205;4032.516098068236;4037.5962403759536;4043.1913617276664;3981.98009009956;4001.139470146396;4011.4183443400834;4017.0961533654986;4031.395290706388;3522.806245656488;3526.947095793565;3527.6119626841028;3537.540119784437;3538.6815186633326;5179.8446046618665;5197.714125723083;5236.842894713165;5238.633295669305;5244.265802787613;4685.320628508881;4694.859154225379;4718.363020992157;4724.244120940667;4728.05438912219;5483.835484935458;5627.746751396197;5628.183913332544;5637.548996080303;5648.576356773217;3925.8822235332987;3927.9214415711526;3931.646151846319;3939.625735555118;3941.2905676978135;5853.824385268406;5959.493443057346;5992.310884248323;5999.910046326146;6040.456358927674;4493.932591011137;4511.729296242236;4546.249868771682;4556.840510582114;4563.577317012241;4619.445666520039;4619.722816631013;4623.352730617717;4626.930596041062;4629.7222166669435;4963.975180124076;5018.172001619765;5050.696958182521;5054.725373581829;5058.114829904752;5742.684152371659;5769.884602308014;5776.104703770922;5777.537796976232;5787.652740835563;1580.581145996312;1608.0914283429825;1608.5094046315985;1613.9757903631455;1614.8708103351703;1100;1156;1159.96520104397;1170.1341007654444;1183.928964262147;4865.683730557574;4865.878353041202;4874.8781280467565;4877.756112194376;4894.2658601210105;5774.220480235199;5815.912761308584;5859.9197284964075;5896.528277737771;5897.262842144732;4633.281841314534;4813.831515896997;4859.95140048602;4865.6107511399005;4872.834795117187;3104.425681248931;3114.345987342638;3115.283484798509;3130.8591113399953;3140.905772826819;5224.92162617561;5309.36287645485;5358.223057656618;5368.758405871745;5388.245645609618;6018.187544681499;6022.277326720821;6027.638341699512;6045.969770151121;6062.333143354227;5341.679499229981;5383.031054410244;5395.81114660985;5400.783968641367;5401.297831281908;5655.519280861008;5881.441263080001;5913.935491611551;5932.8813423732145;5936.495397891227;5599.496045355774;5821.679807610622;5836.095405212199;5851.8537036572725;5863.824085277278;5342.225377320345;5371.919421208607;5382.273393091882;5399.352077750695;5405.918911216257;4015.5382131054134;4020.115574573706;4031;4035.1526179502634;4041.4139949707715;5882.264716910387;5903.2325797646035;5934.881302374015;5970.3432622412365;5985.042393217064;5730.455606717355;5732.025555655465;5751.683657398883;5756.913646295393;5761.135829625589;5686.9715651421475;5715.257016587817;5731.3408957968695;5733.541316694738;5756.769729210785;5525.171224316385;5626.74679639409;5647;5661.348944871393;5662.320521537442;5728.112142617901;5757.251557297524;5766.135079738073;5770.336411312753;5788.450097240924;5514.420985796433;5528.115501519737;5534.252875861707;5550.139728342114;5592.273004509388 10:20:03 INFO - PID 8183 | |5;yui.html;706.1667232665453;707.9646017699115;714.1715609892526;722.9589391276561;724.8405350822817;14338.283085845718;15183.544493665195;15197.772033419495;16653.50039498817;16980.32078716853;16321.591960201002;16486.75269870953;16561.337546498155;16587.751183732253;16699.582510437245;854.9059603443616;898.2903506230086;907.496339531563;911.0206527982413;912.6303846942;901.0628945896293;913.3834661603391;913.9817203655923;915.496476937685;917.5274733512247;929.577042445689;929.6932012435914;931.8555623878276;936.4100616611526;937.0910217089412;921.5438358012759;924.0713083351222;926.2219735422244;926.2266007883426;930.483581612205;679.5141473846223;681.8329509270211;682.5836239893661;687.656171914043;692.4771797293062;14859.405623775036;15095.4716584919;15202.923985380114;15324.387024519006;15372.846271537253;15444.845551544453;15902.966307189996;15996.12021338826;16020.679586408207;16036.599085022968;11784.175107742461;11822.881771182265;11956.820647690292;11964.282143071443;12030.278183308941;2875.1374587623836;2880.135959212249;2897.174305322973;2905;2906.636670416198;83447;84636;85143;85838.57080714556;86114.13885861124;12303.200291980993;12394.380280985915;12484.126111172312;12607.369631518572;12668.493260269486;19866;20384.082716277804;20392.592148156953;20397.184112635627;20494.18023279052;5591.273134492571;5636.408177141423;5649.745761440745;5658.151277308354;5658.773649053992;2590.8575028373243;2674.3848914749715;2683.5437975544205;2685.9462810743676;2692.2192564156176;3391.6608339165887;3472.7569070164845;3483.303339332144;3485.1809824691177;3487.9476807847905;708.121928808274;715.4920006795234;719.7301012120455;720.9639518024078;722.2524686949088;569.5130663282916;588.7497813429276;589.5784514072459;590.1825971030069;590.7932223721663;9561.330706850593;10129.392236465836;10603.681889543326;10930;11287.379194144401;602.8854517641633;612.6262979582451;613.8526753579109;622.7011034703368;623.5603899251017;4706.1999460091865;4750.931040515857;5290.735463226823;5408.1887716842;5576.7211639417865;86138.56930715307;86228;86468;90667.54666226759;94042.52978735199;63628.44760241392;65595.67202163959;65983.67008165024;66682.66658666772;71939.64030179815;62931.685341573;63415.365846340945;63451.048234276524;63731.681341593925;64409.67795160994;10147.086762191439;10235.437050962268;10296.330738501973;10708.57165713394;11077.279976801483;26581.069662561717;27403.17790466289;28166.71833281641;28868.855655721585;28959.42081158323;51783;52045.7397713009;52460.47539524556;52639.473605263454;53650.73174634102;13814.861851381358;13950.372233249325;14080;14152.78770818459;14232.074915130483;15357;15566.37734490653;15841.128737919526;15854.286557104728;16031.35874565051;13876.653083672585;14474.348654310792;14489.420423182955;14684.559463216121;14693.191874447008;13274.269915154373;14093.718125637224;14468.493602723855;14477.710445791236;14503.057301275383;14267.714645707236;14382.712345752818;14401.927990359982;14474.34865431037;14925.10449373041;10088.546015429176;10408.687739367831;10415.635452759117;10515.369077855354;10538.156947444033;10888.29226100301;10982.06652434552;11339.886601133883;11365.54537818511;12026.879731202576 10:20:03 INFO - PID 8183 | __end_tp_report 10:20:03 INFO - PID 8183 | __start_cc_report 10:20:03 INFO - PID 8183 | _x_x_mozilla_cycle_collect,345 10:20:03 INFO - PID 8183 | __end_cc_report 10:20:03 INFO - PID 8183 | __startTimestamp1495646403084__endTimestamp 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | ------- Summary: start ------- 10:20:03 INFO - PID 8183 | Number of tests: 6 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#0] dojo.html Cycles:165 Average:5168.21 Median:5277.45 stddev:606.94 (11.5%) stddev-sans-first:577.06 10:20:03 INFO - PID 8183 | Values: 2698.7 2711.2 2722.7 2737.0 2741.3 5044.9 5243.9 5250.4 5265.1 5267.2 5117.8 5175.7 5181.9 5185.4 5198.4 4618.2 4672.0 4685.6 4716.0 4727.7 4552.3 4709.6 4712.1 4740.5 4766.3 4577.5 4677.0 4683.4 4751.4 4803.0 4618.1 4620.5 4671.5 4714.2 4716.6 4645.1 4652.0 4661.7 4667.2 4709.0 5138.8 5189.1 5243.1 5263.6 5281.2 5593.9 5658.8 5673.5 5717.4 5730.6 5692.3 5693.5 5693.8 5698.5 5722.3 5273.8 5275.9 5276.2 5277.4 5317.1 5674.6 5736.9 5742.6 5750.5 5802.4 5494.5 5569.7 5582.6 5587.7 5591.9 5696.7 5709.0 5711.3 5715.3 5715.9 5544.1 5645.7 5651.9 5669.0 5674.6 5505.9 5564.1 5570.1 5605.8 5703.9 4797.9 4808.5 4813.4 4836.7 4854.7 4088.4 4095.0 4108.1 4116.8 4194.4 4656.8 4710.1 4737.5 4753.0 4761.8 5510.7 5636.8 5636.9 5639.9 5664.3 4743.2 4752.5 4758.4 4762.3 4803.1 5059.6 5071.1 5078.9 5087.8 5120.7 5079.8 5099.9 5143.1 5152.0 5215.6 5565.7 5662.0 5739.5 5783.4 5801.9 5120.1 5157.4 5163.9 5166.8 5235.3 5569.2 5638.3 5640.7 5640.7 5645.6 5726.9 5745.4 5751.1 5757.7 5759.5 5403.4 5454.3 5462.5 5509.8 5516.5 5544.9 5545.2 5548.5 5548.9 5583.8 5465.5 5477.4 5478.4 5491.8 5540.4 5373.8 5440.7 5455.6 5551.1 5601.2 5368.8 5370.0 5371.5 5377.6 5414.2 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#1] ext.html Cycles:180 Average:30155.67 Median:29716.26 stddev:40784.06 (137.2%) stddev-sans-first:40838.23 10:20:03 INFO - PID 8183 | Values: 634.9 684.6 703.0 1159.8 1208.7 34139.8 35184.3 35279.6 35335.3 35546.5 32784.3 33016.5 33071.3 33092.8 33154.0 6406.0 6534.6 6648.2 6816.1 6896.7 6766.8 6849.6 6859.3 6868.9 6883.1 6831.1 6893.9 6899.5 6902.7 6903.9 6847.0 6847.7 6869.7 6883.7 6889.9 6777.2 6801.1 6807.2 6810.8 6819.8 31547.5 31676.5 31780.8 31966.8 32103.8 3005.6 3019.8 3027.5 3031.8 3046.6 24663.9 24709.6 24823.4 24853.5 24987.0 2803.2 2826.6 2843.4 2854.1 2859.0 145547.0 146395.3 146727.0 150653.0 153928.5 40018.6 40087.4 40226.6 40353.0 40358.4 41358.0 41802.6 41925.4 43372.6 43940.8 12353.3 12360.6 12400.8 12401.4 12422.2 9703.4 9734.8 9754.8 9766.5 9807.3 12805.7 12880.6 12929.4 12974.6 13183.8 5419.3 5420.5 5448.2 5463.4 5554.4 863.5 880.8 908.5 925.2 944.8 21215.6 21482.4 21538.7 21609.7 21703.0 989.8 992.5 1011.8 1026.9 1035.6 10904.6 11290.2 11347.7 11452.3 11493.5 175515.0 176269.0 176718.0 176728.0 176959.0 40217.0 40472.6 40485.6 40535.0 40677.8 1216.4 1243.9 1257.5 1259.2 1266.1 19140.6 20151.8 20826.9 20838.2 21077.7 29384.3 29475.8 29579.4 29629.7 29687.3 146740.0 147133.0 147303.0 147865.0 148254.0 29592.1 29745.3 29868.3 29891.6 29927.1 34772.3 36165.8 36557.3 36690.9 36760.0 27091.9 27315.5 27365.2 27790.0 28449.9 26834.3 27142.5 27705.9 27795.4 28637.7 28490.0 28537.4 28701.9 28890.6 29212.3 25684.5 26188.5 26286.9 26583.7 27382.3 19323.0 21864.8 21893.8 22054.2 22085.3 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#2] jquery.html Cycles:180 Average:24902.17 Median:38670.31 stddev:60862.07 (157.4%) stddev-sans-first:61004.99 10:20:03 INFO - PID 8183 | Values: 395.2 405.6 413.5 423.4 433.5 17211.6 17955.4 17962.0 18628.4 19171.9 18203.0 18452.4 18552.4 18570.8 18598.8 5368.5 5376.2 5431.0 5536.0 5548.3 5269.7 5334.2 5334.3 5339.8 5340.4 5218.6 5301.5 5320.8 5327.8 5333.1 5405.2 5454.9 5475.7 5480.1 5485.3 4864.4 4889.1 4928.2 4948.7 4964.2 21289.6 21506.8 21533.0 21537.9 21644.6 1545.5 1561.8 1569.0 1570.0 1576.9 14407.1 14588.3 14645.8 14969.9 14990.6 2015.8 2092.1 2114.8 2134.4 2136.6 90590.5 92402.0 92777.5 96181.5 98453.0 10737.3 10762.0 10906.2 11137.1 11158.4 14853.9 15389.7 15452.4 15477.0 15484.2 7783.2 7791.5 7898.7 8054.1 8067.6 7268.9 7315.1 7330.3 7516.3 7533.5 6915.1 6924.0 7007.3 7052.4 7234.8 1974.3 1980.9 1991.3 2002.6 2127.3 832.3 857.8 865.4 875.3 903.6 16558.3 16621.9 16640.0 17184.4 17285.9 855.0 868.5 882.1 893.5 897.1 9047.3 9478.7 9586.2 9587.7 9668.1 362670.0 363462.0 363869.0 364938.0 370868.0 66681.3 71347.0 72792.3 72927.0 73499.0 1087.7 1111.1 1150.8 1154.9 1157.8 17163.4 17843.3 18397.4 18466.9 18483.4 38657.6 38683.0 39281.0 39613.2 40732.8 49257.0 49344.0 50169.5 50201.7 51287.2 7947.1 8003.5 8081.7 8263.4 8348.3 11716.0 13056.2 13408.8 13422.7 13622.0 11426.6 11455.3 11603.5 11681.2 11743.4 10868.4 11085.3 11144.9 11258.7 11583.2 11633.2 11722.5 12003.7 12159.5 12298.3 7946.8 8019.1 8156.4 8230.8 8403.8 10786.6 10797.9 10949.7 10989.6 11269.9 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#3] mootools.html Cycles:180 Average:6425.58 Median:3776.92 stddev:4202.84 (111.3%) stddev-sans-first:4196.47 10:20:03 INFO - PID 8183 | Values: 1225.6 1249.1 1267.0 1271.3 1286.9 10166.8 10513.0 10645.5 10663.5 10744.1 10320.2 10500.9 10503.2 10558.4 10568.3 2174.3 2207.8 2210.8 2214.2 2219.5 2134.9 2166.4 2175.1 2176.7 2177.5 2091.8 2129.5 2131.8 2134.2 2146.5 2044.2 2074.7 2090.8 2093.7 2099.5 2046.1 2050.6 2087.3 2088.9 2198.0 10311.5 10432.7 10475.6 10543.8 10582.4 5462.7 5622.9 5648.9 5662.8 5668.9 3308.1 3428.3 3476.6 3481.9 3498.1 1092.1 1098.7 1108.1 1116.4 1133.1 15747.1 15858.3 15862.4 15900.4 15941.3 4652.3 4807.7 4920.0 4946.6 4997.3 11129.1 11149.9 11152.7 11179.5 11249.3 5468.9 5661.9 5710.6 5713.7 5739.3 5082.3 5220.7 5249.4 5275.0 5294.9 3774.9 3779.0 3871.1 3907.9 3998.3 1132.8 1138.2 1141.0 1151.5 1152.1 627.6 652.5 670.1 672.3 681.7 5969.9 6085.8 6105.4 6175.4 6394.0 827.0 839.8 844.1 859.1 873.0 3986.7 4019.3 4042.7 4059.1 4093.5 13709.2 14045.3 14140.4 14220.9 14300.8 13862.5 13941.7 13999.4 14037.2 14103.3 7325.3 7547.6 7618.5 7667.0 7691.7 5907.6 6062.5 6065.3 6087.3 6181.4 11812.6 12031.6 12047.6 12176.4 12280.6 11865.5 12518.2 12529.9 12564.1 12592.2 7812.5 7918.0 7932.2 7987.9 8014.6 9327.8 9481.5 9583.4 9614.8 9630.7 8031.9 8068.5 8173.8 8235.1 8237.3 7794.3 7824.2 7841.1 7947.2 7959.1 7418.5 7547.4 7577.1 7600.7 7604.7 5183.9 5393.8 5398.7 5406.1 5678.8 5481.8 5564.3 5568.4 5647.6 5744.5 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#4] prototype.html Cycles:180 Average:4714.81 Median:5249.36 stddev:1355.24 (25.8%) stddev-sans-first:1319.26 10:20:03 INFO - PID 8183 | Values: 372.0 380.0 390.9 393.2 397.3 5287.5 5444.7 5454.5 5456.8 5469.3 5254.4 5305.5 5306.5 5306.7 5318.6 4038.3 4040.9 4046.2 4053.3 4056.7 3922.3 4064.6 4071.5 4075.3 4085.6 4017.7 4027.3 4032.5 4037.6 4043.2 3982.0 4001.1 4011.4 4017.1 4031.4 3522.8 3526.9 3527.6 3537.5 3538.7 5179.8 5197.7 5236.8 5238.6 5244.3 4685.3 4694.9 4718.4 4724.2 4728.1 5483.8 5627.7 5628.2 5637.5 5648.6 3925.9 3927.9 3931.6 3939.6 3941.3 5853.8 5959.5 5992.3 5999.9 6040.5 4493.9 4511.7 4546.2 4556.8 4563.6 4619.4 4619.7 4623.4 4626.9 4629.7 4964.0 5018.2 5050.7 5054.7 5058.1 5742.7 5769.9 5776.1 5777.5 5787.7 1580.6 1608.1 1608.5 1614.0 1614.9 1100.0 1156.0 1160.0 1170.1 1183.9 4865.7 4865.9 4874.9 4877.8 4894.3 5774.2 5815.9 5859.9 5896.5 5897.3 4633.3 4813.8 4860.0 4865.6 4872.8 3104.4 3114.3 3115.3 3130.9 3140.9 5224.9 5309.4 5358.2 5368.8 5388.2 6018.2 6022.3 6027.6 6046.0 6062.3 5341.7 5383.0 5395.8 5400.8 5401.3 5655.5 5881.4 5913.9 5932.9 5936.5 5599.5 5821.7 5836.1 5851.9 5863.8 5342.2 5371.9 5382.3 5399.4 5405.9 4015.5 4020.1 4031.0 4035.2 4041.4 5882.3 5903.2 5934.9 5970.3 5985.0 5730.5 5732.0 5751.7 5756.9 5761.1 5687.0 5715.3 5731.3 5733.5 5756.8 5525.2 5626.7 5647.0 5661.3 5662.3 5728.1 5757.3 5766.1 5770.3 5788.5 5514.4 5528.1 5534.3 5550.1 5592.3 10:20:03 INFO - PID 8183 | 10:20:03 INFO - PID 8183 | [#5] yui.html Cycles:180 Average:17637.50 Median:15928.30 stddev:23212.67 (145.7%) stddev-sans-first:23242.97 10:20:03 INFO - PID 8183 | Values: 706.2 708.0 714.2 723.0 724.8 14338.3 15183.5 15197.8 16653.5 16980.3 16321.6 16486.8 16561.3 16587.8 16699.6 854.9 898.3 907.5 911.0 912.6 901.1 913.4 914.0 915.5 917.5 929.6 929.7 931.9 936.4 937.1 921.5 924.1 926.2 926.2 930.5 679.5 681.8 682.6 687.7 692.5 14859.4 15095.5 15202.9 15324.4 15372.8 15444.8 15903.0 15996.1 16020.7 16036.6 11784.2 11822.9 11956.8 11964.3 12030.3 2875.1 2880.1 2897.2 2905.0 2906.6 83447.0 84636.0 85143.0 85838.6 86114.1 12303.2 12394.4 12484.1 12607.4 12668.5 19866.0 20384.1 20392.6 20397.2 20494.2 5591.3 5636.4 5649.7 5658.2 5658.8 2590.9 2674.4 2683.5 2685.9 2692.2 3391.7 3472.8 3483.3 3485.2 3487.9 708.1 715.5 719.7 721.0 722.3 569.5 588.7 589.6 590.2 590.8 9561.3 10129.4 10603.7 10930.0 11287.4 602.9 612.6 613.9 622.7 623.6 4706.2 4750.9 5290.7 5408.2 5576.7 86138.6 86228.0 86468.0 90667.5 94042.5 63628.4 65595.7 65983.7 66682.7 71939.6 62931.7 63415.4 63451.0 63731.7 64409.7 10147.1 10235.4 10296.3 10708.6 11077.3 26581.1 27403.2 28166.7 28868.9 28959.4 51783.0 52045.7 52460.5 52639.5 53650.7 13814.9 13950.4 14080.0 14152.8 14232.1 15357.0 15566.4 15841.1 15854.3 16031.4 13876.7 14474.3 14489.4 14684.6 14693.2 13274.3 14093.7 14468.5 14477.7 14503.1 14267.7 14382.7 14401.9 14474.3 14925.1 10088.5 10408.7 10415.6 10515.4 10538.2 10888.3 10982.1 11339.9 11365.5 12026.9 10:20:03 INFO - PID 8183 | -------- Summary: end -------- 10:20:03 INFO - PID 8183 | 10:20:03 INFO - TEST-INFO | 8183: exit 0 10:20:03 INFO - TEST-OK | dromaeo_css | took 1145991ms 10:20:03 INFO - TEST-START | kraken 10:20:03 INFO - operating with platform_type : linux_ 10:20:03 INFO - Initialising browser for kraken test... 10:20:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50459/getInfo.html -profile /tmp/tmpzTQ9DV/profile 10:20:03 INFO - TEST-INFO | started process 8587 (/builds/slave/test/build/application/firefox/firefox http://localhost:50459/getInfo.html) 10:20:38 INFO - TEST-INFO | 8587: killed by SIGTERM 10:20:38 INFO - Browser initialized. 10:20:38 INFO - Running cycle 1/1 for kraken test... 10:20:38 INFO - TEST-INFO | started process 8781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzTQ9DV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:50 INFO - PID 8781 | RSS: Main: 172908544 10:20:50 INFO - PID 8781 | 10:20:53 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50459/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:54 INFO - PID 8781 | RSS: Main: 179159040 10:20:54 INFO - PID 8781 | 10:20:56 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50459/tests/kraken/driver.html?testName=audio-dft) 10:20:57 INFO - PID 8781 | RSS: Main: 177659904 10:20:57 INFO - PID 8781 | 10:21:00 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50459/tests/kraken/driver.html?testName=audio-fft) 10:21:01 INFO - PID 8781 | RSS: Main: 175165440 10:21:01 INFO - PID 8781 | 10:21:03 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50459/tests/kraken/driver.html?testName=audio-oscillator) 10:21:03 INFO - PID 8781 | RSS: Main: 176013312 10:21:03 INFO - PID 8781 | 10:21:05 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:06 INFO - PID 8781 | RSS: Main: 175923200 10:21:06 INFO - PID 8781 | 10:21:09 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50459/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:10 INFO - PID 8781 | RSS: Main: 177614848 10:21:10 INFO - PID 8781 | 10:21:13 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50459/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:14 INFO - PID 8781 | RSS: Main: 176451584 10:21:14 INFO - PID 8781 | 10:21:17 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50459/tests/kraken/driver.html?testName=json-parse-financial) 10:21:18 INFO - PID 8781 | RSS: Main: 177127424 10:21:18 INFO - PID 8781 | 10:21:19 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:20 INFO - PID 8781 | RSS: Main: 176979968 10:21:20 INFO - PID 8781 | 10:21:21 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:22 INFO - PID 8781 | RSS: Main: 177385472 10:21:22 INFO - PID 8781 | 10:21:24 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:25 INFO - PID 8781 | RSS: Main: 176738304 10:21:25 INFO - PID 8781 | 10:21:28 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:29 INFO - PID 8781 | RSS: Main: 177131520 10:21:29 INFO - PID 8781 | 10:21:32 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:32 INFO - PID 8781 | RSS: Main: 177111040 10:21:32 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:50459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50459/tests/kraken/driver.html?testName=ai-astar) 10:21:34 INFO - PID 8781 | RSS: Main: 178499584 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | __start_tp_report 10:21:34 INFO - PID 8781 | _x_x_mozilla_page_load 10:21:34 INFO - PID 8781 | _x_x_mozilla_page_load_details 10:21:34 INFO - PID 8781 | |i|pagename|runs| 10:21:34 INFO - PID 8781 | |0;ai-astar;106;111;110;110;110;113;113;112;112;112 10:21:34 INFO - PID 8781 | |1;audio-beat-detection;147;124;130;163;123;124;131;123;151;124 10:21:34 INFO - PID 8781 | |2;audio-dft;165;163;164;162;167;169;169;163;162;162 10:21:34 INFO - PID 8781 | |3;audio-fft;73;75;73;104;76;75;76;80;93;75 10:21:34 INFO - PID 8781 | |4;audio-oscillator;85;84;102;84;86;84;96;84;85;108 10:21:34 INFO - PID 8781 | |5;imaging-gaussian-blur;115;116;114;114;114;114;114;114;115;114 10:21:34 INFO - PID 8781 | |6;imaging-darkroom;150;151;152;152;150;151;151;151;150;151 10:21:34 INFO - PID 8781 | |7;imaging-desaturate;96;95;94;95;94;94;95;96;94;94 10:21:34 INFO - PID 8781 | |8;json-parse-financial;55;53;53;55;55;55;56;54;55;55 10:21:34 INFO - PID 8781 | |9;json-stringify-tinderbox;59;57;57;56;57;57;57;57;56;56 10:21:34 INFO - PID 8781 | |10;stanford-crypto-aes;98;89;87;88;89;87;88;88;126;88 10:21:34 INFO - PID 8781 | |11;stanford-crypto-ccm;135;135;137;138;145;135;135;142;132;144 10:21:34 INFO - PID 8781 | |12;stanford-crypto-pbkdf2;186;185;200;196;199;200;202;203;194;194 10:21:34 INFO - PID 8781 | |13;stanford-crypto-sha256-iterative;76;73;74;78;71;74;72;72;71;75 10:21:34 INFO - PID 8781 | __end_tp_report 10:21:34 INFO - PID 8781 | __start_cc_report 10:21:34 INFO - PID 8781 | _x_x_mozilla_cycle_collect,916 10:21:34 INFO - PID 8781 | __end_cc_report 10:21:34 INFO - PID 8781 | __startTimestamp1495646494816__endTimestamp 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | ------- Summary: start ------- 10:21:34 INFO - PID 8781 | Number of tests: 14 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.08 (1.9%) stddev-sans-first:1.24 10:21:34 INFO - PID 8781 | Values: 106.0 111.0 110.0 110.0 110.0 113.0 113.0 112.0 112.0 112.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:130.50 stddev:14.40 (11.0%) stddev-sans-first:14.48 10:21:34 INFO - PID 8781 | Values: 147.0 124.0 130.0 163.0 123.0 124.0 131.0 123.0 151.0 124.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.80 (1.7%) stddev-sans-first:2.96 10:21:34 INFO - PID 8781 | Values: 165.0 163.0 164.0 162.0 167.0 169.0 169.0 163.0 162.0 162.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.50 stddev:10.27 (13.6%) stddev-sans-first:10.58 10:21:34 INFO - PID 8781 | Values: 73.0 75.0 73.0 104.0 76.0 75.0 76.0 80.0 93.0 75.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:84.50 stddev:8.90 (10.5%) stddev-sans-first:9.27 10:21:34 INFO - PID 8781 | Values: 85.0 84.0 102.0 84.0 86.0 84.0 96.0 84.0 85.0 108.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:21:34 INFO - PID 8781 | Values: 115.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:21:34 INFO - PID 8781 | Values: 150.0 151.0 152.0 152.0 150.0 151.0 151.0 151.0 150.0 151.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 10:21:34 INFO - PID 8781 | Values: 96.0 95.0 94.0 95.0 94.0 94.0 95.0 96.0 94.0 94.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 10:21:34 INFO - PID 8781 | Values: 55.0 53.0 53.0 55.0 55.0 55.0 56.0 54.0 55.0 55.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.50 10:21:34 INFO - PID 8781 | Values: 59.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 56.0 56.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:88.00 stddev:12.10 (13.7%) stddev-sans-first:12.69 10:21:34 INFO - PID 8781 | Values: 98.0 89.0 87.0 88.0 89.0 87.0 88.0 88.0 126.0 88.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:4.39 (3.2%) stddev-sans-first:4.54 10:21:34 INFO - PID 8781 | Values: 135.0 135.0 137.0 138.0 145.0 135.0 135.0 142.0 132.0 144.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:199.50 stddev:6.28 (3.1%) stddev-sans-first:5.55 10:21:34 INFO - PID 8781 | Values: 186.0 185.0 200.0 196.0 199.0 200.0 202.0 203.0 194.0 194.0 10:21:34 INFO - PID 8781 | 10:21:34 INFO - PID 8781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:2.27 (3.1%) stddev-sans-first:2.24 10:21:34 INFO - PID 8781 | Values: 76.0 73.0 74.0 78.0 71.0 74.0 72.0 72.0 71.0 75.0 10:21:34 INFO - PID 8781 | -------- Summary: end -------- 10:21:34 INFO - PID 8781 | 10:21:35 INFO - TEST-INFO | 8781: exit 0 10:21:35 INFO - TEST-OK | kraken | took 92088ms 10:21:35 INFO - SUITE-END | took 1238s 10:21:35 INFO - Completed test suite (00:20:38) 10:21:35 INFO - javascript benchmark 10:21:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6779.150310747741, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.703142654308, 2711.2137480130764, 2722.714115017923, 2737.0146747171016, 2741.259859837844, 5044.949550504494, 5243.947560524393, 5250.369955605328, 5265.052290587692, 5267.209918512225, 5117.846464606058, 5175.689458632484, 5181.896362072756, 5185.403678576955, 5198.428172900987, 4618.237990731525, 4672.042231342567, 4685.64857635677, 4715.976420117895, 4727.716337019772, 4552.294394368878, 4709.576138147566, 4712.104700106986, 4740.549647783455, 4766.332713420124, 4577.473590537097, 4676.953230467686, 4683.414573178353, 4751.382320298357, 4802.97598512007, 4618.145643056046, 4620.491745907947, 4671.462781780071, 4714.222153344694, 4716.646251531115, 4645.117427688729, 4651.953480465186, 4661.650376221797, 4667.22990706533, 4708.95291047092, 5138.845834624967, 5189.065968125736, 5243.056249875021, 5263.552598029172, 5281.234221037928, 5593.860153496154, 5658.801941932013, 5673.546116310686, 5717.371089180187, 5730.598858079936, 5692.288463942007, 5693.516051135658, 5693.800716974927, 5698.458646428583, 5722.313322401297, 5273.789048438096, 5275.920861187085, 5276.15581506957, 5277.445868183824, 5317.069512835238, 5674.631148975303, 5736.913946290725, 5742.626729262584, 5750.539956803529, 5802.419758024248, 5494.450554944474, 5569.749361278752, 5582.553395728332, 5587.720613969285, 5591.8881622368135, 5696.658200507983, 5708.971455142698, 5711.314642242957, 5715.2855893013375, 5715.942840571624, 5544.112941929272, 5645.745941432645, 5651.943480565142, 5668.95124401987, 5674.574406919498, 5505.944940550623, 5564.054110801174, 5570.08093664549, 5605.80379686709, 5703.942960570341, 4797.904041919142, 4808.519148085234, 4813.446453657874, 4836.661433699607, 4854.68444551103, 4088.4071809587444, 4094.9795251023556, 4108.137291168888, 4116.835326586903, 4194.3708443733685, 4656.837010704609, 4710.057988402334, 4737.45519265282, 4753.04939012199, 4761.809527618856, 5510.6969116698165, 5636.774529018793, 5636.943630563642, 5639.943600563942, 5664.348599910981, 4743.241081427024, 4752.453467851241, 4758.357621721093, 4762.333273341735, 4803.087413391444, 5059.595232381401, 5071.137906555894, 5078.923816142761, 5087.771050302746, 5120.718360490135, 5079.77141028662, 5099.852533180005, 5143.125668636416, 5151.974240128776, 5215.634905556726, 5565.693886836263, 5662.009148399096, 5739.540836733135, 5783.3638299787835, 5801.854953626024, 5120.052790233819, 5157.406898206755, 5163.870903227449, 5166.767495462788, 5235.319408476874, 5569.220309156803, 5638.2670252866865, 5640.717964101696, 5640.71796410186, 5645.604807663424, 5726.914096288476, 5745.368009519033, 5751.1373294006235, 5757.740901659519, 5759.481646651821, 5403.351597808288, 5454.318210223722, 5462.481064298885, 5509.779608815603, 5516.503514683537, 5544.861378465571, 5545.195946587803, 5548.528375088163, 5548.861278468071, 5583.832485025456, 5465.535429488538, 5477.4248703887115, 5478.424765399575, 5491.780328786964, 5540.36285827135, 5373.838784836461, 5440.673559586279, 5455.563554915677, 5551.139573366135, 5601.159826025966, 5368.812091576776, 5369.973150134224, 5371.543418809445, 5377.623566350318, 5414.160805075219], "value": 5124.170785544341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.8761991411676, 684.5584597934333, 702.9648517574121, 1159.7506536094738, 1208.70990962169, 34139.82930085349, 35184.296314073734, 35279.64720352796, 35335.2932941341, 35546.46680299791, 32784.344313113725, 33016.50475242873, 33071.338573228524, 33092.834535827285, 33154.0, 6405.950095969291, 6534.60792352458, 6648.202215734119, 6816.079829223066, 6896.655167241618, 6766.8308292292595, 6849.623270720109, 6859.314068593126, 6868.896966545481, 6883.139607549057, 6831.11195544581, 6893.896591551131, 6899.482538809584, 6902.689378977933, 6903.929890866923, 6847.0, 6847.657617119125, 6869.656517174121, 6883.690233939485, 6889.862202755967, 6777.220619628756, 6801.115854938876, 6807.217170025411, 6810.829729256759, 6819.761308354184, 31547.526787098213, 31676.524852127237, 31780.841095794603, 31966.840165799254, 32103.839480802446, 3005.5641931919968, 3019.773516986213, 3027.5458681197774, 3031.8180909145303, 3046.5887105240954, 24663.876680616482, 24709.629355559682, 24823.379415514577, 24853.5029299413, 24987.0, 2803.201087690019, 2826.5760135979563, 2843.445528122017, 2854.0866922584783, 2858.9857050714822, 145547.0, 146395.2680236592, 146727.0, 150653.0, 153928.46071539255, 40018.599814001485, 40087.39868901969, 40226.59773402287, 40353.0, 40358.385664573674, 41358.0, 41802.58197417987, 41925.371119433235, 43372.56627433685, 43940.78029609896, 12353.258804471761, 12360.629181124581, 12400.75198496025, 12401.379931003414, 12422.192557483735, 9703.369280996712, 9734.75663108428, 9754.804903901882, 9766.46284454362, 9807.313488055768, 12805.679858003625, 12880.613581592566, 12929.353532323534, 12974.610761677164, 13183.802242966363, 5419.295491586068, 5420.457954204627, 5448.237246785453, 5463.399026107125, 5554.416786237468, 863.5250612163285, 880.8062226310202, 908.5411867007119, 925.1997022575424, 944.7826999790087, 21215.575688486144, 21482.355529334145, 21538.676919846213, 21609.747349964247, 21703.0, 989.7871957529165, 992.454150217392, 1011.8482227665762, 1026.8921763214905, 1035.6064695415844, 10904.61833835812, 11290.209685321948, 11347.659570212907, 11452.312861228353, 11493.540258389738, 175515.0, 176269.0, 176718.0, 176728.0, 176959.0, 40217.0, 40472.595274046886, 40485.59514404877, 40535.0, 40677.796611016754, 1216.4465168348556, 1243.8880500754976, 1257.528426839935, 1259.212991880075, 1266.050462153385, 19140.61718765589, 20151.79848201499, 20826.895865520575, 20838.228750555765, 21077.6838347428, 29384.265393364483, 29475.820967161075, 29579.40841183207, 29629.703702962695, 29687.25781855471, 146740.0, 147133.0, 147303.0, 147865.0, 148254.0, 29592.112236632936, 29745.25636859096, 29868.253293667833, 29891.55162672518, 29927.102186934426, 34772.304553909285, 36165.819170903975, 36557.26885462329, 36690.89927302185, 36759.95640479599, 27091.864540677172, 27315.45369092567, 27365.179044628694, 27790.0, 28449.857750711115, 26834.329141771614, 27142.457150857266, 27705.86147069252, 27795.44409111847, 28637.713622863506, 28490.0, 28537.42925141527, 28701.85649071741, 28890.566641500816, 29212.26969325784, 25684.486310274064, 26188.476230475666, 26286.86856565705, 26583.734162658126, 27382.315442114108, 19323.0, 21864.781352186274, 21893.781062189173, 22054.228102016354, 22085.33743987683], "value": 14414.633461082825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.229302859424, 405.58022446767603, 413.4996654048601, 423.37974866820105, 433.5187941385062, 17211.569710757238, 17955.371561995333, 17961.999999999985, 18628.441146765585, 19171.904140479277, 18203.0, 18452.354167604135, 18552.35066772663, 18570.814291857077, 18598.81401185988, 5368.516833484986, 5376.220448035023, 5431.0, 5536.031194540959, 5548.306461692288, 5269.736513174345, 5334.199870019509, 5334.27987221724, 5339.8398048058425, 5340.359156901177, 5218.634695571312, 5301.549368303698, 5320.813771517997, 5327.813526526553, 5333.093374126388, 5405.243265942771, 5454.890902181974, 5475.698836563987, 5480.095784195603, 5485.259489968863, 4864.440589332236, 4889.1443997300685, 4928.236123400843, 4948.7278199699, 4964.180910149821, 21289.574208515896, 21506.784932150636, 21533.0, 21537.892310538347, 21644.567108657895, 1545.5440645009749, 1561.8281988981203, 1569.0272031340642, 1569.9607509812347, 1576.9448069317634, 14407.135571865616, 14588.270586470633, 14645.780313295309, 14969.925150374178, 14990.62523436912, 2015.8387329013644, 2092.06902928197, 2114.767375588684, 2134.3703607435846, 2136.6260904341834, 90590.547047265, 92402.0, 92777.53611231901, 96181.5190924048, 98453.0, 10737.302075365076, 10762.0, 10906.182036347305, 11137.053350465301, 11158.386288754034, 14853.851461485247, 15389.691216388306, 15452.38190472391, 15477.0, 15484.225788710519, 7783.2216778322845, 7791.532508049535, 7898.68405263783, 8054.114047454776, 8067.596620168968, 7268.928355418786, 7315.085614298213, 7330.266973302627, 7516.285952834472, 7533.54798712079, 6915.111622463727, 6924.0, 7007.305105579274, 7052.435805135577, 7234.782956511313, 1974.2892558678864, 1980.920763169486, 1991.2974406882197, 2002.589469158819, 2127.2660931978444, 832.2592892325835, 857.8498762716499, 865.3812524045338, 875.3347455933537, 903.5527413930147, 16558.337666493448, 16621.916890415712, 16640.0, 17184.398546050827, 17285.91357043207, 854.9658013679508, 868.5440143924491, 882.0738224863995, 893.4505279253212, 897.0984160918366, 9047.32145089121, 9478.668246611336, 9586.233101351874, 9587.712368628952, 9668.129868311886, 362670.0, 363462.0, 363869.0, 364938.0, 370868.0, 66681.33318666751, 71347.0, 72792.2720772796, 72927.0, 73499.0, 1087.7063192938022, 1111.0889070961896, 1150.8216226484908, 1154.9422528873522, 1157.7742340243572, 17163.425486177173, 17843.286268549113, 18397.356092537233, 18466.907665461586, 18483.445496635122, 38657.613423865405, 38683.0, 39281.0, 39613.207735845695, 40732.79633601813, 49257.0, 49344.0, 50169.49830501794, 50201.748991256274, 51287.23069153891, 7947.125816160102, 8003.479773814916, 8081.676732930617, 8263.380246481418, 8348.286806787697, 11716.0, 13056.21662700241, 13408.798868017182, 13422.731545369234, 13622.0, 11426.600068997544, 11455.255408398427, 11603.477843496894, 11681.240719353214, 11743.41282935867, 10868.369744538066, 11085.334879907232, 11144.88855111471, 11258.66224013281, 11583.189176757545, 11633.185677002528, 11722.531098755955, 12003.699907502032, 12159.452824622736, 12298.323592202158, 7946.801329966797, 8019.077806052145, 8156.388270879589, 8230.818833009376, 8403.831923361377, 10786.568537258421, 10797.92020797914, 10949.726256843642, 10989.560417583207, 11269.887301127212], "value": 8895.605316001294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.5955534673556, 1249.0819247852826, 1267.0497127154633, 1271.2944315904674, 1286.8713128687132, 10166.796664066715, 10513.0, 10645.520951557179, 10663.520141593628, 10744.086752626035, 10320.225983051263, 10500.894991050087, 10503.212259080561, 10558.419286939215, 10568.260221784478, 2174.3259589527256, 2207.75714671386, 2210.8341874359407, 2214.202886960693, 2219.511707424364, 2134.8612340197915, 2166.447555873258, 2175.0755928730305, 2176.6517357222847, 2177.46652070243, 2091.7803630618796, 2129.5421484380854, 2131.7868213178635, 2134.2103421733905, 2146.5170336674278, 2044.2436298569476, 2074.73028506294, 2090.822280106193, 2093.685947107946, 2099.5276062885728, 2046.0562465657686, 2050.63088644044, 2087.321620473352, 2088.9164433422643, 2197.9560408791895, 10311.535980880803, 10432.68701938943, 10475.58097676092, 10543.789124217472, 10582.417967011812, 5462.6995515246645, 5622.91565626516, 5648.943510564924, 5662.801801936954, 5668.943310566883, 3308.106811160997, 3428.3143371325837, 3476.5828100628087, 3481.930361392783, 3498.142954976022, 1092.0608276881876, 1098.692366137475, 1108.1245815805503, 1116.4417791104447, 1133.1048471707425, 15747.05517668932, 15858.286377113058, 15862.44481443144, 15900.443484478103, 15941.282642281241, 4652.255639097796, 4807.735574543363, 4919.950800492021, 4946.604271658259, 4997.275395067695, 11129.054030407344, 11149.888501114885, 11152.665420037412, 11179.4969226385, 11249.268797528299, 5468.890622187534, 5661.943380566224, 5710.5717071219, 5713.685747283939, 5739.253896993448, 5082.33929589151, 5220.738963051908, 5249.42256351801, 5274.97362513185, 5294.92057619136, 3774.8678796241998, 3778.962210377916, 3871.070942973666, 3907.8632247871187, 3998.300297447935, 1132.7904337697553, 1138.2032577195996, 1141.0301243942583, 1151.4703236511298, 1152.1128730877178, 627.6108812536256, 652.4649787174566, 670.1489108831854, 672.3411057164006, 681.7204945972128, 5969.880602388015, 6085.817425477154, 6105.358937311607, 6175.413335733098, 6394.0, 826.9710560130487, 839.8194388206565, 844.1178967978354, 859.1451505751817, 872.9956350218336, 3986.661133803659, 4019.31671615826, 4042.7372220805555, 4059.086705491241, 4093.508778946486, 13709.245991470565, 14045.297735113203, 14140.43438262458, 14220.928895355457, 14300.785488217685, 13862.514811981533, 13941.721165576631, 13999.440022399194, 14037.1577705338, 14103.294835258195, 7325.340719335285, 7547.622618869144, 7618.4667073305445, 7667.0, 7691.730789422343, 5907.586468947305, 6062.484688801501, 6065.272167339947, 6087.2999605044215, 6181.381861813783, 11812.645620631394, 12031.578894738643, 12047.638570842888, 12176.39118044112, 12280.631581052583, 11865.525378984745, 12518.248905065726, 12529.874701252871, 12564.120511564102, 12592.244465332109, 7812.53124812513, 7918.049834019955, 7932.206779322021, 7987.880181797162, 8014.599270036591, 9327.766805829908, 9481.478518681539, 9583.424994500352, 9614.759631009281, 9630.662926797528, 8031.879521807061, 8068.515889046676, 8173.795655108432, 8235.13531079228, 8237.341012718849, 7794.298513133618, 7824.178461261486, 7841.059072911287, 7947.205279472238, 7959.124496305518, 7418.48070635072, 7547.396208303432, 7577.128630207597, 7600.695972161273, 7604.695812167452, 5183.870403239949, 5393.8112166074, 5398.676079435247, 5406.080966235828, 5678.801241956677, 5481.808136715196, 5564.276644036411, 5568.359638641608, 5647.604667673223, 5744.511716504144], "value": 4797.10472512134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9702423806094, 379.9696024318054, 390.9061825161962, 393.231232939603, 397.29480172693445, 5287.462018231242, 5444.733160103936, 5454.454554544549, 5456.836294911154, 5469.261649677293, 5254.448282930294, 5305.532927188857, 5306.548943339821, 5306.70813105279, 5318.627696061278, 4038.3336749436307, 4040.8585699500522, 4046.231216068952, 4053.3109371406786, 4056.655184309337, 3922.2743792398355, 4064.634182923536, 4071.4707088078508, 4075.2664520386465, 4085.611866872642, 4017.678585713136, 4027.335489644205, 4032.516098068236, 4037.5962403759536, 4043.1913617276664, 3981.98009009956, 4001.139470146396, 4011.4183443400834, 4017.0961533654986, 4031.395290706388, 3522.806245656488, 3526.947095793565, 3527.6119626841028, 3537.540119784437, 3538.6815186633326, 5179.8446046618665, 5197.714125723083, 5236.842894713165, 5238.633295669305, 5244.265802787613, 4685.320628508881, 4694.859154225379, 4718.363020992157, 4724.244120940667, 4728.05438912219, 5483.835484935458, 5627.746751396197, 5628.183913332544, 5637.548996080303, 5648.576356773217, 3925.8822235332987, 3927.9214415711526, 3931.646151846319, 3939.625735555118, 3941.2905676978135, 5853.824385268406, 5959.493443057346, 5992.310884248323, 5999.910046326146, 6040.456358927674, 4493.932591011137, 4511.729296242236, 4546.249868771682, 4556.840510582114, 4563.577317012241, 4619.445666520039, 4619.722816631013, 4623.352730617717, 4626.930596041062, 4629.7222166669435, 4963.975180124076, 5018.172001619765, 5050.696958182521, 5054.725373581829, 5058.114829904752, 5742.684152371659, 5769.884602308014, 5776.104703770922, 5777.537796976232, 5787.652740835563, 1580.581145996312, 1608.0914283429825, 1608.5094046315985, 1613.9757903631455, 1614.8708103351703, 1100.0, 1156.0, 1159.96520104397, 1170.1341007654444, 1183.928964262147, 4865.683730557574, 4865.878353041202, 4874.8781280467565, 4877.756112194376, 4894.2658601210105, 5774.220480235199, 5815.912761308584, 5859.9197284964075, 5896.528277737771, 5897.262842144732, 4633.281841314534, 4813.831515896997, 4859.95140048602, 4865.6107511399005, 4872.834795117187, 3104.425681248931, 3114.345987342638, 3115.283484798509, 3130.8591113399953, 3140.905772826819, 5224.92162617561, 5309.36287645485, 5358.223057656618, 5368.758405871745, 5388.245645609618, 6018.187544681499, 6022.277326720821, 6027.638341699512, 6045.969770151121, 6062.333143354227, 5341.679499229981, 5383.031054410244, 5395.81114660985, 5400.783968641367, 5401.297831281908, 5655.519280861008, 5881.441263080001, 5913.935491611551, 5932.8813423732145, 5936.495397891227, 5599.496045355774, 5821.679807610622, 5836.095405212199, 5851.8537036572725, 5863.824085277278, 5342.225377320345, 5371.919421208607, 5382.273393091882, 5399.352077750695, 5405.918911216257, 4015.5382131054134, 4020.115574573706, 4031.0, 4035.1526179502634, 4041.4139949707715, 5882.264716910387, 5903.2325797646035, 5934.881302374015, 5970.3432622412365, 5985.042393217064, 5730.455606717355, 5732.025555655465, 5751.683657398883, 5756.913646295393, 5761.135829625589, 5686.9715651421475, 5715.257016587817, 5731.3408957968695, 5733.541316694738, 5756.769729210785, 5525.171224316385, 5626.74679639409, 5647.0, 5661.348944871393, 5662.320521537442, 5728.112142617901, 5757.251557297524, 5766.135079738073, 5770.336411312753, 5788.450097240924, 5514.420985796433, 5528.115501519737, 5534.252875861707, 5550.139728342114, 5592.273004509388], "value": 4315.536089383448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1667232665453, 707.9646017699115, 714.1715609892526, 722.9589391276561, 724.8405350822817, 14338.283085845718, 15183.544493665195, 15197.772033419495, 16653.50039498817, 16980.32078716853, 16321.591960201002, 16486.75269870953, 16561.337546498155, 16587.751183732253, 16699.582510437245, 854.9059603443616, 898.2903506230086, 907.496339531563, 911.0206527982413, 912.6303846942, 901.0628945896293, 913.3834661603391, 913.9817203655923, 915.496476937685, 917.5274733512247, 929.577042445689, 929.6932012435914, 931.8555623878276, 936.4100616611526, 937.0910217089412, 921.5438358012759, 924.0713083351222, 926.2219735422244, 926.2266007883426, 930.483581612205, 679.5141473846223, 681.8329509270211, 682.5836239893661, 687.656171914043, 692.4771797293062, 14859.405623775036, 15095.4716584919, 15202.923985380114, 15324.387024519006, 15372.846271537253, 15444.845551544453, 15902.966307189996, 15996.12021338826, 16020.679586408207, 16036.599085022968, 11784.175107742461, 11822.881771182265, 11956.820647690292, 11964.282143071443, 12030.278183308941, 2875.1374587623836, 2880.135959212249, 2897.174305322973, 2905.0, 2906.636670416198, 83447.0, 84636.0, 85143.0, 85838.57080714556, 86114.13885861124, 12303.200291980993, 12394.380280985915, 12484.126111172312, 12607.369631518572, 12668.493260269486, 19866.0, 20384.082716277804, 20392.592148156953, 20397.184112635627, 20494.18023279052, 5591.273134492571, 5636.408177141423, 5649.745761440745, 5658.151277308354, 5658.773649053992, 2590.8575028373243, 2674.3848914749715, 2683.5437975544205, 2685.9462810743676, 2692.2192564156176, 3391.6608339165887, 3472.7569070164845, 3483.303339332144, 3485.1809824691177, 3487.9476807847905, 708.121928808274, 715.4920006795234, 719.7301012120455, 720.9639518024078, 722.2524686949088, 569.5130663282916, 588.7497813429276, 589.5784514072459, 590.1825971030069, 590.7932223721663, 9561.330706850593, 10129.392236465836, 10603.681889543326, 10930.0, 11287.379194144401, 602.8854517641633, 612.6262979582451, 613.8526753579109, 622.7011034703368, 623.5603899251017, 4706.1999460091865, 4750.931040515857, 5290.735463226823, 5408.1887716842, 5576.7211639417865, 86138.56930715307, 86228.0, 86468.0, 90667.54666226759, 94042.52978735199, 63628.44760241392, 65595.67202163959, 65983.67008165024, 66682.66658666772, 71939.64030179815, 62931.685341573, 63415.365846340945, 63451.048234276524, 63731.681341593925, 64409.67795160994, 10147.086762191439, 10235.437050962268, 10296.330738501973, 10708.57165713394, 11077.279976801483, 26581.069662561717, 27403.17790466289, 28166.71833281641, 28868.855655721585, 28959.42081158323, 51783.0, 52045.7397713009, 52460.47539524556, 52639.473605263454, 53650.73174634102, 13814.861851381358, 13950.372233249325, 14080.0, 14152.78770818459, 14232.074915130483, 15357.0, 15566.37734490653, 15841.128737919526, 15854.286557104728, 16031.35874565051, 13876.653083672585, 14474.348654310792, 14489.420423182955, 14684.559463216121, 14693.191874447008, 13274.269915154373, 14093.718125637224, 14468.493602723855, 14477.710445791236, 14503.057301275383, 14267.714645707236, 14382.712345752818, 14401.927990359982, 14474.34865431037, 14925.10449373041, 10088.546015429176, 10408.687739367831, 10415.635452759117, 10515.369077855354, 10538.156947444033, 10888.29226100301, 10982.06652434552, 11339.886601133883, 11365.54537818511, 12026.879731202576], "value": 7135.157642190361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 110.0, 110.0, 110.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 130.0, 163.0, 123.0, 124.0, 131.0, 123.0, 151.0, 124.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 162.0, 167.0, 169.0, 169.0, 163.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 104.0, 76.0, 75.0, 76.0, 80.0, 93.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 102.0, 84.0, 86.0, 84.0, 96.0, 84.0, 85.0, 108.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 152.0, 150.0, 151.0, 151.0, 151.0, 150.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 55.0, 55.0, 56.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 89.0, 87.0, 88.0, 89.0, 87.0, 88.0, 88.0, 126.0, 88.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 137.0, 138.0, 145.0, 135.0, 135.0, 142.0, 132.0, 144.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 200.0, 196.0, 199.0, 200.0, 202.0, 203.0, 194.0, 194.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 78.0, 71.0, 74.0, 72.0, 72.0, 71.0, 75.0], "value": 73.6, "unit": "score"}]}]} 10:21:36 INFO - Return code: 0 10:21:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:36 INFO - # TBPL SUCCESS # 10:21:36 INFO - Running post-action listener: _resource_record_post_action 10:21:36 INFO - [mozharness: 2017-05-24 17:21:36.097443Z] Finished run-tests step (success) 10:21:36 INFO - Running post-run listener: _resource_record_post_run 10:21:36 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 233472; Write bytes: 413720576; Read time: 104; Write time: 257320 10:21:36 INFO - TinderboxPrint: CPU usage
12.7% 10:21:36 INFO - TinderboxPrint: I/O read bytes / time
233,472 / 104 10:21:36 INFO - TinderboxPrint: I/O write bytes / time
413,720,576 / 257,320 10:21:36 INFO - TinderboxPrint: CPU idle
8,732.4 (87.2%) 10:21:36 INFO - TinderboxPrint: CPU user
1,222.4 (12.2%) 10:21:36 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76668928; Read time: 0; Write time: 32088 10:21:36 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 233472; Write bytes: 304750592; Read time: 104; Write time: 171736 10:21:36 INFO - Running post-run listener: _upload_blobber_files 10:21:36 INFO - Blob upload gear active. 10:21:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:38 INFO - (blobuploader) - INFO - Done attempting. 10:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:46 INFO - (blobuploader) - INFO - Done attempting. 10:21:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:21:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:47 INFO - (blobuploader) - INFO - Done attempting. 10:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:48 INFO - (blobuploader) - INFO - Done attempting. 10:21:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:48 INFO - Return code: 0 10:21:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d281530aefeee6b2284bd77db9047a43494dab07934bc256b062d4f4524d88d65f10fd4bb66c2b67a7bad07d3a9f74998e5091df48dd0f8adf24498932799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b92fa293c5b693bbff19acc6b3aee1faf2869f64be11f170586d0db7482b9bac81b14709e1c8d6a82b8f6445d0439488718523164e4c6d7af9e19c156cf43c9b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f3569a1449edba845a44d7fd9fd8b2e278044e83ba8054b8f70a1cac58017ff86623342551a30100bd888c3d3d937595e5ada8da4a5eeac2dc3689a85dd70f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f57717fcc4f90073f47b74f8880a0585532fe6d1ae280c5a8c8c0612d0b7dd41610a3b8dd7abaf8a5d1ee87746df95be3cc5be4764198cb1ddf0b94085d4f7c"} 10:21:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:48 INFO - Contents: 10:21:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d281530aefeee6b2284bd77db9047a43494dab07934bc256b062d4f4524d88d65f10fd4bb66c2b67a7bad07d3a9f74998e5091df48dd0f8adf24498932799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b92fa293c5b693bbff19acc6b3aee1faf2869f64be11f170586d0db7482b9bac81b14709e1c8d6a82b8f6445d0439488718523164e4c6d7af9e19c156cf43c9b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f3569a1449edba845a44d7fd9fd8b2e278044e83ba8054b8f70a1cac58017ff86623342551a30100bd888c3d3d937595e5ada8da4a5eeac2dc3689a85dd70f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f57717fcc4f90073f47b74f8880a0585532fe6d1ae280c5a8c8c0612d0b7dd41610a3b8dd7abaf8a5d1ee87746df95be3cc5be4764198cb1ddf0b94085d4f7c"} 10:21:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:48 INFO - Copying logs to upload dir... 10:21:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.208947 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 10:21:48.790902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 10:21:48.798236) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d281530aefeee6b2284bd77db9047a43494dab07934bc256b062d4f4524d88d65f10fd4bb66c2b67a7bad07d3a9f74998e5091df48dd0f8adf24498932799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b92fa293c5b693bbff19acc6b3aee1faf2869f64be11f170586d0db7482b9bac81b14709e1c8d6a82b8f6445d0439488718523164e4c6d7af9e19c156cf43c9b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f3569a1449edba845a44d7fd9fd8b2e278044e83ba8054b8f70a1cac58017ff86623342551a30100bd888c3d3d937595e5ada8da4a5eeac2dc3689a85dd70f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f57717fcc4f90073f47b74f8880a0585532fe6d1ae280c5a8c8c0612d0b7dd41610a3b8dd7abaf8a5d1ee87746df95be3cc5be4764198cb1ddf0b94085d4f7c"} build_url:https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/P3jmION2Qoa1DZZEpebAGg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d281530aefeee6b2284bd77db9047a43494dab07934bc256b062d4f4524d88d65f10fd4bb66c2b67a7bad07d3a9f74998e5091df48dd0f8adf24498932799be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b92fa293c5b693bbff19acc6b3aee1faf2869f64be11f170586d0db7482b9bac81b14709e1c8d6a82b8f6445d0439488718523164e4c6d7af9e19c156cf43c9b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f3569a1449edba845a44d7fd9fd8b2e278044e83ba8054b8f70a1cac58017ff86623342551a30100bd888c3d3d937595e5ada8da4a5eeac2dc3689a85dd70f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f57717fcc4f90073f47b74f8880a0585532fe6d1ae280c5a8c8c0612d0b7dd41610a3b8dd7abaf8a5d1ee87746df95be3cc5be4764198cb1ddf0b94085d4f7c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 10:21:48.825318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:21:48.825651) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495644753.353511-471596092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:21:48.908250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 10:21:48.908552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 10:21:48.911833) ========= ========= Total master_lag: 0.34 =========