builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1462801189.55 results: success (0) buildid: 20160509045548 builduid: 039db17d53974ffb91704586ba114135 revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.553714) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.554154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.554431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.571251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.571553) ========= 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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:39:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-09 06:39:49 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.662645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.662956) ========= 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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.712202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:49.712543) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da2b27e1aabd9e23870c09072753faba6ad0a42d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev da2b27e1aabd9e23870c09072753faba6ad0a42d --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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:39:50,074 truncating revision to first 12 chars 2016-05-09 06:39:50,074 Setting DEBUG logging. 2016-05-09 06:39:50,074 attempt 1/10 2016-05-09 06:39:50,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da2b27e1aabd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:39:50,343 unpacking tar archive at: fx-team-da2b27e1aabd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:50.279302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:50.279644) ========= script_repo_revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:50.280057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:50.280327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:39:50.291209) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 06:39:50.291505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:50 INFO - MultiFileLogger online at 20160509 06:39:50 in /builds/slave/test 06:39:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:39:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:50 INFO - {'append_to_log': False, 06:39:50 INFO - 'base_work_dir': '/builds/slave/test', 06:39:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:39:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:50 INFO - 'branch': 'Fx-Team-Non-PGO', 06:39:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:50 INFO - 'config_files': ('talos/linux_config.py',), 06:39:50 INFO - 'default_actions': ('clobber', 06:39:50 INFO - 'read-buildbot-config', 06:39:50 INFO - 'download-and-extract', 06:39:50 INFO - 'populate-webroot', 06:39:50 INFO - 'create-virtualenv', 06:39:50 INFO - 'install', 06:39:50 INFO - 'run-tests'), 06:39:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:50 INFO - 'download_minidump_stackwalk': True, 06:39:50 INFO - 'download_symbols': 'ondemand', 06:39:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:50 INFO - 'installer_path': 'installer.exe', 06:39:50 INFO - 'log_level': 'info', 06:39:50 INFO - 'log_name': 'talos', 06:39:50 INFO - 'log_to_console': True, 06:39:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:50 INFO - 'opt_config_files': (), 06:39:50 INFO - 'pip_index': False, 06:39:50 INFO - 'sps_profile': False, 06:39:50 INFO - 'sps_profile_interval': 0, 06:39:50 INFO - 'suite': 'dromaeojs-e10s', 06:39:50 INFO - 'system_bits': '32', 06:39:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:50 INFO - 'title': 'talos-linux64-ix-021', 06:39:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:50 INFO - 'use_talos_json': True, 06:39:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:50 INFO - 'work_dir': 'build'} 06:39:50 INFO - ##### 06:39:50 INFO - ##### Running clobber step. 06:39:50 INFO - ##### 06:39:50 INFO - Running pre-action listener: _resource_record_pre_action 06:39:50 INFO - Running main action method: clobber 06:39:50 INFO - rmtree: /builds/slave/test/build 06:39:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:51 INFO - Running post-action listener: _resource_record_post_action 06:39:51 INFO - ##### 06:39:51 INFO - ##### Finished clobber step (success) 06:39:51 INFO - ##### 06:39:51 INFO - ##### 06:39:51 INFO - ##### Running read-buildbot-config step. 06:39:51 INFO - ##### 06:39:51 INFO - Running pre-action listener: _resource_record_pre_action 06:39:51 INFO - Running main action method: read_buildbot_config 06:39:51 INFO - Using buildbot properties: 06:39:51 INFO - { 06:39:51 INFO - "project": "", 06:39:51 INFO - "product": "firefox", 06:39:51 INFO - "script_repo_revision": "production", 06:39:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:39:51 INFO - "repository": "", 06:39:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:39:51 INFO - "buildid": "20160509045548", 06:39:51 INFO - "pgo_build": "False", 06:39:51 INFO - "basedir": "/builds/slave/test", 06:39:51 INFO - "buildnumber": 1246, 06:39:51 INFO - "slavename": "talos-linux64-ix-021", 06:39:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:39:51 INFO - "platform": "ubuntu64_hw", 06:39:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:39:51 INFO - "branch": "fx-team", 06:39:51 INFO - "repo_path": "integration/fx-team", 06:39:51 INFO - "revision": "da2b27e1aabd9e23870c09072753faba6ad0a42d", 06:39:51 INFO - "stage_platform": "linux64", 06:39:51 INFO - "builduid": "039db17d53974ffb91704586ba114135", 06:39:51 INFO - "slavebuilddir": "test" 06:39:51 INFO - } 06:39:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:39:51 INFO - Running post-action listener: _resource_record_post_action 06:39:51 INFO - ##### 06:39:51 INFO - ##### Finished read-buildbot-config step (success) 06:39:51 INFO - ##### 06:39:51 INFO - ##### 06:39:51 INFO - ##### Running download-and-extract step. 06:39:51 INFO - ##### 06:39:51 INFO - Running pre-action listener: _resource_record_pre_action 06:39:51 INFO - Running main action method: download_and_extract 06:39:51 INFO - mkdir: /builds/slave/test/build/tests 06:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:51 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:39:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:39:52 INFO - Downloaded 1361 bytes. 06:39:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:39:52 INFO - Using the following test package requirements: 06:39:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:39:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:39:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'jsshell-linux-x86_64.zip'], 06:39:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:39:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:39:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:39:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:39:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:39:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:52 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:53 INFO - Downloaded 22322863 bytes. 06:39:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:39:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:39:54 INFO - Return code: 0 06:39:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:54 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:55 INFO - Downloaded 22322863 bytes. 06:39:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:39:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:39:57 INFO - Return code: 0 06:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:57 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:39:58 INFO - Downloaded 10840152 bytes. 06:39:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:39:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:39:58 INFO - Return code: 0 06:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:58 INFO - https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:39:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:39:59 INFO - Downloaded 54862390 bytes. 06:39:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:39:59 INFO - mkdir: /builds/slave/test/properties 06:39:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:59 INFO - Contents: 06:39:59 INFO - build_url:https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:40:00 INFO - Running post-action listener: _resource_record_post_action 06:40:00 INFO - Running post-action listener: set_extra_try_arguments 06:40:00 INFO - ##### 06:40:00 INFO - ##### Finished download-and-extract step (success) 06:40:00 INFO - ##### 06:40:00 INFO - ##### 06:40:00 INFO - ##### Running populate-webroot step. 06:40:00 INFO - ##### 06:40:00 INFO - Running pre-action listener: _resource_record_pre_action 06:40:00 INFO - Running main action method: populate_webroot 06:40:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:40:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:40:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:40:00 INFO - '--tppagecycles', 06:40:00 INFO - '7'], 06:40:00 INFO - 'tests': ['tsvgm']}}, 06:40:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:40:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:40:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:40:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:40:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['damp', 'tps']}, 06:40:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'tests': ['damp', 'tps']}, 06:40:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['dromaeo_dom']}, 06:40:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:40:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['a11yr', 06:40:00 INFO - 'ts_paint', 06:40:00 INFO - 'tpaint', 06:40:00 INFO - 'sessionrestore', 06:40:00 INFO - 'sessionrestore_no_auto_restore', 06:40:00 INFO - 'tabpaint']}, 06:40:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['tsvgx', 06:40:00 INFO - 'tsvgr_opacity', 06:40:00 INFO - 'tart', 06:40:00 INFO - 'tscrollx', 06:40:00 INFO - 'cart']}, 06:40:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:40:00 INFO - 'tsvgr_opacity', 06:40:00 INFO - 'tart', 06:40:00 INFO - 'tscrollx', 06:40:00 INFO - 'cart']}, 06:40:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'talos_options': ['--disable-e10s'], 06:40:00 INFO - 'tests': ['tp5o']}, 06:40:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'tests': ['tp5o']}, 06:40:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'talos_options': ['--disable-e10s', 06:40:00 INFO - '--xperf_path', 06:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:00 INFO - 'tests': ['tp5n']}, 06:40:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:00 INFO - 'talos_options': ['--xperf_path', 06:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:00 INFO - 'tests': ['tp5n']}}, 06:40:00 INFO - 'talos.zip': {'path': '', 06:40:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:40:00 INFO - Running post-action listener: _resource_record_post_action 06:40:00 INFO - ##### 06:40:00 INFO - ##### Finished populate-webroot step (success) 06:40:00 INFO - ##### 06:40:00 INFO - ##### 06:40:00 INFO - ##### Running create-virtualenv step. 06:40:00 INFO - ##### 06:40:00 INFO - Running pre-action listener: _resource_record_pre_action 06:40:00 INFO - Running main action method: create_virtualenv 06:40:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:40:00 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 06:40:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:40:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:40:00 INFO - Using real prefix '/usr' 06:40:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:40:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:40:02 INFO - Installing pip.................done. 06:40:02 INFO - Return code: 0 06:40:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:40:02 INFO - Using env: {'DISPLAY': ':0', 06:40:02 INFO - 'HOME': '/home/cltbld', 06:40:02 INFO - 'LANG': 'en_US.UTF-8', 06:40:02 INFO - 'LANGUAGE': 'en_US:en', 06:40:02 INFO - 'LOGNAME': 'cltbld', 06:40:02 INFO - 'MAIL': '/var/mail/cltbld', 06:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:02 INFO - 'MOZ_NO_REMOTE': '1', 06:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:02 INFO - 'NO_EM_RESTART': '1', 06:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:02 INFO - 'PWD': '/builds/slave/test', 06:40:02 INFO - 'SHELL': '/bin/bash', 06:40:02 INFO - 'SHLVL': '1', 06:40:02 INFO - 'TERM': 'linux', 06:40:02 INFO - 'TMOUT': '86400', 06:40:02 INFO - 'USER': 'cltbld', 06:40:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:02 INFO - '_': '/tools/buildbot/bin/python'} 06:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:03 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 06:40:03 INFO - Cleaning up... 06:40:03 INFO - Return code: 0 06:40:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:40:03 INFO - Using env: {'DISPLAY': ':0', 06:40:03 INFO - 'HOME': '/home/cltbld', 06:40:03 INFO - 'LANG': 'en_US.UTF-8', 06:40:03 INFO - 'LANGUAGE': 'en_US:en', 06:40:03 INFO - 'LOGNAME': 'cltbld', 06:40:03 INFO - 'MAIL': '/var/mail/cltbld', 06:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:03 INFO - 'MOZ_NO_REMOTE': '1', 06:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:03 INFO - 'NO_EM_RESTART': '1', 06:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:03 INFO - 'PWD': '/builds/slave/test', 06:40:03 INFO - 'SHELL': '/bin/bash', 06:40:03 INFO - 'SHLVL': '1', 06:40:03 INFO - 'TERM': 'linux', 06:40:03 INFO - 'TMOUT': '86400', 06:40:03 INFO - 'USER': 'cltbld', 06:40:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:03 INFO - '_': '/tools/buildbot/bin/python'} 06:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:03 INFO - Downloading/unpacking psutil>=0.7.1 06:40:03 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 06:40:03 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 06:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:03 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 06:40:03 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 06:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:05 INFO - Installing collected packages: psutil 06:40:05 INFO - Running setup.py install for psutil 06:40:05 INFO - building 'psutil._psutil_linux' extension 06:40:05 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 06:40:05 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 06:40:05 INFO - building 'psutil._psutil_posix' extension 06:40:05 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 06:40:05 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 06:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:05 INFO - Successfully installed psutil 06:40:05 INFO - Cleaning up... 06:40:05 INFO - Return code: 0 06:40:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:40:05 INFO - Using env: {'DISPLAY': ':0', 06:40:05 INFO - 'HOME': '/home/cltbld', 06:40:05 INFO - 'LANG': 'en_US.UTF-8', 06:40:05 INFO - 'LANGUAGE': 'en_US:en', 06:40:05 INFO - 'LOGNAME': 'cltbld', 06:40:05 INFO - 'MAIL': '/var/mail/cltbld', 06:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:05 INFO - 'MOZ_NO_REMOTE': '1', 06:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:05 INFO - 'NO_EM_RESTART': '1', 06:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:05 INFO - 'PWD': '/builds/slave/test', 06:40:05 INFO - 'SHELL': '/bin/bash', 06:40:05 INFO - 'SHLVL': '1', 06:40:05 INFO - 'TERM': 'linux', 06:40:05 INFO - 'TMOUT': '86400', 06:40:05 INFO - 'USER': 'cltbld', 06:40:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:05 INFO - '_': '/tools/buildbot/bin/python'} 06:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:40:06 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 06:40:06 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 06:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:06 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 06:40:06 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 06:40:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:40:08 INFO - Installing collected packages: mozsystemmonitor 06:40:08 INFO - Running setup.py install for mozsystemmonitor 06:40:08 INFO - Successfully installed mozsystemmonitor 06:40:08 INFO - Cleaning up... 06:40:08 INFO - Return code: 0 06:40:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:40:08 INFO - Using env: {'DISPLAY': ':0', 06:40:08 INFO - 'HOME': '/home/cltbld', 06:40:08 INFO - 'LANG': 'en_US.UTF-8', 06:40:08 INFO - 'LANGUAGE': 'en_US:en', 06:40:08 INFO - 'LOGNAME': 'cltbld', 06:40:08 INFO - 'MAIL': '/var/mail/cltbld', 06:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:08 INFO - 'MOZ_NO_REMOTE': '1', 06:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:08 INFO - 'NO_EM_RESTART': '1', 06:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:08 INFO - 'PWD': '/builds/slave/test', 06:40:08 INFO - 'SHELL': '/bin/bash', 06:40:08 INFO - 'SHLVL': '1', 06:40:08 INFO - 'TERM': 'linux', 06:40:08 INFO - 'TMOUT': '86400', 06:40:08 INFO - 'USER': 'cltbld', 06:40:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:08 INFO - '_': '/tools/buildbot/bin/python'} 06:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:40:08 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 06:40:08 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 06:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:08 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 06:40:08 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 06:40:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:40:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:40:10 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 06:40:10 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 06:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:10 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 06:40:10 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 06:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:40:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:40:10 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 06:40:10 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 06:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:10 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 06:40:10 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 06:40:10 INFO - Downloading docopt-0.6.1.tar.gz 06:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:40:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:40:11 INFO - Running setup.py install for blobuploader 06:40:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:40:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:40:11 INFO - Running setup.py install for requests 06:40:11 INFO - Running setup.py install for docopt 06:40:11 INFO - Successfully installed blobuploader requests docopt 06:40:11 INFO - Cleaning up... 06:40:11 INFO - Return code: 0 06:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:40:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:40:11 INFO - Using env: {'DISPLAY': ':0', 06:40:11 INFO - 'HOME': '/home/cltbld', 06:40:11 INFO - 'LANG': 'en_US.UTF-8', 06:40:11 INFO - 'LANGUAGE': 'en_US:en', 06:40:11 INFO - 'LOGNAME': 'cltbld', 06:40:11 INFO - 'MAIL': '/var/mail/cltbld', 06:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:11 INFO - 'MOZ_NO_REMOTE': '1', 06:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:11 INFO - 'NO_EM_RESTART': '1', 06:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:11 INFO - 'PWD': '/builds/slave/test', 06:40:11 INFO - 'SHELL': '/bin/bash', 06:40:11 INFO - 'SHLVL': '1', 06:40:11 INFO - 'TERM': 'linux', 06:40:11 INFO - 'TMOUT': '86400', 06:40:11 INFO - 'USER': 'cltbld', 06:40:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:11 INFO - '_': '/tools/buildbot/bin/python'} 06:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:11 INFO - Running setup.py (path:/tmp/pip-3yjhKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:11 INFO - Running setup.py (path:/tmp/pip-vtODyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:12 INFO - Running setup.py (path:/tmp/pip-qIhLMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:12 INFO - Running setup.py (path:/tmp/pip-qszxuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:12 INFO - Running setup.py (path:/tmp/pip-iN2xd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:12 INFO - Running setup.py (path:/tmp/pip-UrBxoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:12 INFO - Running setup.py (path:/tmp/pip-oYRQFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:12 INFO - Running setup.py (path:/tmp/pip-Q6OjWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:12 INFO - Running setup.py (path:/tmp/pip-vKBYbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:12 INFO - Running setup.py (path:/tmp/pip-5kpXIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:12 INFO - Running setup.py (path:/tmp/pip-ZVX2SI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:12 INFO - Running setup.py (path:/tmp/pip-Nl9NXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:12 INFO - Running setup.py (path:/tmp/pip-Il7Iu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:12 INFO - Running setup.py (path:/tmp/pip-Z7eP4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:12 INFO - Running setup.py (path:/tmp/pip-WmeZAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:12 INFO - Running setup.py (path:/tmp/pip-9IHTDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:13 INFO - Running setup.py (path:/tmp/pip-QUTrlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:40:13 INFO - Running setup.py install for manifestparser 06:40:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Running setup.py install for mozcrash 06:40:13 INFO - Running setup.py install for mozdebug 06:40:13 INFO - Running setup.py install for mozdevice 06:40:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Running setup.py install for mozfile 06:40:13 INFO - Running setup.py install for mozhttpd 06:40:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Running setup.py install for mozinfo 06:40:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Running setup.py install for mozInstall 06:40:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:40:13 INFO - Running setup.py install for mozleak 06:40:13 INFO - Running setup.py install for mozlog 06:40:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Running setup.py install for moznetwork 06:40:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Running setup.py install for mozprocess 06:40:14 INFO - Running setup.py install for mozprofile 06:40:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Running setup.py install for mozrunner 06:40:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Running setup.py install for mozscreenshot 06:40:14 INFO - Running setup.py install for moztest 06:40:14 INFO - Running setup.py install for mozversion 06:40:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:40:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:40:14 INFO - Cleaning up... 06:40:14 INFO - Return code: 0 06:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:40:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:40:14 INFO - Using env: {'DISPLAY': ':0', 06:40:14 INFO - 'HOME': '/home/cltbld', 06:40:14 INFO - 'LANG': 'en_US.UTF-8', 06:40:14 INFO - 'LANGUAGE': 'en_US:en', 06:40:14 INFO - 'LOGNAME': 'cltbld', 06:40:14 INFO - 'MAIL': '/var/mail/cltbld', 06:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:14 INFO - 'MOZ_NO_REMOTE': '1', 06:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:14 INFO - 'NO_EM_RESTART': '1', 06:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:14 INFO - 'PWD': '/builds/slave/test', 06:40:14 INFO - 'SHELL': '/bin/bash', 06:40:14 INFO - 'SHLVL': '1', 06:40:14 INFO - 'TERM': 'linux', 06:40:14 INFO - 'TMOUT': '86400', 06:40:14 INFO - 'USER': 'cltbld', 06:40:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:14 INFO - '_': '/tools/buildbot/bin/python'} 06:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:15 INFO - Running setup.py (path:/tmp/pip-vSIRVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:15 INFO - Running setup.py (path:/tmp/pip-HNlh4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:15 INFO - Running setup.py (path:/tmp/pip-B6cmGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:15 INFO - Running setup.py (path:/tmp/pip-tirm_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:15 INFO - Running setup.py (path:/tmp/pip-MVMsK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:15 INFO - Running setup.py (path:/tmp/pip-a7NmGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:15 INFO - Running setup.py (path:/tmp/pip-r8sIeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:15 INFO - Running setup.py (path:/tmp/pip-RXibaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:15 INFO - Running setup.py (path:/tmp/pip-gKvAnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:15 INFO - Running setup.py (path:/tmp/pip-tA1u8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:15 INFO - Running setup.py (path:/tmp/pip-7wOoHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:15 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:15 INFO - Running setup.py (path:/tmp/pip-Wnjmls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:15 INFO - Running setup.py (path:/tmp/pip-fCEkk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:16 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)) 06:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:16 INFO - Running setup.py (path:/tmp/pip-fqnXmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:16 INFO - Running setup.py (path:/tmp/pip-vwXuIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:16 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)) 06:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:16 INFO - Running setup.py (path:/tmp/pip-KzXzX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 06:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:16 INFO - Running setup.py (path:/tmp/pip-NMaf5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:16 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)) 06:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:40:16 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)) 06:40:16 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:40:16 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:40:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:40:16 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 06:40:16 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 06:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:16 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 06:40:16 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 06:40:18 INFO - Downloading blessings-1.6.tar.gz 06:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:40:18 INFO - Installing collected packages: blessings 06:40:18 INFO - Running setup.py install for blessings 06:40:18 INFO - Successfully installed blessings 06:40:18 INFO - Cleaning up... 06:40:18 INFO - Return code: 0 06:40:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:18 INFO - Reading from file tmpfile_stdout 06:40:18 INFO - Current package versions: 06:40:18 INFO - argparse == 1.2.1 06:40:18 INFO - blessings == 1.6 06:40:18 INFO - blobuploader == 1.2.4 06:40:18 INFO - docopt == 0.6.1 06:40:18 INFO - manifestparser == 1.1 06:40:18 INFO - mozInstall == 1.12 06:40:18 INFO - mozcrash == 0.17 06:40:18 INFO - mozdebug == 0.1 06:40:18 INFO - mozdevice == 0.48 06:40:18 INFO - mozfile == 1.2 06:40:18 INFO - mozhttpd == 0.7 06:40:18 INFO - mozinfo == 0.9 06:40:18 INFO - mozleak == 0.1 06:40:18 INFO - mozlog == 3.1 06:40:18 INFO - moznetwork == 0.27 06:40:18 INFO - mozprocess == 0.22 06:40:18 INFO - mozprofile == 0.28 06:40:18 INFO - mozrunner == 6.11 06:40:18 INFO - mozscreenshot == 0.1 06:40:18 INFO - mozsystemmonitor == 0.0 06:40:18 INFO - moztest == 0.7 06:40:18 INFO - mozversion == 1.4 06:40:18 INFO - psutil == 3.1.1 06:40:18 INFO - requests == 1.2.3 06:40:18 INFO - wsgiref == 0.1.2 06:40:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:40:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:40:18 INFO - Using env: {'DISPLAY': ':0', 06:40:18 INFO - 'HOME': '/home/cltbld', 06:40:18 INFO - 'LANG': 'en_US.UTF-8', 06:40:18 INFO - 'LANGUAGE': 'en_US:en', 06:40:18 INFO - 'LOGNAME': 'cltbld', 06:40:18 INFO - 'MAIL': '/var/mail/cltbld', 06:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:18 INFO - 'MOZ_NO_REMOTE': '1', 06:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:18 INFO - 'NO_EM_RESTART': '1', 06:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:18 INFO - 'PWD': '/builds/slave/test', 06:40:18 INFO - 'SHELL': '/bin/bash', 06:40:18 INFO - 'SHLVL': '1', 06:40:18 INFO - 'TERM': 'linux', 06:40:18 INFO - 'TMOUT': '86400', 06:40:18 INFO - 'USER': 'cltbld', 06:40:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:18 INFO - '_': '/tools/buildbot/bin/python'} 06:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 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)) 06:40:18 INFO - Cleaning up... 06:40:18 INFO - Return code: 0 06:40:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:40:18 INFO - Using env: {'DISPLAY': ':0', 06:40:18 INFO - 'HOME': '/home/cltbld', 06:40:18 INFO - 'LANG': 'en_US.UTF-8', 06:40:18 INFO - 'LANGUAGE': 'en_US:en', 06:40:18 INFO - 'LOGNAME': 'cltbld', 06:40:18 INFO - 'MAIL': '/var/mail/cltbld', 06:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:18 INFO - 'MOZ_NO_REMOTE': '1', 06:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:18 INFO - 'NO_EM_RESTART': '1', 06:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:18 INFO - 'PWD': '/builds/slave/test', 06:40:18 INFO - 'SHELL': '/bin/bash', 06:40:18 INFO - 'SHLVL': '1', 06:40:18 INFO - 'TERM': 'linux', 06:40:18 INFO - 'TMOUT': '86400', 06:40:18 INFO - 'USER': 'cltbld', 06:40:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:18 INFO - '_': '/tools/buildbot/bin/python'} 06:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:19 INFO - Downloading/unpacking jsonschema 06:40:19 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 06:40:19 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 06:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:19 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 06:40:19 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 06:40:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:40:21 INFO - Downloading/unpacking functools32 (from jsonschema) 06:40:21 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 06:40:21 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 06:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:21 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 06:40:21 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 06:40:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:40:21 INFO - warning: no files found matching '*.txt' 06:40:21 INFO - no previously-included directories found matching 'build' 06:40:21 INFO - no previously-included directories found matching 'dist' 06:40:21 INFO - no previously-included directories found matching '.git*' 06:40:21 INFO - Installing collected packages: jsonschema, functools32 06:40:21 INFO - Running setup.py install for functools32 06:40:21 INFO - warning: no files found matching '*.txt' 06:40:21 INFO - no previously-included directories found matching 'build' 06:40:21 INFO - no previously-included directories found matching 'dist' 06:40:21 INFO - no previously-included directories found matching '.git*' 06:40:21 INFO - Successfully installed jsonschema functools32 06:40:21 INFO - Cleaning up... 06:40:21 INFO - Return code: 0 06:40:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:21 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9246accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, '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': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', '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 06:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:40:21 INFO - Using env: {'DISPLAY': ':0', 06:40:21 INFO - 'HOME': '/home/cltbld', 06:40:21 INFO - 'LANG': 'en_US.UTF-8', 06:40:21 INFO - 'LANGUAGE': 'en_US:en', 06:40:21 INFO - 'LOGNAME': 'cltbld', 06:40:21 INFO - 'MAIL': '/var/mail/cltbld', 06:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:21 INFO - 'MOZ_NO_REMOTE': '1', 06:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:21 INFO - 'NO_EM_RESTART': '1', 06:40:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:21 INFO - 'PWD': '/builds/slave/test', 06:40:21 INFO - 'SHELL': '/bin/bash', 06:40:21 INFO - 'SHLVL': '1', 06:40:21 INFO - 'TERM': 'linux', 06:40:21 INFO - 'TMOUT': '86400', 06:40:21 INFO - 'USER': 'cltbld', 06:40:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:21 INFO - '_': '/tools/buildbot/bin/python'} 06:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:21 INFO - Downloading/unpacking flake8 06:40:21 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 06:40:21 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 06:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:21 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 06:40:21 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 06:40:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:40:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:40:23 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 06:40:23 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 06:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:23 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 06:40:23 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 06:40:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:40:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:40:23 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 06:40:23 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 06:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:23 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 06:40:23 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 06:40:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:40:24 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 06:40:24 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 06:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:24 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 06:40:24 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 06:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:40:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:24 INFO - no previously-included directories found matching 'docs/_build' 06:40:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:40:24 INFO - Running setup.py install for pep8 06:40:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:24 INFO - no previously-included directories found matching 'docs/_build' 06:40:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:40:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:40:24 INFO - Cleaning up... 06:40:24 INFO - Return code: 0 06:40:24 INFO - Running post-action listener: _resource_record_post_action 06:40:24 INFO - Running post-action listener: _start_resource_monitoring 06:40:24 INFO - Starting resource monitoring. 06:40:24 INFO - ##### 06:40:24 INFO - ##### Finished create-virtualenv step (success) 06:40:24 INFO - ##### 06:40:24 INFO - ##### 06:40:24 INFO - ##### Running install step. 06:40:24 INFO - ##### 06:40:24 INFO - Running pre-action listener: _resource_record_pre_action 06:40:24 INFO - Running main action method: install 06:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:24 INFO - Reading from file tmpfile_stdout 06:40:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:40:25 INFO - Reading from file tmpfile_stdout 06:40:25 INFO - Output received: 06:40:25 INFO - Usage: mozinstall [options] installer 06:40:25 INFO - Options: 06:40:25 INFO - -h, --help show this help message and exit 06:40:25 INFO - -d DEST, --destination=DEST 06:40:25 INFO - Directory to install application into. [default: 06:40:25 INFO - "/builds/slave/test"] 06:40:25 INFO - --app=APP Application being installed. [default: firefox] 06:40:25 INFO - mkdir: /builds/slave/test/build/application 06:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:40:40 INFO - Reading from file tmpfile_stdout 06:40:40 INFO - Output received: 06:40:40 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:40 INFO - Running post-action listener: _resource_record_post_action 06:40:40 INFO - ##### 06:40:40 INFO - ##### Finished install step (success) 06:40:40 INFO - ##### 06:40:40 INFO - ##### 06:40:40 INFO - ##### Running run-tests step. 06:40:40 INFO - ##### 06:40:40 INFO - Running pre-action listener: _resource_record_pre_action 06:40:40 INFO - Running main action method: run_tests 06:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:40 INFO - Python 2.7.3 06:40:40 INFO - Return code: 0 06:40:40 INFO - grabbing minidump binary from tooltool 06:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:40 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d9c0>, '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 0x1a5e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:40 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 06:40:40 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 06:40:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:41 INFO - Return code: 0 06:40:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:40:41 INFO - Return code: 0 06:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 06:40:41 INFO - Using env: {'DISPLAY': ':0', 06:40:41 INFO - 'HOME': '/home/cltbld', 06:40:41 INFO - 'LANG': 'en_US.UTF-8', 06:40:41 INFO - 'LANGUAGE': 'en_US:en', 06:40:41 INFO - 'LOGNAME': 'cltbld', 06:40:41 INFO - 'MAIL': '/var/mail/cltbld', 06:40:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:41 INFO - 'MOZ_NO_REMOTE': '1', 06:40:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:41 INFO - 'NO_EM_RESTART': '1', 06:40:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:41 INFO - 'PWD': '/builds/slave/test', 06:40:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:41 INFO - 'SHELL': '/bin/bash', 06:40:41 INFO - 'SHLVL': '1', 06:40:41 INFO - 'TERM': 'linux', 06:40:41 INFO - 'TMOUT': '86400', 06:40:41 INFO - 'USER': 'cltbld', 06:40:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462801189.240010-284434426', 06:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:41 INFO - '_': '/tools/buildbot/bin/python'} 06:40:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:40:42 INFO - mozversion application_buildid: 20160509045548 06:40:42 INFO - mozversion application_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 06:40:42 INFO - mozversion application_display_name: Nightly 06:40:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:42 INFO - mozversion application_name: Firefox 06:40:42 INFO - mozversion application_remotingname: firefox 06:40:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:40:42 INFO - mozversion application_vendor: Mozilla 06:40:42 INFO - mozversion application_version: 49.0a1 06:40:42 INFO - mozversion platform_buildid: 20160509045548 06:40:42 INFO - mozversion platform_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 06:40:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:40:42 INFO - mozversion platform_version: 49.0a1 06:40:42 INFO - using testdate: 1462801242 06:40:42 INFO - actual date: 1462801242 06:40:42 INFO - starting webserver on 'localhost:44090' 06:40:42 INFO - SUITE-START | Running 2 tests 06:40:42 INFO - TEST-START | dromaeo_css 06:40:42 INFO - operating with platform_type : linux_ 06:40:42 INFO - Initialising browser for dromaeo_css test... 06:40:42 INFO - TEST-INFO | started process 32091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9mHtt/profile http://localhost:44090/getInfo.html) 06:40:47 INFO - PROCESS | 32091 | 06:40:47 INFO - PROCESS | 32091 | (process:32156): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:40:48 INFO - PROCESS | 32091 | __metrics Screen width/height:1600/1200 06:40:48 INFO - PROCESS | 32091 | colorDepth:24 06:40:48 INFO - PROCESS | 32091 | Browser inner width/height: 1024/697 06:40:48 INFO - PROCESS | 32091 | __metrics 06:40:49 ERROR - PROCESS | 32091 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 06:40:50 INFO - TEST-INFO | 32091: exit 0 06:40:50 INFO - Browser initialized. 06:40:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:50 INFO - TEST-INFO | started process 32207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9mHtt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:52 INFO - PROCESS | 32207 | 06:40:52 INFO - PROCESS | 32207 | (process:32265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:02 INFO - PROCESS | 32207 | RSS: Main: 164503552 06:41:02 INFO - PROCESS | 32207 | 06:41:51 INFO - PROCESS | 32207 | 1462801311633 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:44:03 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44090/tests/dromaeo/cssquery-ext.html) 06:44:04 INFO - PROCESS | 32207 | RSS: Main: 165765120 06:44:04 INFO - PROCESS | 32207 | 06:47:06 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-ext.html (next: http://localhost:44090/tests/dromaeo/cssquery-jquery.html) 06:47:07 INFO - PROCESS | 32207 | RSS: Main: 166789120 06:47:07 INFO - PROCESS | 32207 | 06:50:09 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44090/tests/dromaeo/cssquery-mootools.html) 06:50:09 INFO - PROCESS | 32207 | RSS: Main: 167522304 06:50:09 INFO - PROCESS | 32207 | 06:53:11 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44090/tests/dromaeo/cssquery-prototype.html) 06:53:12 INFO - PROCESS | 32207 | RSS: Main: 165089280 06:53:12 INFO - PROCESS | 32207 | 06:56:14 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44090/tests/dromaeo/cssquery-yui.html) 06:56:15 INFO - PROCESS | 32207 | RSS: Main: 166686720 06:56:15 INFO - PROCESS | 32207 | 06:59:17 INFO - PROCESS | 32207 | Cycle 1(1): loaded http://localhost:44090/tests/dromaeo/cssquery-yui.html (next: http://localhost:44090/tests/dromaeo/cssquery-dojo.html) 06:59:18 INFO - PROCESS | 32207 | RSS: Main: 168669184 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | __start_tp_report 06:59:18 INFO - PROCESS | 32207 | _x_x_mozilla_page_load 06:59:18 INFO - PROCESS | 32207 | _x_x_mozilla_page_load_details 06:59:18 INFO - PROCESS | 32207 | |i|pagename|runs| 06:59:18 INFO - PROCESS | 32207 | |0;dojo.html;2649.8675066246687;2675.7725593324567;2700.9459810803783;2712.715164907686;2718.170957857854;4714.929276060858;4765.594924431423;4772.952270477294;4773.236282194849;4806.783694733736;4649.46531148918;4782.928256076161;4862.951370486294;4876.780544875481;4881.414230292361;4466.508684044745;4495.505494395614;4595.540445955395;4604.493505714368;4628.375169352128;415.0477937509275;4326.6538676905775;4407.955920440802;4457.6879618426565;4479.440069991251;4432.20220360335;4437.5784300491405;4443.311286750559;4457.598816106533;4487.39420178275;4442.666799990014;4462.821487140511;4463.888402789924;4474.485434175079;4501.0322780602;4391.4730232372;4397.868063958086;4449.955500444987;4454.8886277842985;4461.263891457906;4759.785809638574;4765.880852978668;4793.520647935178;4803.831865884712;4838.733869637169;4966.701997880139;5172.663776854492;5200.349956255468;5220.4779522047875;5254.21186821976;5152.278680984665;5163.1480805667015;5190.935858149108;5193.246979187997;5264.394594621629;4900.877478063041;4902.2401527762895;4922.064807686528;4925.876853078702;4934.136526107916;5270.393904701008;5308.389535203424;5319.521243088063;5350.224217488442;5362.51737343641;5081.644284900021;5100.362454693163;5100.38795344561;5101.2603172539775;5104.183330667075;5161.354830646169;5167.405748338989;5171.146760784429;5180.326557547494;5190.92213616796;4953.7275449849885;5157.406898206679;5177.352830896138;5182.611304152204;5228.529432351031;5124.103281925648;5149.407818100892;5161.535461808456;5169.327987361619;5214.817481388209;4317.503487098961;4484.551544845489;4492.460904691393;4503.211937910853;4545.2954792007295;3740.0462881964927;3830.616938306203;3885.708571857122;3905.882823515299;3935.704822138351;4417.917610185461;4432.578905004019;4450.109978004412;4483.865484035484;4523.11799199153;5229.973850130801;5241.633085683966;5243.082460569385;5243.868903277372;5257.973710131425;4338.457692788402;4381.802818873159;4413.845515406945;4442.378067070613;4445.177642136216;4637.930431043537;4697.600703940135;4707.246840505502;4708.670393072521;4768.022555376139;4666.696664716783;4833.516648335209;4868.926966095441;4882.023595280958;4916.336294600254;5194.68831870089;5201.115810312332;5227.424983251915;5232.659877107976;5287.841364759063;4855.684380515255;4889.877753056202;4890.266460030882;4908.263760435821;4937.308776771327;4780.139574876555;5153.613478989166;5164.32863727713;5178.352705911761;5184.377874655065;5151.742412879416;5208.73956302191;5224.764885580082;5252.684838909678;5319.946800531945;5086.415062267739;5095.694258344512;5105.851183483686;5139.6145289102715;5162.612804039787;4921.507849215193;5048.368953880765;5117.616178786531;5118.923216151687;5127.846164615067;4995.075910956485;5001.274815151855;5016.322796422436;5062.088824011713;5116.053530096944;5140.537351638371;5146.176611742103;5168.870778230575;5176.767045483038;5203.063448579292;4838.782254798472;4915.746484646393;4945.381827271591;5060.1903695408555;5067.518585734497 06:59:18 INFO - PROCESS | 32207 | |1;ext.html;558.8630785457561;591.9052951527755;603.3755063509266;606.930203026652;637.735339833969;36805.81597092014;37692.62307376929;41557.16885662285;41686.7915660422;41724.16551668969;42954.57045429545;43050;43479.78260108695;43490.56509434905;43495;7966.721164759249;8075.717349892755;8100;8108.067572229181;8108.675652973874;7862.567558784264;7895.249951254622;7941.126476087655;7954.562499062549;7969.760907172794;7986.041674999008;8000.199980001982;8005;8017.3586113111105;8020.719274825382;7808.726694565663;7871.881921771178;7911.446198766089;7928.920710792905;7966.721164759206;7891.723789667391;7934.484258523177;7952.125266220711;7953.12515623281;7963.044434667877;30327.848360758275;39334.409983850266;40069.79965100156;40078.19843603141;40136.799316003526;3120.828354440505;3150.6376766671897;3150.716435520791;3625.546806649169;3743.288775132716;28062.298442538897;28246;28625.856870715514;29772.8511357444;29937.550936735966;3105.3634005028916;3188.059522440862;3188.8883889063773;3189.2505261263586;3197.488401855692;211566;211790;212319;212682.99999999846;212923;33229.16927076794;33299.334013319596;33354.166145846066;34071.31857362839;34994.125146871535;36030.09924751902;36199;36209.63790362115;36283.27433451316;36333.454998175046;11883.227590206781;12076.818847717292;12103.213291136048;12103.33431661267;12117.575884843987;9867.901320986699;9960.153386962045;9967.10296073357;9973.700788976343;10003.399796012263;8430.072692003874;8516.1058088901;8541.53021583819;8561.657533698706;8568.785780355542;3241.7406607471344;3258.185453636591;3263.9673603264137;3283.3925723741186;3348.3135957129216;935.8876934767871;945.3099237556622;955.6368579939578;971.606499367743;1027.845823126522;27634.723652763616;28830.42339153205;28915.855420723183;29222.707772922;29681.554776678367;979.4417182206216;998.605550807427;1017.4556612212579;1025.6102680981328;1070.3577853287966;15404.229788510529;15589.844101559067;15640.296186671627;15644;15731.528054158394;384587;387241;388865;390296;390552;49756.502434975184;50787.476375708786;51046.48953510417;51052;51157.23264151041;1246.2273390497949;1275.2922128218927;1275.8213850060813;1280.5646080332544;1281.404147071616;28040.29899252535;28742.712572874003;29167.791542929837;29355.11934641964;29620.851895740383;44336.77831610951;44533.554664454234;44820.55179448164;44865.77567112144;44902.55097449115;321692;322416;323078;323569;324147;25804;25999.49461667642;26344.473110538067;26378.07676731305;26800;43647.62772722865;44359;44664;44752.328715069954;44766.3285050718;37584.43623345597;37653.435198471496;38265.80867095647;38825;39601.603983959794;37263.44104838376;37959.430608540344;38089.4286585707;38189.618103818604;38486.6151338483;32735.508967365033;37239.441408378356;37423.43864841975;37774;38707.80646096864;31896;32849.53991544392;33636.66363336433;34075.65924340725;34134.487982680774;26889.731102689504;27069.72930270672;27112;27156.72843271621;27292.181234562995 06:59:18 INFO - PROCESS | 32207 | |2;jquery.html;379.49906123916435;381.0245770826684;383.1761712318516;392.49564309861836;394.686224451561;16084.195790210486;17075.40236091737;17174.57063573411;17601.91199044006;17704.20331085101;16774.245158967846;16930.773566365908;17347.04591247481;17387.478375648752;17394.826051739477;5104.9744751276285;5193.63644544882;5264.631475796696;5266.894662106774;5266.92099618506;3640.5813331466825;5672.092465205568;6026.276846778393;6033.69831508425;6122.938770612303;5053.494650534935;6062.060380641008;6065.939340606604;6074.63552186868;6087.512998960073;5309.097453432906;5394.865128371783;5395.163749618815;5421.512063914267;5428.4028756836715;5030.3963524377305;5460.126379779256;5464;5471.124620060811;5484.8354549363585;12486.562970296087;12710.682232944158;12763.936180319039;18316.725249121275;20966.685499717518;1971.2607772085469;1971.5071232191951;1998.3605246321183;2015.838732901379;2047.1708957872086;9711.514424278828;9829.213662907021;9912.851307230398;11937.701557461132;12452;1739.8608111351189;1775.973360399595;1803.2246134162306;1823.4165067178508;1880.069365664005;66432.6678366605;67767;68288;69516.99999999949;69567.30432695658;10125.493725313705;10216.335938163995;10229.7442563935;10317.74205644865;10607.098396636373;14600;14635.268236588128;14657.56027319182;14681.48614798477;14723;6865.519413640997;6882.174139103339;6935.682220378112;7084.326988936043;7117.25268846774;6261.467775239064;6359.650219237987;6362.363763623601;6495.64273964927;6504.15445992018;4469.910601787946;4497.16802391552;4510.368548403226;4541.205289074399;4622.14490319292;1699.269314194908;1788.499220218315;1904.552430178907;1905.4950438133906;1935.1195206181153;826.9503829770233;916.5463095767504;917.0691747875911;919.0533750237266;999.2156157416393;15578;15787.447439339798;16988;17272.568185795455;17348;872.7905302727299;907.3693782821008;921.2814005076051;944.187998321443;954.5895265036102;9640.276979226586;9685.612575496902;9707.70876873695;9732.562034708313;9780.510974451248;398255;411434;412867.0349723783;414677;417066;74205;78065;78938.6053069731;80346.59826700829;80699;950.5152372290044;963.633819148719;974.4202199691173;978.7504186432415;1004.3873237325225;15924.761128583312;15982.60043498922;16047.839521605101;16151.75772363439;16254.349826006828;24046.39884002914;25365.492690146464;34860.12849678778;35247.29505409929;37255.441168381956;45456.772716136205;46182.38361657326;47811.76094119507;49464;51502.48497514977;7481.812954676177;7802.29779319864;7877.84244315099;7885.093214280202;8057.113717491188;7274.01800756891;8647.524386158822;10997.890021099687;11730.296182229093;11821.704457388634;9975;10264.846027309746;10360.274780765274;10361.84457233127;10582.523786429476;10165.949170254102;10294.433806140734;10363.32638378503;10501.78996420052;10559.208059395729;5216.217567364925;6946.722131114901;10215.02957219063;10354.326968747007;10747.89252107469;7548.433867459853;7802.726904558313;7814.4529882907655;7908.84182316362;7989.560574168477;10063.345882517613;10206.693799186036;10257.128144107535;10277.383356998604;10717.89282107169 06:59:18 INFO - PROCESS | 32207 | |3;mootools.html;1480.407836865254;1481.9407223711053;1641.409092726619;1803.3327668762543;1804.5308219862832;6439.645819479927;7119.181294151174;7166.5341752786035;7674.040744906887;7680.3087722105;7305.853882922352;7468.215837337069;7484.4012479001685;7513.135989361225;7566.470347075693;2144.8498605097648;2159.8164156046755;2176.3688530326185;2186.8797216153184;2187.256332846832;2161.3407910587266;2170.6526955687013;2223.899924503401;2225.9666105008437;2230.275160572812;2186.814120799734;2199.714037175173;2202.8898555072265;2210.0386331945656;2225.5437635284807;2123.543438160803;2130.1479408236673;2131.968020479694;2134.0503475953205;2136.0921608316403;2122.8832414217213;2138.7112739780086;2146.087912637123;2153.224839057938;2165.7509386420606;7471.514351567185;7487.925120748777;7521.962390188069;7552.055993000875;7573.886391704129;4442.844500442469;4529.682922195448;4579.793909274091;4594;4606.769661516911;2886.5237235856057;3008.5938398316384;3029.0004298581634;3037.8759858852145;3116.1430606583144;932.151741914861;961.5721004153155;978.6379039755265;987.9753006174903;1009.8384258518602;9891.554880030344;9918.156956658693;9937.155341795957;9942.254330925138;9968.900310996869;4180.784184382283;4193.769342686121;4292.055747735493;4293.806778694966;4335.7615331157085;8572.785680357916;8572.91427085721;8576.44253123545;8607.440516366541;8610.741677749678;4347.3261644445165;4427.335899615019;4462.9107417851465;4546.772661366918;4571.9314210286875;3535.0101971448034;3887.1448281378052;4020.7788571628257;4042.0501182222156;4042.6563742082253;3626.165981824195;3688.3360995021153;3712.201876596491;3721.7580857244193;3770.1517158639635;1131.5417256011328;1144.227646338718;1161.4726634475637;1173;1199.1006744941294;737.0602481835703;818.688898218685;900.7072701371949;903.7198468474794;910.3491003932088;5167.534921857051;5172.482751724798;5210.791568337224;5222.895542089137;5229.294045303835;844.0673056272852;844.6114787197835;852.1308265569085;857.9528125953133;927.526961249754;3678.963210367862;3699.2416554606243;3718;3727.7763334200035;3759.793211373401;8770.210681038738;8886.511241881759;9150.725478235663;9169.174774270214;9182.265418766483;9092.454452732858;9148.634054637872;9152.95423522878;9181.311401644769;9197.678081267124;6933.479989000845;6949.687264073129;6998.965005174941;7023.964880175567;7103.715851365888;4930.8767280818265;4976.751162441791;5033.748312584429;5040.344755181803;5157.381114266312;8260.83478330442;8339.624716887876;8364.456310339809;8514.063453020039;8532.360072994426;8228.177182281725;8475.872861907199;8534.359923005924;8540.957295213733;8628.697995570124;5669.206311116364;6088.543359248163;6169.383061693795;6260.718267678057;6318.810435686937;7294.307040831112;7326.816829579303;7341.375983041287;7407.148177959603;7413.406927445899;6539.70571324282;6718.294579069323;6751.291114432914;6802.877525208285;6820.93179068203;6594.340565943367;6621.437177839937;6624.635645039376;6677.165354330708;6762.830929226809;6074.362191969956;6121.969390153021;6188.659623720739;6208.2239720034995;6217.502599791916;4382.868513944587;4402.2516172251435;4452.910941781081;4510.616597589242;4532.9773351133035;4599.241125214302;4686.742229177292;4701.388819453449;4707.152712511781;4726.881827954328 06:59:18 INFO - PROCESS | 32207 | |4;prototype.html;306.42545227698065;316.90651257878926;318.0966056399825;321.676302017199;325.8142858570616;4858.368412106422;4915.557599816016;5045.192769156935;5048.949510504894;5107.208382700678;4940.752962351886;4947.886725486764;5008.874778130539;5009.897822479058;5031.672941258816;3944.230874979373;3947.993261718272;3952.7351247600777;3959.6238357356006;3976;3694.685951694109;3958.1885713428824;3971.8283106483655;3974.1852920151446;3983.0838907051398;3770.396736522157;3863.43980122882;3870.6709929656013;3877.4377715231276;3878.45701601776;3825.2540754552874;3884.3008258513455;3891.7859517726515;3909.824057917372;3911.2568611963634;3434.1414646338417;3446.9486806524;3460.532828068204;3464.9133771655656;3469.705075068622;4651.651126165551;4788.760561971888;4793.5925446337105;4914.557689807899;4917.164082106051;4375.387445757597;4395.077273613044;4413.360062790877;4415.492218394894;4430.291153415438;5204.791808327663;5205;5209.244659524347;5209.4009188943;5216.817411390621;3633.3096711624707;3720.9255814883822;3726;3727.422249551324;3732.832022558964;5443;5445.863853403657;5453.481919217668;5459.181122831567;5470.7264636768405;3750.6249375062275;3752.3433399155037;3778.886633401002;3795.5445346558035;3808.8857334280015;3867.129895773485;3869.5743468218475;3873.225354928969;3878.166194268246;3889.416587511896;4327.502337231196;4331.4152589400655;4338.047878454645;4353.6299414549485;4365.519792822787;5168.8449346519665;5174.767135478913;5228.63399562027;5251.553617942518;5271.341082364705;1238.486028298264;1268.6257554021586;1287.2533930320392;1292.3344477594046;1293.2563775828935;868.2489646455897;879.366855863777;891.8171774786153;899.9460032398077;902.1024081039277;4341.8480353188115;4382.8904277392685;4389.275769498061;4399.12017596482;4400.581944715247;5154.242480273036;5181.404138524118;5193.68837869729;5220.712860792617;5222.321098257202;4247.256730072287;4348.304271316638;4400.3498687992005;4405.3612226227015;4434.600885920283;2717.5244332241778;2765.7787377010195;2768.5708715149185;2770.598263251817;2785.4846853332197;4903.264510323409;4912.72979986097;4924.532169443897;4925.300771233919;4927.556519913225;5137.948620513747;5258.237555554423;5293.232481290268;5299.205119232146;5362.383325917569;4853.927191092066;4864.927026094611;4880.243562247857;4894.8042078317185;4929.926051109236;5181.766820493162;5215.843524694265;5231.921521177262;5272.815451459181;5284.075286824867;5012.423571289349;5154.587632989277;5169.327987361619;5177.275181474522;5216.895662086813;4920;4923.876903077452;4943.29456337563;4968.285941350228;4977.9502204978935;3739.270842185748;3745.438184272381;3748.9071515999954;3749.962500374961;3766.679832214183;5028.1590901140735;5111.670965548909;5133.486651334837;5255.579553635624;5283.075461794094;5125.051865404912;5265.6050796189675;5267.945501254437;5284.630075894651;5295.602829787705;5235.947640523546;5279.752951934609;5291.550218231493;5295.470452954673;5315.840524784263;4966.776495057803;5143;5154.5824898153305;5176.456472070378;5266.34170728659;5329.280547126088;5347.732613369394;5360.365088648;5363.436839131835;5378.757955891916;5171.405288391883;5189.766460509361;5272.103742363884;5288.233206185158;5296.708681022426 06:59:18 INFO - PROCESS | 32207 | |5;yui.html;693.8542905989742;729.9671514781836;799.9280064794167;808.5633757770804;821.3962737388023;10545.63090291839;10843.620473283436;10885.292455990355;10936.890631093687;10968.835467467994;11843.881561184386;11870.465829037692;11901.642950711472;11904.583339583116;11918.165728399015;662.5925056090517;842.7640260727006;855.1448551448551;872.646578135856;872.6989188729877;859.9570021498931;866.5450638414819;867.8177582707639;867.9869801952975;868.6308318964446;920.7744102694849;928;932.2355668351954;932.4638332958542;936.3866667332908;914.8078903430288;917.554985831871;919.2278486071732;920.5949382271846;920.9217216536603;677.1265068062194;677.4309579952863;678.0202607232502;678.49452158142;678.8947713104427;12281.815772763415;12285.262884226886;12306.323152226623;12398.62804115878;12455.564055258114;12603.243805371707;12635;12780.808287875689;12946.805797913039;13290.20258784476;9733;9810.362326448758;9933.35433196847;9937.701868943943;10120.089191972758;3302.5046243063493;3405.7786243894066;3412.9829350853333;3486.3550243205086;3495.7378196635354;41470.1705965882;41484.58515414868;41540.376894346606;43255.35116973248;43598;8902.332325075646;8943.195112439911;8958.10418958112;8983.505907175168;9040;17966;17987.100644967963;18026.188821503063;18117.728234076498;18202.726959095624;6354.904676429857;6510.9023364649565;6583.604983700993;6683.832904177337;6773.695183716744;3469.219425629213;3570.0896271450615;3587.336342776595;3596.7662101963288;3598.2803439312243;2716.5653495440633;2799.0902956539207;2811.6485439320086;2815.268030312093;2818.8167769094944;509.06840481918;510.00548929587455;511.128525863402;521.7886755863881;524.1639584862139;469.5773803576808;620.2494981072862;635.7806556737918;640.6412409050946;657.2015001772774;7882.211778822187;7952.204779522001;8016.095779825699;8201.630926608317;8271.379646526535;501.2931766209627;520.8958208358343;533.8131653921174;556.6103727390843;584.7923986984559;3588.1209103769743;3717.402175581397;3752.662260396523;3763.1532905096683;3768.3970564709516;48321.27518087231;48798.512014879394;49002.26496602483;49092.75453622709;49165.26252106221;44606;45124;46289.76855115703;46346.30480542794;46350;39765.40351894666;39988.40017399683;40801;40881;43301.56698432975;7844.646990885538;7946.801329966797;8141.715039973573;8262.215089566482;8326.6669333226;27004.189874303804;28473.28816779597;28524.85737571299;29536.556951646173;29635.110946671633;35300.646993529735;37645.05887352838;37964.430533542574;38040.42939355857;38283.2343353137;10253;10337.431441270803;10658.520366583367;10687.5190616424;10906.909309069348;11474.254173478697;11874.643760687193;12015.45930433115;12029.518819247132;12064.095192860395;10286.485675716034;10589.9470502647;10664.466776661291;10902.127829773757;10964.506597202986;11154.219204655596;11184.217104802585;11230.834014515434;11271.549138034386;11486.13853960973;10133.92790488193;10341.63804266847;10441.425721585385;10525.421101839473;10722.678319650424;8661.653533858575;8747.562621868754;8772;8888.580670408137;9067.04795996411;8909.821803564022;9470.810583788423;9501.857472138061;9556.85664715016;9575.712728618153 06:59:18 INFO - PROCESS | 32207 | __end_tp_report 06:59:18 INFO - PROCESS | 32207 | __start_cc_report 06:59:18 INFO - PROCESS | 32207 | _x_x_mozilla_cycle_collect,373 06:59:18 INFO - PROCESS | 32207 | __end_cc_report 06:59:18 INFO - PROCESS | 32207 | __startTimestamp1462802358199__endTimestamp 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | ------- Summary: start ------- 06:59:18 INFO - PROCESS | 32207 | Number of tests: 6 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#0] dojo.html Cycles:165 Average:4773.88 Median:4915.75 stddev:612.41 (12.5%) stddev-sans-first:591.18 06:59:18 INFO - PROCESS | 32207 | Values: 2649.9 2675.8 2700.9 2712.7 2718.2 4714.9 4765.6 4773.0 4773.2 4806.8 4649.5 4782.9 4863.0 4876.8 4881.4 4466.5 4495.5 4595.5 4604.5 4628.4 415.0 4326.7 4408.0 4457.7 4479.4 4432.2 4437.6 4443.3 4457.6 4487.4 4442.7 4462.8 4463.9 4474.5 4501.0 4391.5 4397.9 4450.0 4454.9 4461.3 4759.8 4765.9 4793.5 4803.8 4838.7 4966.7 5172.7 5200.3 5220.5 5254.2 5152.3 5163.1 5190.9 5193.2 5264.4 4900.9 4902.2 4922.1 4925.9 4934.1 5270.4 5308.4 5319.5 5350.2 5362.5 5081.6 5100.4 5100.4 5101.3 5104.2 5161.4 5167.4 5171.1 5180.3 5190.9 4953.7 5157.4 5177.4 5182.6 5228.5 5124.1 5149.4 5161.5 5169.3 5214.8 4317.5 4484.6 4492.5 4503.2 4545.3 3740.0 3830.6 3885.7 3905.9 3935.7 4417.9 4432.6 4450.1 4483.9 4523.1 5230.0 5241.6 5243.1 5243.9 5258.0 4338.5 4381.8 4413.8 4442.4 4445.2 4637.9 4697.6 4707.2 4708.7 4768.0 4666.7 4833.5 4868.9 4882.0 4916.3 5194.7 5201.1 5227.4 5232.7 5287.8 4855.7 4889.9 4890.3 4908.3 4937.3 4780.1 5153.6 5164.3 5178.4 5184.4 5151.7 5208.7 5224.8 5252.7 5319.9 5086.4 5095.7 5105.9 5139.6 5162.6 4921.5 5048.4 5117.6 5118.9 5127.8 4995.1 5001.3 5016.3 5062.1 5116.1 5140.5 5146.2 5168.9 5176.8 5203.1 4838.8 4915.7 4945.4 5060.2 5067.5 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#1] ext.html Cycles:180 Average:45579.85 Median:20663.86 stddev:83487.89 (404.0%) stddev-sans-first:83653.66 06:59:18 INFO - PROCESS | 32207 | Values: 558.9 591.9 603.4 606.9 637.7 36805.8 37692.6 41557.2 41686.8 41724.2 42954.6 43050.0 43479.8 43490.6 43495.0 7966.7 8075.7 8100.0 8108.1 8108.7 7862.6 7895.2 7941.1 7954.6 7969.8 7986.0 8000.2 8005.0 8017.4 8020.7 7808.7 7871.9 7911.4 7928.9 7966.7 7891.7 7934.5 7952.1 7953.1 7963.0 30327.8 39334.4 40069.8 40078.2 40136.8 3120.8 3150.6 3150.7 3625.5 3743.3 28062.3 28246.0 28625.9 29772.9 29937.6 3105.4 3188.1 3188.9 3189.3 3197.5 211566.0 211790.0 212319.0 212683.0 212923.0 33229.2 33299.3 33354.2 34071.3 34994.1 36030.1 36199.0 36209.6 36283.3 36333.5 11883.2 12076.8 12103.2 12103.3 12117.6 9867.9 9960.2 9967.1 9973.7 10003.4 8430.1 8516.1 8541.5 8561.7 8568.8 3241.7 3258.2 3264.0 3283.4 3348.3 935.9 945.3 955.6 971.6 1027.8 27634.7 28830.4 28915.9 29222.7 29681.6 979.4 998.6 1017.5 1025.6 1070.4 15404.2 15589.8 15640.3 15644.0 15731.5 384587.0 387241.0 388865.0 390296.0 390552.0 49756.5 50787.5 51046.5 51052.0 51157.2 1246.2 1275.3 1275.8 1280.6 1281.4 28040.3 28742.7 29167.8 29355.1 29620.9 44336.8 44533.6 44820.6 44865.8 44902.6 321692.0 322416.0 323078.0 323569.0 324147.0 25804.0 25999.5 26344.5 26378.1 26800.0 43647.6 44359.0 44664.0 44752.3 44766.3 37584.4 37653.4 38265.8 38825.0 39601.6 37263.4 37959.4 38089.4 38189.6 38486.6 32735.5 37239.4 37423.4 37774.0 38707.8 31896.0 32849.5 33636.7 34075.7 34134.5 26889.7 27069.7 27112.0 27156.7 27292.2 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#2] jquery.html Cycles:180 Average:24567.63 Median:4503.77 stddev:67701.36 (1503.2%) stddev-sans-first:67866.92 06:59:18 INFO - PROCESS | 32207 | Values: 379.5 381.0 383.2 392.5 394.7 16084.2 17075.4 17174.6 17601.9 17704.2 16774.2 16930.8 17347.0 17387.5 17394.8 5105.0 5193.6 5264.6 5266.9 5266.9 3640.6 5672.1 6026.3 6033.7 6122.9 5053.5 6062.1 6065.9 6074.6 6087.5 5309.1 5394.9 5395.2 5421.5 5428.4 5030.4 5460.1 5464.0 5471.1 5484.8 12486.6 12710.7 12763.9 18316.7 20966.7 1971.3 1971.5 1998.4 2015.8 2047.2 9711.5 9829.2 9912.9 11937.7 12452.0 1739.9 1776.0 1803.2 1823.4 1880.1 66432.7 67767.0 68288.0 69517.0 69567.3 10125.5 10216.3 10229.7 10317.7 10607.1 14600.0 14635.3 14657.6 14681.5 14723.0 6865.5 6882.2 6935.7 7084.3 7117.3 6261.5 6359.7 6362.4 6495.6 6504.2 4469.9 4497.2 4510.4 4541.2 4622.1 1699.3 1788.5 1904.6 1905.5 1935.1 827.0 916.5 917.1 919.1 999.2 15578.0 15787.4 16988.0 17272.6 17348.0 872.8 907.4 921.3 944.2 954.6 9640.3 9685.6 9707.7 9732.6 9780.5 398255.0 411434.0 412867.0 414677.0 417066.0 74205.0 78065.0 78938.6 80346.6 80699.0 950.5 963.6 974.4 978.8 1004.4 15924.8 15982.6 16047.8 16151.8 16254.3 24046.4 25365.5 34860.1 35247.3 37255.4 45456.8 46182.4 47811.8 49464.0 51502.5 7481.8 7802.3 7877.8 7885.1 8057.1 7274.0 8647.5 10997.9 11730.3 11821.7 9975.0 10264.8 10360.3 10361.8 10582.5 10165.9 10294.4 10363.3 10501.8 10559.2 5216.2 6946.7 10215.0 10354.3 10747.9 7548.4 7802.7 7814.5 7908.8 7989.6 10063.3 10206.7 10257.1 10277.4 10717.9 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#3] mootools.html Cycles:180 Average:4976.22 Median:5449.25 stddev:2676.70 (49.1%) stddev-sans-first:2671.31 06:59:18 INFO - PROCESS | 32207 | Values: 1480.4 1481.9 1641.4 1803.3 1804.5 6439.6 7119.2 7166.5 7674.0 7680.3 7305.9 7468.2 7484.4 7513.1 7566.5 2144.8 2159.8 2176.4 2186.9 2187.3 2161.3 2170.7 2223.9 2226.0 2230.3 2186.8 2199.7 2202.9 2210.0 2225.5 2123.5 2130.1 2132.0 2134.1 2136.1 2122.9 2138.7 2146.1 2153.2 2165.8 7471.5 7487.9 7522.0 7552.1 7573.9 4442.8 4529.7 4579.8 4594.0 4606.8 2886.5 3008.6 3029.0 3037.9 3116.1 932.2 961.6 978.6 988.0 1009.8 9891.6 9918.2 9937.2 9942.3 9968.9 4180.8 4193.8 4292.1 4293.8 4335.8 8572.8 8572.9 8576.4 8607.4 8610.7 4347.3 4427.3 4462.9 4546.8 4571.9 3535.0 3887.1 4020.8 4042.1 4042.7 3626.2 3688.3 3712.2 3721.8 3770.2 1131.5 1144.2 1161.5 1173.0 1199.1 737.1 818.7 900.7 903.7 910.3 5167.5 5172.5 5210.8 5222.9 5229.3 844.1 844.6 852.1 858.0 927.5 3679.0 3699.2 3718.0 3727.8 3759.8 8770.2 8886.5 9150.7 9169.2 9182.3 9092.5 9148.6 9153.0 9181.3 9197.7 6933.5 6949.7 6999.0 7024.0 7103.7 4930.9 4976.8 5033.7 5040.3 5157.4 8260.8 8339.6 8364.5 8514.1 8532.4 8228.2 8475.9 8534.4 8541.0 8628.7 5669.2 6088.5 6169.4 6260.7 6318.8 7294.3 7326.8 7341.4 7407.1 7413.4 6539.7 6718.3 6751.3 6802.9 6820.9 6594.3 6621.4 6624.6 6677.2 6762.8 6074.4 6122.0 6188.7 6208.2 6217.5 4382.9 4402.3 4452.9 4510.6 4533.0 4599.2 4686.7 4701.4 4707.2 4726.9 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#4] prototype.html Cycles:180 Average:4295.27 Median:4915.06 stddev:1246.24 (25.4%) stddev-sans-first:1213.24 06:59:18 INFO - PROCESS | 32207 | Values: 306.4 316.9 318.1 321.7 325.8 4858.4 4915.6 5045.2 5048.9 5107.2 4940.8 4947.9 5008.9 5009.9 5031.7 3944.2 3948.0 3952.7 3959.6 3976.0 3694.7 3958.2 3971.8 3974.2 3983.1 3770.4 3863.4 3870.7 3877.4 3878.5 3825.3 3884.3 3891.8 3909.8 3911.3 3434.1 3446.9 3460.5 3464.9 3469.7 4651.7 4788.8 4793.6 4914.6 4917.2 4375.4 4395.1 4413.4 4415.5 4430.3 5204.8 5205.0 5209.2 5209.4 5216.8 3633.3 3720.9 3726.0 3727.4 3732.8 5443.0 5445.9 5453.5 5459.2 5470.7 3750.6 3752.3 3778.9 3795.5 3808.9 3867.1 3869.6 3873.2 3878.2 3889.4 4327.5 4331.4 4338.0 4353.6 4365.5 5168.8 5174.8 5228.6 5251.6 5271.3 1238.5 1268.6 1287.3 1292.3 1293.3 868.2 879.4 891.8 899.9 902.1 4341.8 4382.9 4389.3 4399.1 4400.6 5154.2 5181.4 5193.7 5220.7 5222.3 4247.3 4348.3 4400.3 4405.4 4434.6 2717.5 2765.8 2768.6 2770.6 2785.5 4903.3 4912.7 4924.5 4925.3 4927.6 5137.9 5258.2 5293.2 5299.2 5362.4 4853.9 4864.9 4880.2 4894.8 4929.9 5181.8 5215.8 5231.9 5272.8 5284.1 5012.4 5154.6 5169.3 5177.3 5216.9 4920.0 4923.9 4943.3 4968.3 4978.0 3739.3 3745.4 3748.9 3750.0 3766.7 5028.2 5111.7 5133.5 5255.6 5283.1 5125.1 5265.6 5267.9 5284.6 5295.6 5235.9 5279.8 5291.6 5295.5 5315.8 4966.8 5143.0 5154.6 5176.5 5266.3 5329.3 5347.7 5360.4 5363.4 5378.8 5171.4 5189.8 5272.1 5288.2 5296.7 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - PROCESS | 32207 | [#5] yui.html Cycles:180 Average:12353.64 Median:44102.00 stddev:13735.41 (31.1%) stddev-sans-first:13746.03 06:59:18 INFO - PROCESS | 32207 | Values: 693.9 730.0 799.9 808.6 821.4 10545.6 10843.6 10885.3 10936.9 10968.8 11843.9 11870.5 11901.6 11904.6 11918.2 662.6 842.8 855.1 872.6 872.7 860.0 866.5 867.8 868.0 868.6 920.8 928.0 932.2 932.5 936.4 914.8 917.6 919.2 920.6 920.9 677.1 677.4 678.0 678.5 678.9 12281.8 12285.3 12306.3 12398.6 12455.6 12603.2 12635.0 12780.8 12946.8 13290.2 9733.0 9810.4 9933.4 9937.7 10120.1 3302.5 3405.8 3413.0 3486.4 3495.7 41470.2 41484.6 41540.4 43255.4 43598.0 8902.3 8943.2 8958.1 8983.5 9040.0 17966.0 17987.1 18026.2 18117.7 18202.7 6354.9 6510.9 6583.6 6683.8 6773.7 3469.2 3570.1 3587.3 3596.8 3598.3 2716.6 2799.1 2811.6 2815.3 2818.8 509.1 510.0 511.1 521.8 524.2 469.6 620.2 635.8 640.6 657.2 7882.2 7952.2 8016.1 8201.6 8271.4 501.3 520.9 533.8 556.6 584.8 3588.1 3717.4 3752.7 3763.2 3768.4 48321.3 48798.5 49002.3 49092.8 49165.3 44606.0 45124.0 46289.8 46346.3 46350.0 39765.4 39988.4 40801.0 40881.0 43301.6 7844.6 7946.8 8141.7 8262.2 8326.7 27004.2 28473.3 28524.9 29536.6 29635.1 35300.6 37645.1 37964.4 38040.4 38283.2 10253.0 10337.4 10658.5 10687.5 10906.9 11474.3 11874.6 12015.5 12029.5 12064.1 10286.5 10589.9 10664.5 10902.1 10964.5 11154.2 11184.2 11230.8 11271.5 11486.1 10133.9 10341.6 10441.4 10525.4 10722.7 8661.7 8747.6 8772.0 8888.6 9067.0 8909.8 9470.8 9501.9 9556.9 9575.7 06:59:18 INFO - PROCESS | 32207 | -------- Summary: end -------- 06:59:18 INFO - PROCESS | 32207 | 06:59:18 INFO - TEST-INFO | 32207: exit 0 06:59:18 INFO - TEST-OK | dromaeo_css | took 1116780ms 06:59:18 INFO - TEST-START | kraken 06:59:18 INFO - operating with platform_type : linux_ 06:59:18 INFO - Initialising browser for kraken test... 06:59:18 INFO - TEST-INFO | started process 32442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv4Q7rJ/profile http://localhost:44090/getInfo.html) 06:59:23 INFO - PROCESS | 32442 | 06:59:23 INFO - PROCESS | 32442 | (process:32506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:24 INFO - PROCESS | 32442 | __metrics Screen width/height:1600/1200 06:59:24 INFO - PROCESS | 32442 | colorDepth:24 06:59:24 INFO - PROCESS | 32442 | Browser inner width/height: 1024/697 06:59:24 INFO - PROCESS | 32442 | __metrics 06:59:25 ERROR - PROCESS | 32442 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 06:59:26 INFO - TEST-INFO | 32442: exit 0 06:59:26 INFO - Browser initialized. 06:59:26 INFO - Running cycle 1/1 for kraken test... 06:59:26 INFO - TEST-INFO | started process 32558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv4Q7rJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:28 INFO - PROCESS | 32558 | 06:59:28 INFO - PROCESS | 32558 | (process:32619): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:38 INFO - PROCESS | 32558 | RSS: Main: 163831808 06:59:38 INFO - PROCESS | 32558 | 06:59:41 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44090/tests/kraken/driver.html?testName=audio-beat-detection) 06:59:42 INFO - PROCESS | 32558 | RSS: Main: 167387136 06:59:42 INFO - PROCESS | 32558 | 06:59:44 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44090/tests/kraken/driver.html?testName=audio-dft) 06:59:45 INFO - PROCESS | 32558 | RSS: Main: 167305216 06:59:45 INFO - PROCESS | 32558 | 06:59:48 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44090/tests/kraken/driver.html?testName=audio-fft) 06:59:49 INFO - PROCESS | 32558 | RSS: Main: 163352576 06:59:49 INFO - PROCESS | 32558 | 06:59:51 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44090/tests/kraken/driver.html?testName=audio-oscillator) 06:59:52 INFO - PROCESS | 32558 | RSS: Main: 163749888 06:59:52 INFO - PROCESS | 32558 | 06:59:54 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:59:54 INFO - PROCESS | 32558 | RSS: Main: 164319232 06:59:54 INFO - PROCESS | 32558 | 06:59:58 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44090/tests/kraken/driver.html?testName=imaging-darkroom) 06:59:58 INFO - PROCESS | 32558 | RSS: Main: 164192256 06:59:58 INFO - PROCESS | 32558 | 07:00:02 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44090/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:03 INFO - PROCESS | 32558 | RSS: Main: 163192832 07:00:03 INFO - PROCESS | 32558 | 07:00:06 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44090/tests/kraken/driver.html?testName=json-parse-financial) 07:00:06 INFO - PROCESS | 32558 | RSS: Main: 163319808 07:00:06 INFO - PROCESS | 32558 | 07:00:08 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:09 INFO - PROCESS | 32558 | RSS: Main: 163479552 07:00:09 INFO - PROCESS | 32558 | 07:00:11 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:00:11 INFO - PROCESS | 32558 | RSS: Main: 163360768 07:00:11 INFO - PROCESS | 32558 | 07:00:14 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:14 INFO - PROCESS | 32558 | RSS: Main: 164528128 07:00:14 INFO - PROCESS | 32558 | 07:00:17 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:18 INFO - PROCESS | 32558 | RSS: Main: 164134912 07:00:18 INFO - PROCESS | 32558 | 07:00:21 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:00:21 INFO - PROCESS | 32558 | RSS: Main: 163971072 07:00:21 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | Cycle 1(1): loaded http://localhost:44090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44090/tests/kraken/driver.html?testName=ai-astar) 07:00:23 INFO - PROCESS | 32558 | RSS: Main: 166330368 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | __start_tp_report 07:00:23 INFO - PROCESS | 32558 | _x_x_mozilla_page_load 07:00:23 INFO - PROCESS | 32558 | _x_x_mozilla_page_load_details 07:00:23 INFO - PROCESS | 32558 | |i|pagename|runs| 07:00:23 INFO - PROCESS | 32558 | |0;ai-astar;115;116;109;114;115;114;107;114;117;116 07:00:23 INFO - PROCESS | 32558 | |1;audio-beat-detection;155;132;160;212;142;155;158;132;191;135 07:00:23 INFO - PROCESS | 32558 | |2;audio-dft;163;164;168;168;163;163;161;163;162;163 07:00:23 INFO - PROCESS | 32558 | |3;audio-fft;75;76;76;169;76;75;76;77;161;76 07:00:23 INFO - PROCESS | 32558 | |4;audio-oscillator;93;93;183;92;93;93;141;92;93;143 07:00:23 INFO - PROCESS | 32558 | |5;imaging-gaussian-blur;118;118;118;118;119;118;118;118;118;118 07:00:23 INFO - PROCESS | 32558 | |6;imaging-darkroom;148;147;146;147;147;148;148;147;147;146 07:00:23 INFO - PROCESS | 32558 | |7;imaging-desaturate;95;97;95;96;96;96;96;95;95;95 07:00:23 INFO - PROCESS | 32558 | |8;json-parse-financial;66;66;65;66;65;65;65;67;64;65 07:00:23 INFO - PROCESS | 32558 | |9;json-stringify-tinderbox;65;66;66;66;65;66;65;65;65;65 07:00:23 INFO - PROCESS | 32558 | |10;stanford-crypto-aes;81;87;85;96;87;88;84;82;136;82 07:00:23 INFO - PROCESS | 32558 | |11;stanford-crypto-ccm;134;144;132;133;135;137;134;147;151;137 07:00:23 INFO - PROCESS | 32558 | |12;stanford-crypto-pbkdf2;176;178;181;180;175;172;171;176;172;173 07:00:23 INFO - PROCESS | 32558 | |13;stanford-crypto-sha256-iterative;69;70;69;73;68;66;68;67;71;68 07:00:23 INFO - PROCESS | 32558 | __end_tp_report 07:00:23 INFO - PROCESS | 32558 | __start_cc_report 07:00:23 INFO - PROCESS | 32558 | _x_x_mozilla_cycle_collect,917 07:00:23 INFO - PROCESS | 32558 | __end_cc_report 07:00:23 INFO - PROCESS | 32558 | __startTimestamp1462802423963__endTimestamp 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | ------- Summary: start ------- 07:00:23 INFO - PROCESS | 32558 | Number of tests: 14 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.20 (2.8%) stddev-sans-first:3.36 07:00:23 INFO - PROCESS | 32558 | Values: 115.0 116.0 109.0 114.0 115.0 114.0 107.0 114.0 117.0 116.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:156.50 stddev:26.16 (16.7%) stddev-sans-first:27.73 07:00:23 INFO - PROCESS | 32558 | Values: 155.0 132.0 160.0 212.0 142.0 155.0 158.0 132.0 191.0 135.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.35 (1.4%) stddev-sans-first:2.47 07:00:23 INFO - PROCESS | 32558 | Values: 163.0 164.0 168.0 168.0 163.0 163.0 161.0 163.0 162.0 163.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.63 (49.5%) stddev-sans-first:39.30 07:00:23 INFO - PROCESS | 32558 | Values: 75.0 76.0 76.0 169.0 76.0 75.0 76.0 77.0 161.0 76.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:93.00 stddev:32.40 (34.8%) stddev-sans-first:33.66 07:00:23 INFO - PROCESS | 32558 | Values: 93.0 93.0 183.0 92.0 93.0 93.0 141.0 92.0 93.0 143.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:00:23 INFO - PROCESS | 32558 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:00:23 INFO - PROCESS | 32558 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 146.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:00:23 INFO - PROCESS | 32558 | Values: 95.0 97.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 07:00:23 INFO - PROCESS | 32558 | Values: 66.0 66.0 65.0 66.0 65.0 65.0 65.0 67.0 64.0 65.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:00:23 INFO - PROCESS | 32558 | Values: 65.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:86.00 stddev:16.46 (19.1%) stddev-sans-first:17.07 07:00:23 INFO - PROCESS | 32558 | Values: 81.0 87.0 85.0 96.0 87.0 88.0 84.0 82.0 136.0 82.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.00 stddev:6.57 (4.8%) stddev-sans-first:6.77 07:00:23 INFO - PROCESS | 32558 | Values: 134.0 144.0 132.0 133.0 135.0 137.0 134.0 147.0 151.0 137.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.00 stddev:3.47 (2.0%) stddev-sans-first:3.67 07:00:23 INFO - PROCESS | 32558 | Values: 176.0 178.0 181.0 180.0 175.0 172.0 171.0 176.0 172.0 173.0 07:00:23 INFO - PROCESS | 32558 | 07:00:23 INFO - PROCESS | 32558 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.02 (2.9%) stddev-sans-first:2.15 07:00:23 INFO - PROCESS | 32558 | Values: 69.0 70.0 69.0 73.0 68.0 66.0 68.0 67.0 71.0 68.0 07:00:23 INFO - PROCESS | 32558 | -------- Summary: end -------- 07:00:23 INFO - PROCESS | 32558 | 07:00:24 INFO - TEST-INFO | 32558: exit 0 07:00:25 INFO - TEST-OK | kraken | took 66111ms 07:00:25 INFO - SUITE-END | took 1182s 07:00:25 INFO - Completed test suite (00:19:42) 07:00:25 INFO - javascript benchmark 07:00:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.8675066246687, 2675.7725593324567, 2700.9459810803783, 2712.715164907686, 2718.170957857854, 4714.929276060858, 4765.594924431423, 4772.952270477294, 4773.236282194849, 4806.783694733736, 4649.46531148918, 4782.928256076161, 4862.951370486294, 4876.780544875481, 4881.414230292361, 4466.508684044745, 4495.505494395614, 4595.540445955395, 4604.493505714368, 4628.375169352128, 415.0477937509275, 4326.6538676905775, 4407.955920440802, 4457.6879618426565, 4479.440069991251, 4432.20220360335, 4437.5784300491405, 4443.311286750559, 4457.598816106533, 4487.39420178275, 4442.666799990014, 4462.821487140511, 4463.888402789924, 4474.485434175079, 4501.0322780602, 4391.4730232372, 4397.868063958086, 4449.955500444987, 4454.8886277842985, 4461.263891457906, 4759.785809638574, 4765.880852978668, 4793.520647935178, 4803.831865884712, 4838.733869637169, 4966.701997880139, 5172.663776854492, 5200.349956255468, 5220.4779522047875, 5254.21186821976, 5152.278680984665, 5163.1480805667015, 5190.935858149108, 5193.246979187997, 5264.394594621629, 4900.877478063041, 4902.2401527762895, 4922.064807686528, 4925.876853078702, 4934.136526107916, 5270.393904701008, 5308.389535203424, 5319.521243088063, 5350.224217488442, 5362.51737343641, 5081.644284900021, 5100.362454693163, 5100.38795344561, 5101.2603172539775, 5104.183330667075, 5161.354830646169, 5167.405748338989, 5171.146760784429, 5180.326557547494, 5190.92213616796, 4953.7275449849885, 5157.406898206679, 5177.352830896138, 5182.611304152204, 5228.529432351031, 5124.103281925648, 5149.407818100892, 5161.535461808456, 5169.327987361619, 5214.817481388209, 4317.503487098961, 4484.551544845489, 4492.460904691393, 4503.211937910853, 4545.2954792007295, 3740.0462881964927, 3830.616938306203, 3885.708571857122, 3905.882823515299, 3935.704822138351, 4417.917610185461, 4432.578905004019, 4450.109978004412, 4483.865484035484, 4523.11799199153, 5229.973850130801, 5241.633085683966, 5243.082460569385, 5243.868903277372, 5257.973710131425, 4338.457692788402, 4381.802818873159, 4413.845515406945, 4442.378067070613, 4445.177642136216, 4637.930431043537, 4697.600703940135, 4707.246840505502, 4708.670393072521, 4768.022555376139, 4666.696664716783, 4833.516648335209, 4868.926966095441, 4882.023595280958, 4916.336294600254, 5194.68831870089, 5201.115810312332, 5227.424983251915, 5232.659877107976, 5287.841364759063, 4855.684380515255, 4889.877753056202, 4890.266460030882, 4908.263760435821, 4937.308776771327, 4780.139574876555, 5153.613478989166, 5164.32863727713, 5178.352705911761, 5184.377874655065, 5151.742412879416, 5208.73956302191, 5224.764885580082, 5252.684838909678, 5319.946800531945, 5086.415062267739, 5095.694258344512, 5105.851183483686, 5139.6145289102715, 5162.612804039787, 4921.507849215193, 5048.368953880765, 5117.616178786531, 5118.923216151687, 5127.846164615067, 4995.075910956485, 5001.274815151855, 5016.322796422436, 5062.088824011713, 5116.053530096944, 5140.537351638371, 5146.176611742103, 5168.870778230575, 5176.767045483038, 5203.063448579292, 4838.782254798472, 4915.746484646393, 4945.381827271591, 5060.1903695408555, 5067.518585734497], "value": 4736.520408466306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8630785457561, 591.9052951527755, 603.3755063509266, 606.930203026652, 637.735339833969, 36805.81597092014, 37692.62307376929, 41557.16885662285, 41686.7915660422, 41724.16551668969, 42954.57045429545, 43050.0, 43479.78260108695, 43490.56509434905, 43495.0, 7966.721164759249, 8075.717349892755, 8100.0, 8108.067572229181, 8108.675652973874, 7862.567558784264, 7895.249951254622, 7941.126476087655, 7954.562499062549, 7969.760907172794, 7986.041674999008, 8000.199980001982, 8005.0, 8017.3586113111105, 8020.719274825382, 7808.726694565663, 7871.881921771178, 7911.446198766089, 7928.920710792905, 7966.721164759206, 7891.723789667391, 7934.484258523177, 7952.125266220711, 7953.12515623281, 7963.044434667877, 30327.848360758275, 39334.409983850266, 40069.79965100156, 40078.19843603141, 40136.799316003526, 3120.828354440505, 3150.6376766671897, 3150.716435520791, 3625.546806649169, 3743.288775132716, 28062.298442538897, 28246.0, 28625.856870715514, 29772.8511357444, 29937.550936735966, 3105.3634005028916, 3188.059522440862, 3188.8883889063773, 3189.2505261263586, 3197.488401855692, 211566.0, 211790.0, 212319.0, 212682.99999999846, 212923.0, 33229.16927076794, 33299.334013319596, 33354.166145846066, 34071.31857362839, 34994.125146871535, 36030.09924751902, 36199.0, 36209.63790362115, 36283.27433451316, 36333.454998175046, 11883.227590206781, 12076.818847717292, 12103.213291136048, 12103.33431661267, 12117.575884843987, 9867.901320986699, 9960.153386962045, 9967.10296073357, 9973.700788976343, 10003.399796012263, 8430.072692003874, 8516.1058088901, 8541.53021583819, 8561.657533698706, 8568.785780355542, 3241.7406607471344, 3258.185453636591, 3263.9673603264137, 3283.3925723741186, 3348.3135957129216, 935.8876934767871, 945.3099237556622, 955.6368579939578, 971.606499367743, 1027.845823126522, 27634.723652763616, 28830.42339153205, 28915.855420723183, 29222.707772922, 29681.554776678367, 979.4417182206216, 998.605550807427, 1017.4556612212579, 1025.6102680981328, 1070.3577853287966, 15404.229788510529, 15589.844101559067, 15640.296186671627, 15644.0, 15731.528054158394, 384587.0, 387241.0, 388865.0, 390296.0, 390552.0, 49756.502434975184, 50787.476375708786, 51046.48953510417, 51052.0, 51157.23264151041, 1246.2273390497949, 1275.2922128218927, 1275.8213850060813, 1280.5646080332544, 1281.404147071616, 28040.29899252535, 28742.712572874003, 29167.791542929837, 29355.11934641964, 29620.851895740383, 44336.77831610951, 44533.554664454234, 44820.55179448164, 44865.77567112144, 44902.55097449115, 321692.0, 322416.0, 323078.0, 323569.0, 324147.0, 25804.0, 25999.49461667642, 26344.473110538067, 26378.07676731305, 26800.0, 43647.62772722865, 44359.0, 44664.0, 44752.328715069954, 44766.3285050718, 37584.43623345597, 37653.435198471496, 38265.80867095647, 38825.0, 39601.603983959794, 37263.44104838376, 37959.430608540344, 38089.4286585707, 38189.618103818604, 38486.6151338483, 32735.508967365033, 37239.441408378356, 37423.43864841975, 37774.0, 38707.80646096864, 31896.0, 32849.53991544392, 33636.66363336433, 34075.65924340725, 34134.487982680774, 26889.731102689504, 27069.72930270672, 27112.0, 27156.72843271621, 27292.181234562995], "value": 16630.596087485792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.49906123916435, 381.0245770826684, 383.1761712318516, 392.49564309861836, 394.686224451561, 16084.195790210486, 17075.40236091737, 17174.57063573411, 17601.91199044006, 17704.20331085101, 16774.245158967846, 16930.773566365908, 17347.04591247481, 17387.478375648752, 17394.826051739477, 5104.9744751276285, 5193.63644544882, 5264.631475796696, 5266.894662106774, 5266.92099618506, 3640.5813331466825, 5672.092465205568, 6026.276846778393, 6033.69831508425, 6122.938770612303, 5053.494650534935, 6062.060380641008, 6065.939340606604, 6074.63552186868, 6087.512998960073, 5309.097453432906, 5394.865128371783, 5395.163749618815, 5421.512063914267, 5428.4028756836715, 5030.3963524377305, 5460.126379779256, 5464.0, 5471.124620060811, 5484.8354549363585, 12486.562970296087, 12710.682232944158, 12763.936180319039, 18316.725249121275, 20966.685499717518, 1971.2607772085469, 1971.5071232191951, 1998.3605246321183, 2015.838732901379, 2047.1708957872086, 9711.514424278828, 9829.213662907021, 9912.851307230398, 11937.701557461132, 12452.0, 1739.8608111351189, 1775.973360399595, 1803.2246134162306, 1823.4165067178508, 1880.069365664005, 66432.6678366605, 67767.0, 68288.0, 69516.99999999949, 69567.30432695658, 10125.493725313705, 10216.335938163995, 10229.7442563935, 10317.74205644865, 10607.098396636373, 14600.0, 14635.268236588128, 14657.56027319182, 14681.48614798477, 14723.0, 6865.519413640997, 6882.174139103339, 6935.682220378112, 7084.326988936043, 7117.25268846774, 6261.467775239064, 6359.650219237987, 6362.363763623601, 6495.64273964927, 6504.15445992018, 4469.910601787946, 4497.16802391552, 4510.368548403226, 4541.205289074399, 4622.14490319292, 1699.269314194908, 1788.499220218315, 1904.552430178907, 1905.4950438133906, 1935.1195206181153, 826.9503829770233, 916.5463095767504, 917.0691747875911, 919.0533750237266, 999.2156157416393, 15578.0, 15787.447439339798, 16988.0, 17272.568185795455, 17348.0, 872.7905302727299, 907.3693782821008, 921.2814005076051, 944.187998321443, 954.5895265036102, 9640.276979226586, 9685.612575496902, 9707.70876873695, 9732.562034708313, 9780.510974451248, 398255.0, 411434.0, 412867.0349723783, 414677.0, 417066.0, 74205.0, 78065.0, 78938.6053069731, 80346.59826700829, 80699.0, 950.5152372290044, 963.633819148719, 974.4202199691173, 978.7504186432415, 1004.3873237325225, 15924.761128583312, 15982.60043498922, 16047.839521605101, 16151.75772363439, 16254.349826006828, 24046.39884002914, 25365.492690146464, 34860.12849678778, 35247.29505409929, 37255.441168381956, 45456.772716136205, 46182.38361657326, 47811.76094119507, 49464.0, 51502.48497514977, 7481.812954676177, 7802.29779319864, 7877.84244315099, 7885.093214280202, 8057.113717491188, 7274.01800756891, 8647.524386158822, 10997.890021099687, 11730.296182229093, 11821.704457388634, 9975.0, 10264.846027309746, 10360.274780765274, 10361.84457233127, 10582.523786429476, 10165.949170254102, 10294.433806140734, 10363.32638378503, 10501.78996420052, 10559.208059395729, 5216.217567364925, 6946.722131114901, 10215.02957219063, 10354.326968747007, 10747.89252107469, 7548.433867459853, 7802.726904558313, 7814.4529882907655, 7908.84182316362, 7989.560574168477, 10063.345882517613, 10206.693799186036, 10257.128144107535, 10277.383356998604, 10717.89282107169], "value": 8199.647603743653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.407836865254, 1481.9407223711053, 1641.409092726619, 1803.3327668762543, 1804.5308219862832, 6439.645819479927, 7119.181294151174, 7166.5341752786035, 7674.040744906887, 7680.3087722105, 7305.853882922352, 7468.215837337069, 7484.4012479001685, 7513.135989361225, 7566.470347075693, 2144.8498605097648, 2159.8164156046755, 2176.3688530326185, 2186.8797216153184, 2187.256332846832, 2161.3407910587266, 2170.6526955687013, 2223.899924503401, 2225.9666105008437, 2230.275160572812, 2186.814120799734, 2199.714037175173, 2202.8898555072265, 2210.0386331945656, 2225.5437635284807, 2123.543438160803, 2130.1479408236673, 2131.968020479694, 2134.0503475953205, 2136.0921608316403, 2122.8832414217213, 2138.7112739780086, 2146.087912637123, 2153.224839057938, 2165.7509386420606, 7471.514351567185, 7487.925120748777, 7521.962390188069, 7552.055993000875, 7573.886391704129, 4442.844500442469, 4529.682922195448, 4579.793909274091, 4594.0, 4606.769661516911, 2886.5237235856057, 3008.5938398316384, 3029.0004298581634, 3037.8759858852145, 3116.1430606583144, 932.151741914861, 961.5721004153155, 978.6379039755265, 987.9753006174903, 1009.8384258518602, 9891.554880030344, 9918.156956658693, 9937.155341795957, 9942.254330925138, 9968.900310996869, 4180.784184382283, 4193.769342686121, 4292.055747735493, 4293.806778694966, 4335.7615331157085, 8572.785680357916, 8572.91427085721, 8576.44253123545, 8607.440516366541, 8610.741677749678, 4347.3261644445165, 4427.335899615019, 4462.9107417851465, 4546.772661366918, 4571.9314210286875, 3535.0101971448034, 3887.1448281378052, 4020.7788571628257, 4042.0501182222156, 4042.6563742082253, 3626.165981824195, 3688.3360995021153, 3712.201876596491, 3721.7580857244193, 3770.1517158639635, 1131.5417256011328, 1144.227646338718, 1161.4726634475637, 1173.0, 1199.1006744941294, 737.0602481835703, 818.688898218685, 900.7072701371949, 903.7198468474794, 910.3491003932088, 5167.534921857051, 5172.482751724798, 5210.791568337224, 5222.895542089137, 5229.294045303835, 844.0673056272852, 844.6114787197835, 852.1308265569085, 857.9528125953133, 927.526961249754, 3678.963210367862, 3699.2416554606243, 3718.0, 3727.7763334200035, 3759.793211373401, 8770.210681038738, 8886.511241881759, 9150.725478235663, 9169.174774270214, 9182.265418766483, 9092.454452732858, 9148.634054637872, 9152.95423522878, 9181.311401644769, 9197.678081267124, 6933.479989000845, 6949.687264073129, 6998.965005174941, 7023.964880175567, 7103.715851365888, 4930.8767280818265, 4976.751162441791, 5033.748312584429, 5040.344755181803, 5157.381114266312, 8260.83478330442, 8339.624716887876, 8364.456310339809, 8514.063453020039, 8532.360072994426, 8228.177182281725, 8475.872861907199, 8534.359923005924, 8540.957295213733, 8628.697995570124, 5669.206311116364, 6088.543359248163, 6169.383061693795, 6260.718267678057, 6318.810435686937, 7294.307040831112, 7326.816829579303, 7341.375983041287, 7407.148177959603, 7413.406927445899, 6539.70571324282, 6718.294579069323, 6751.291114432914, 6802.877525208285, 6820.93179068203, 6594.340565943367, 6621.437177839937, 6624.635645039376, 6677.165354330708, 6762.830929226809, 6074.362191969956, 6121.969390153021, 6188.659623720739, 6208.2239720034995, 6217.502599791916, 4382.868513944587, 4402.2516172251435, 4452.910941781081, 4510.616597589242, 4532.9773351133035, 4599.241125214302, 4686.742229177292, 4701.388819453449, 4707.152712511781, 4726.881827954328], "value": 4072.236794495166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.42545227698065, 316.90651257878926, 318.0966056399825, 321.676302017199, 325.8142858570616, 4858.368412106422, 4915.557599816016, 5045.192769156935, 5048.949510504894, 5107.208382700678, 4940.752962351886, 4947.886725486764, 5008.874778130539, 5009.897822479058, 5031.672941258816, 3944.230874979373, 3947.993261718272, 3952.7351247600777, 3959.6238357356006, 3976.0, 3694.685951694109, 3958.1885713428824, 3971.8283106483655, 3974.1852920151446, 3983.0838907051398, 3770.396736522157, 3863.43980122882, 3870.6709929656013, 3877.4377715231276, 3878.45701601776, 3825.2540754552874, 3884.3008258513455, 3891.7859517726515, 3909.824057917372, 3911.2568611963634, 3434.1414646338417, 3446.9486806524, 3460.532828068204, 3464.9133771655656, 3469.705075068622, 4651.651126165551, 4788.760561971888, 4793.5925446337105, 4914.557689807899, 4917.164082106051, 4375.387445757597, 4395.077273613044, 4413.360062790877, 4415.492218394894, 4430.291153415438, 5204.791808327663, 5205.0, 5209.244659524347, 5209.4009188943, 5216.817411390621, 3633.3096711624707, 3720.9255814883822, 3726.0, 3727.422249551324, 3732.832022558964, 5443.0, 5445.863853403657, 5453.481919217668, 5459.181122831567, 5470.7264636768405, 3750.6249375062275, 3752.3433399155037, 3778.886633401002, 3795.5445346558035, 3808.8857334280015, 3867.129895773485, 3869.5743468218475, 3873.225354928969, 3878.166194268246, 3889.416587511896, 4327.502337231196, 4331.4152589400655, 4338.047878454645, 4353.6299414549485, 4365.519792822787, 5168.8449346519665, 5174.767135478913, 5228.63399562027, 5251.553617942518, 5271.341082364705, 1238.486028298264, 1268.6257554021586, 1287.2533930320392, 1292.3344477594046, 1293.2563775828935, 868.2489646455897, 879.366855863777, 891.8171774786153, 899.9460032398077, 902.1024081039277, 4341.8480353188115, 4382.8904277392685, 4389.275769498061, 4399.12017596482, 4400.581944715247, 5154.242480273036, 5181.404138524118, 5193.68837869729, 5220.712860792617, 5222.321098257202, 4247.256730072287, 4348.304271316638, 4400.3498687992005, 4405.3612226227015, 4434.600885920283, 2717.5244332241778, 2765.7787377010195, 2768.5708715149185, 2770.598263251817, 2785.4846853332197, 4903.264510323409, 4912.72979986097, 4924.532169443897, 4925.300771233919, 4927.556519913225, 5137.948620513747, 5258.237555554423, 5293.232481290268, 5299.205119232146, 5362.383325917569, 4853.927191092066, 4864.927026094611, 4880.243562247857, 4894.8042078317185, 4929.926051109236, 5181.766820493162, 5215.843524694265, 5231.921521177262, 5272.815451459181, 5284.075286824867, 5012.423571289349, 5154.587632989277, 5169.327987361619, 5177.275181474522, 5216.895662086813, 4920.0, 4923.876903077452, 4943.29456337563, 4968.285941350228, 4977.9502204978935, 3739.270842185748, 3745.438184272381, 3748.9071515999954, 3749.962500374961, 3766.679832214183, 5028.1590901140735, 5111.670965548909, 5133.486651334837, 5255.579553635624, 5283.075461794094, 5125.051865404912, 5265.6050796189675, 5267.945501254437, 5284.630075894651, 5295.602829787705, 5235.947640523546, 5279.752951934609, 5291.550218231493, 5295.470452954673, 5315.840524784263, 4966.776495057803, 5143.0, 5154.5824898153305, 5176.456472070378, 5266.34170728659, 5329.280547126088, 5347.732613369394, 5360.365088648, 5363.436839131835, 5378.757955891916, 5171.405288391883, 5189.766460509361, 5272.103742363884, 5288.233206185158, 5296.708681022426], "value": 3901.2859551816896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.8542905989742, 729.9671514781836, 799.9280064794167, 808.5633757770804, 821.3962737388023, 10545.63090291839, 10843.620473283436, 10885.292455990355, 10936.890631093687, 10968.835467467994, 11843.881561184386, 11870.465829037692, 11901.642950711472, 11904.583339583116, 11918.165728399015, 662.5925056090517, 842.7640260727006, 855.1448551448551, 872.646578135856, 872.6989188729877, 859.9570021498931, 866.5450638414819, 867.8177582707639, 867.9869801952975, 868.6308318964446, 920.7744102694849, 928.0, 932.2355668351954, 932.4638332958542, 936.3866667332908, 914.8078903430288, 917.554985831871, 919.2278486071732, 920.5949382271846, 920.9217216536603, 677.1265068062194, 677.4309579952863, 678.0202607232502, 678.49452158142, 678.8947713104427, 12281.815772763415, 12285.262884226886, 12306.323152226623, 12398.62804115878, 12455.564055258114, 12603.243805371707, 12635.0, 12780.808287875689, 12946.805797913039, 13290.20258784476, 9733.0, 9810.362326448758, 9933.35433196847, 9937.701868943943, 10120.089191972758, 3302.5046243063493, 3405.7786243894066, 3412.9829350853333, 3486.3550243205086, 3495.7378196635354, 41470.1705965882, 41484.58515414868, 41540.376894346606, 43255.35116973248, 43598.0, 8902.332325075646, 8943.195112439911, 8958.10418958112, 8983.505907175168, 9040.0, 17966.0, 17987.100644967963, 18026.188821503063, 18117.728234076498, 18202.726959095624, 6354.904676429857, 6510.9023364649565, 6583.604983700993, 6683.832904177337, 6773.695183716744, 3469.219425629213, 3570.0896271450615, 3587.336342776595, 3596.7662101963288, 3598.2803439312243, 2716.5653495440633, 2799.0902956539207, 2811.6485439320086, 2815.268030312093, 2818.8167769094944, 509.06840481918, 510.00548929587455, 511.128525863402, 521.7886755863881, 524.1639584862139, 469.5773803576808, 620.2494981072862, 635.7806556737918, 640.6412409050946, 657.2015001772774, 7882.211778822187, 7952.204779522001, 8016.095779825699, 8201.630926608317, 8271.379646526535, 501.2931766209627, 520.8958208358343, 533.8131653921174, 556.6103727390843, 584.7923986984559, 3588.1209103769743, 3717.402175581397, 3752.662260396523, 3763.1532905096683, 3768.3970564709516, 48321.27518087231, 48798.512014879394, 49002.26496602483, 49092.75453622709, 49165.26252106221, 44606.0, 45124.0, 46289.76855115703, 46346.30480542794, 46350.0, 39765.40351894666, 39988.40017399683, 40801.0, 40881.0, 43301.56698432975, 7844.646990885538, 7946.801329966797, 8141.715039973573, 8262.215089566482, 8326.6669333226, 27004.189874303804, 28473.28816779597, 28524.85737571299, 29536.556951646173, 29635.110946671633, 35300.646993529735, 37645.05887352838, 37964.430533542574, 38040.42939355857, 38283.2343353137, 10253.0, 10337.431441270803, 10658.520366583367, 10687.5190616424, 10906.909309069348, 11474.254173478697, 11874.643760687193, 12015.45930433115, 12029.518819247132, 12064.095192860395, 10286.485675716034, 10589.9470502647, 10664.466776661291, 10902.127829773757, 10964.506597202986, 11154.219204655596, 11184.217104802585, 11230.834014515434, 11271.549138034386, 11486.13853960973, 10133.92790488193, 10341.63804266847, 10441.425721585385, 10525.421101839473, 10722.678319650424, 8661.653533858575, 8747.562621868754, 8772.0, 8888.580670408137, 9067.04795996411, 8909.821803564022, 9470.810583788423, 9501.857472138061, 9556.85664715016, 9575.712728618153], "value": 5887.780323089765, "unit": "score"}], "name": "dromaeo_css", "value": 6264.218369430323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 109.0, 114.0, 115.0, 114.0, 107.0, 114.0, 117.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 160.0, 212.0, 142.0, 155.0, 158.0, 132.0, 191.0, 135.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 168.0, 168.0, 163.0, 163.0, 161.0, 163.0, 162.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 169.0, 76.0, 75.0, 76.0, 77.0, 161.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 183.0, 92.0, 93.0, 93.0, 141.0, 92.0, 93.0, 143.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 85.0, 96.0, 87.0, 88.0, 84.0, 82.0, 136.0, 82.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 144.0, 132.0, 133.0, 135.0, 137.0, 134.0, 147.0, 151.0, 137.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 181.0, 180.0, 175.0, 172.0, 171.0, 176.0, 172.0, 173.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 73.0, 68.0, 66.0, 68.0, 67.0, 71.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1605.1000000000004, "alertThreshold": 2.0}]} 07:00:25 INFO - Return code: 0 07:00:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:00:25 ERROR - # TBPL SUCCESS # 07:00:25 INFO - Running post-action listener: _resource_record_post_action 07:00:25 INFO - ##### 07:00:25 INFO - ##### Finished run-tests step (success) 07:00:25 INFO - ##### 07:00:25 INFO - Running post-run listener: _resource_record_post_run 07:00:26 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 0; Write bytes: 531795968; Read time: 0; Write time: 1306164 07:00:26 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 235692032; Read time: 0; Write time: 971816 07:00:26 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 292126720; Read time: 0; Write time: 333616 07:00:26 INFO - Running post-run listener: _upload_blobber_files 07:00:26 INFO - Blob upload gear active. 07:00:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:26 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 07:00:26 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:00:26 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:00:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:00:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:00:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:00:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:27 INFO - (blobuploader) - INFO - Done attempting. 07:00:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:00:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:28 INFO - (blobuploader) - INFO - Done attempting. 07:00:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:28 INFO - Return code: 0 07:00:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d44088b9cf248aad1247aceb709d4b1b4dbd1acfb9c7e8dcd177e44ba7fde0f02ce5adc2d28b78e97f76bfb16dbaac8cfd452a1a510d5f95f1859d296bda1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccf8979e58566b8ac5d48269f98d5d0173203212beb1696984e0889d7543b97fa714878ba9242c4cde2c36b3cf063352976ffbbf390e0a5c465bf706fff7d257"} 07:00:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:28 INFO - Contents: 07:00:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d44088b9cf248aad1247aceb709d4b1b4dbd1acfb9c7e8dcd177e44ba7fde0f02ce5adc2d28b78e97f76bfb16dbaac8cfd452a1a510d5f95f1859d296bda1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccf8979e58566b8ac5d48269f98d5d0173203212beb1696984e0889d7543b97fa714878ba9242c4cde2c36b3cf063352976ffbbf390e0a5c465bf706fff7d257"} 07:00:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:28 INFO - Copying logs to upload dir... 07:00:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.763509 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 07:00:28.071932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:28.076022) ========= 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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d44088b9cf248aad1247aceb709d4b1b4dbd1acfb9c7e8dcd177e44ba7fde0f02ce5adc2d28b78e97f76bfb16dbaac8cfd452a1a510d5f95f1859d296bda1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccf8979e58566b8ac5d48269f98d5d0173203212beb1696984e0889d7543b97fa714878ba9242c4cde2c36b3cf063352976ffbbf390e0a5c465bf706fff7d257"} build_url:https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/SPHAb72cTECJZ4N_8v9dyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d44088b9cf248aad1247aceb709d4b1b4dbd1acfb9c7e8dcd177e44ba7fde0f02ce5adc2d28b78e97f76bfb16dbaac8cfd452a1a510d5f95f1859d296bda1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccf8979e58566b8ac5d48269f98d5d0173203212beb1696984e0889d7543b97fa714878ba9242c4cde2c36b3cf063352976ffbbf390e0a5c465bf706fff7d257"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:28.100752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:28.101100) ========= 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=df17445c3590ff7897617a0e00000225-1462801189.240010-284434426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:00:28.187061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:00:28.187561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:00:28.187882) ========= ========= Total master_lag: 0.17 =========