builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1462957953.1 results: success (0) buildid: 20160510233027 builduid: 039e2fd0af134cf196cbb9226cf1cd95 revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.100002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.100456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.100773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.126387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.126950) ========= 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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 02:12:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.3M=0s 2016-05-11 02:12:33 (66.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.242720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.243084) ========= 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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022150 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.294837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.295214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 91714307a799b978b0a94911cd99ee75a1de0ac5 --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 91714307a799b978b0a94911cd99ee75a1de0ac5 --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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 02:12:33,392 truncating revision to first 12 chars 2016-05-11 02:12:33,392 Setting DEBUG logging. 2016-05-11 02:12:33,392 attempt 1/10 2016-05-11 02:12:33,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/91714307a799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 02:12:33,659 unpacking tar archive at: fx-team-91714307a799/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.850732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.851260) ========= script_repo_revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.851957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.852857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:12:33.864661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-11 02:12:33.865178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:34 INFO - MultiFileLogger online at 20160511 02:12:34 in /builds/slave/test 02:12:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:12:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:34 INFO - {'append_to_log': False, 02:12:34 INFO - 'base_work_dir': '/builds/slave/test', 02:12:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:34 INFO - 'branch': 'Fx-Team', 02:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:34 INFO - 'config_files': ('talos/linux_config.py',), 02:12:34 INFO - 'default_actions': ('clobber', 02:12:34 INFO - 'read-buildbot-config', 02:12:34 INFO - 'download-and-extract', 02:12:34 INFO - 'populate-webroot', 02:12:34 INFO - 'create-virtualenv', 02:12:34 INFO - 'install', 02:12:34 INFO - 'run-tests'), 02:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:34 INFO - 'download_minidump_stackwalk': True, 02:12:34 INFO - 'download_symbols': 'ondemand', 02:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:34 INFO - 'installer_path': 'installer.exe', 02:12:34 INFO - 'log_level': 'info', 02:12:34 INFO - 'log_name': 'talos', 02:12:34 INFO - 'log_to_console': True, 02:12:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:34 INFO - 'opt_config_files': (), 02:12:34 INFO - 'pip_index': False, 02:12:34 INFO - 'sps_profile': False, 02:12:34 INFO - 'sps_profile_interval': 0, 02:12:34 INFO - 'suite': 'dromaeojs-e10s', 02:12:34 INFO - 'system_bits': '32', 02:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:34 INFO - 'title': 'talos-linux64-ix-026', 02:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:34 INFO - 'use_talos_json': True, 02:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:34 INFO - 'work_dir': 'build'} 02:12:34 INFO - ##### 02:12:34 INFO - ##### Running clobber step. 02:12:34 INFO - ##### 02:12:34 INFO - Running pre-action listener: _resource_record_pre_action 02:12:34 INFO - Running main action method: clobber 02:12:34 INFO - rmtree: /builds/slave/test/build 02:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:34 INFO - Running post-action listener: _resource_record_post_action 02:12:34 INFO - ##### 02:12:34 INFO - ##### Finished clobber step (success) 02:12:34 INFO - ##### 02:12:34 INFO - ##### 02:12:34 INFO - ##### Running read-buildbot-config step. 02:12:34 INFO - ##### 02:12:34 INFO - Running pre-action listener: _resource_record_pre_action 02:12:34 INFO - Running main action method: read_buildbot_config 02:12:34 INFO - Using buildbot properties: 02:12:34 INFO - { 02:12:34 INFO - "project": "", 02:12:34 INFO - "product": "firefox", 02:12:34 INFO - "script_repo_revision": "production", 02:12:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:12:34 INFO - "repository": "", 02:12:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:12:34 INFO - "buildid": "20160510233027", 02:12:34 INFO - "pgo_build": "True", 02:12:34 INFO - "basedir": "/builds/slave/test", 02:12:34 INFO - "buildnumber": 452, 02:12:34 INFO - "slavename": "talos-linux64-ix-026", 02:12:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:12:34 INFO - "platform": "ubuntu64_hw", 02:12:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:12:34 INFO - "branch": "fx-team", 02:12:34 INFO - "repo_path": "integration/fx-team", 02:12:34 INFO - "revision": "91714307a799b978b0a94911cd99ee75a1de0ac5", 02:12:34 INFO - "stage_platform": "linux64-pgo", 02:12:34 INFO - "builduid": "039e2fd0af134cf196cbb9226cf1cd95", 02:12:34 INFO - "slavebuilddir": "test" 02:12:34 INFO - } 02:12:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:12:34 INFO - Running post-action listener: _resource_record_post_action 02:12:34 INFO - ##### 02:12:34 INFO - ##### Finished read-buildbot-config step (success) 02:12:34 INFO - ##### 02:12:34 INFO - ##### 02:12:34 INFO - ##### Running download-and-extract step. 02:12:34 INFO - ##### 02:12:34 INFO - Running pre-action listener: _resource_record_pre_action 02:12:34 INFO - Running main action method: download_and_extract 02:12:34 INFO - mkdir: /builds/slave/test/build/tests 02:12:34 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')]} 02:12:34 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:12:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:12:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:12:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:35 INFO - Downloaded 1361 bytes. 02:12:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:12:35 INFO - Using the following test package requirements: 02:12:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:12:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'jsshell-linux-x86_64.zip'], 02:12:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:35 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')]} 02:12:35 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:37 INFO - Downloaded 23902907 bytes. 02:12:37 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'] 02:12:37 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 02:12:38 INFO - Return code: 0 02:12:38 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 02:12:38 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')]} 02:12:38 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:56 INFO - Downloaded 23902907 bytes. 02:12:56 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'] 02:12:56 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 02:12:57 INFO - Return code: 0 02:12: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')]} 02:12:57 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:12:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:12:59 INFO - Downloaded 10840152 bytes. 02:12:59 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'] 02:12:59 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 02:13:00 INFO - Return code: 0 02:13:00 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')]} 02:13:00 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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 02:13:01 INFO - Downloaded 58320439 bytes. 02:13:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:13:01 INFO - mkdir: /builds/slave/test/properties 02:13:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:01 INFO - Contents: 02:13:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:13:02 INFO - Running post-action listener: _resource_record_post_action 02:13:02 INFO - Running post-action listener: set_extra_try_arguments 02:13:02 INFO - ##### 02:13:02 INFO - ##### Finished download-and-extract step (success) 02:13:02 INFO - ##### 02:13:02 INFO - ##### 02:13:02 INFO - ##### Running populate-webroot step. 02:13:02 INFO - ##### 02:13:02 INFO - Running pre-action listener: _resource_record_pre_action 02:13:02 INFO - Running main action method: populate_webroot 02:13:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:02 INFO - '--tppagecycles', 02:13:02 INFO - '7'], 02:13:02 INFO - 'tests': ['tsvgm']}}, 02:13:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['damp', 'tps']}, 02:13:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'tests': ['damp', 'tps']}, 02:13:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['dromaeo_dom']}, 02:13:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['a11yr', 02:13:02 INFO - 'ts_paint', 02:13:02 INFO - 'tpaint', 02:13:02 INFO - 'sessionrestore', 02:13:02 INFO - 'sessionrestore_no_auto_restore', 02:13:02 INFO - 'tabpaint']}, 02:13:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['tsvgx', 02:13:02 INFO - 'tsvgr_opacity', 02:13:02 INFO - 'tart', 02:13:02 INFO - 'tscrollx', 02:13:02 INFO - 'cart']}, 02:13:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:02 INFO - 'tsvgr_opacity', 02:13:02 INFO - 'tart', 02:13:02 INFO - 'tscrollx', 02:13:02 INFO - 'cart']}, 02:13:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'talos_options': ['--disable-e10s'], 02:13:02 INFO - 'tests': ['tp5o']}, 02:13:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'tests': ['tp5o']}, 02:13:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'talos_options': ['--disable-e10s', 02:13:02 INFO - '--xperf_path', 02:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:02 INFO - 'tests': ['tp5n']}, 02:13:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:02 INFO - 'talos_options': ['--xperf_path', 02:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:02 INFO - 'tests': ['tp5n']}}, 02:13:02 INFO - 'talos.zip': {'path': '', 02:13:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:02 INFO - Running post-action listener: _resource_record_post_action 02:13:02 INFO - ##### 02:13:02 INFO - ##### Finished populate-webroot step (success) 02:13:02 INFO - ##### 02:13:02 INFO - ##### 02:13:02 INFO - ##### Running create-virtualenv step. 02:13:02 INFO - ##### 02:13:02 INFO - Running pre-action listener: _resource_record_pre_action 02:13:02 INFO - Running main action method: create_virtualenv 02:13:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:02 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 02:13:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:02 INFO - Using real prefix '/usr' 02:13:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:05 INFO - Installing pip.................done. 02:13:05 INFO - Return code: 0 02:13:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13: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', 'pip>=1.5'] in /builds/slave/test/build 02:13: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 pip>=1.5 02:13:05 INFO - Using env: {'DISPLAY': ':0', 02:13:05 INFO - 'HOME': '/home/cltbld', 02:13:05 INFO - 'LANG': 'en_US.UTF-8', 02:13:05 INFO - 'LANGUAGE': 'en_US:en', 02:13:05 INFO - 'LOGNAME': 'cltbld', 02:13:05 INFO - 'MAIL': '/var/mail/cltbld', 02:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:05 INFO - 'MOZ_NO_REMOTE': '1', 02:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:05 INFO - 'NO_EM_RESTART': '1', 02:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:05 INFO - 'PWD': '/builds/slave/test', 02:13:05 INFO - 'SHELL': '/bin/bash', 02:13:05 INFO - 'SHLVL': '1', 02:13:05 INFO - 'TERM': 'linux', 02:13:05 INFO - 'TMOUT': '86400', 02:13:05 INFO - 'USER': 'cltbld', 02:13:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:05 INFO - '_': '/tools/buildbot/bin/python'} 02:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:05 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 02:13:05 INFO - Cleaning up... 02:13:05 INFO - Return code: 0 02:13:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', '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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 02:13: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 psutil>=0.7.1 02:13:05 INFO - Using env: {'DISPLAY': ':0', 02:13:05 INFO - 'HOME': '/home/cltbld', 02:13:05 INFO - 'LANG': 'en_US.UTF-8', 02:13:05 INFO - 'LANGUAGE': 'en_US:en', 02:13:05 INFO - 'LOGNAME': 'cltbld', 02:13:05 INFO - 'MAIL': '/var/mail/cltbld', 02:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:05 INFO - 'MOZ_NO_REMOTE': '1', 02:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:05 INFO - 'NO_EM_RESTART': '1', 02:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:05 INFO - 'PWD': '/builds/slave/test', 02:13:05 INFO - 'SHELL': '/bin/bash', 02:13:05 INFO - 'SHLVL': '1', 02:13:05 INFO - 'TERM': 'linux', 02:13:05 INFO - 'TMOUT': '86400', 02:13:05 INFO - 'USER': 'cltbld', 02:13:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:05 INFO - '_': '/tools/buildbot/bin/python'} 02:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:05 INFO - Downloading/unpacking psutil>=0.7.1 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:07 INFO - Installing collected packages: psutil 02:13:07 INFO - Running setup.py install for psutil 02:13:07 INFO - building 'psutil._psutil_linux' extension 02:13:07 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 02:13:07 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 02:13:07 INFO - building 'psutil._psutil_posix' extension 02:13:07 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 02:13:08 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 02:13:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:08 INFO - Successfully installed psutil 02:13:08 INFO - Cleaning up... 02:13:08 INFO - Return code: 0 02:13:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', '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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:13: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 mozsystemmonitor==0.0.0 02:13:08 INFO - Using env: {'DISPLAY': ':0', 02:13:08 INFO - 'HOME': '/home/cltbld', 02:13:08 INFO - 'LANG': 'en_US.UTF-8', 02:13:08 INFO - 'LANGUAGE': 'en_US:en', 02:13:08 INFO - 'LOGNAME': 'cltbld', 02:13:08 INFO - 'MAIL': '/var/mail/cltbld', 02:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:08 INFO - 'MOZ_NO_REMOTE': '1', 02:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:08 INFO - 'NO_EM_RESTART': '1', 02:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:08 INFO - 'PWD': '/builds/slave/test', 02:13:08 INFO - 'SHELL': '/bin/bash', 02:13:08 INFO - 'SHLVL': '1', 02:13:08 INFO - 'TERM': 'linux', 02:13:08 INFO - 'TMOUT': '86400', 02:13:08 INFO - 'USER': 'cltbld', 02:13:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:08 INFO - '_': '/tools/buildbot/bin/python'} 02:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:13:10 INFO - Installing collected packages: mozsystemmonitor 02:13:10 INFO - Running setup.py install for mozsystemmonitor 02:13:10 INFO - Successfully installed mozsystemmonitor 02:13:10 INFO - Cleaning up... 02:13:10 INFO - Return code: 0 02:13:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:10 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')]} 02:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:10 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')]} 02:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:10 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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13:10 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 02:13:10 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 02:13:10 INFO - Using env: {'DISPLAY': ':0', 02:13:10 INFO - 'HOME': '/home/cltbld', 02:13:10 INFO - 'LANG': 'en_US.UTF-8', 02:13:10 INFO - 'LANGUAGE': 'en_US:en', 02:13:10 INFO - 'LOGNAME': 'cltbld', 02:13:10 INFO - 'MAIL': '/var/mail/cltbld', 02:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:10 INFO - 'MOZ_NO_REMOTE': '1', 02:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:10 INFO - 'NO_EM_RESTART': '1', 02:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:10 INFO - 'PWD': '/builds/slave/test', 02:13:10 INFO - 'SHELL': '/bin/bash', 02:13:10 INFO - 'SHLVL': '1', 02:13:10 INFO - 'TERM': 'linux', 02:13:10 INFO - 'TMOUT': '86400', 02:13:10 INFO - 'USER': 'cltbld', 02:13:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:10 INFO - '_': '/tools/buildbot/bin/python'} 02:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:12 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:12 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 02:13:12 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 02:13:12 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 02:13:12 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 02:13:12 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 02:13:12 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 02:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:13 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 02:13:13 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 02:13:13 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 02:13:13 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 02:13:13 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 02:13:13 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 02:13:13 INFO - Downloading docopt-0.6.1.tar.gz 02:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:13 INFO - Running setup.py install for blobuploader 02:13:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:13 INFO - Running setup.py install for requests 02:13:13 INFO - Running setup.py install for docopt 02:13:13 INFO - Successfully installed blobuploader requests docopt 02:13:13 INFO - Cleaning up... 02:13:13 INFO - Return code: 0 02:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:13 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')]} 02:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:13 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')]} 02:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:13 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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13:13 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 02:13:13 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 02:13:13 INFO - Using env: {'DISPLAY': ':0', 02:13:13 INFO - 'HOME': '/home/cltbld', 02:13:13 INFO - 'LANG': 'en_US.UTF-8', 02:13:13 INFO - 'LANGUAGE': 'en_US:en', 02:13:13 INFO - 'LOGNAME': 'cltbld', 02:13:13 INFO - 'MAIL': '/var/mail/cltbld', 02:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:13 INFO - 'MOZ_NO_REMOTE': '1', 02:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:13 INFO - 'NO_EM_RESTART': '1', 02:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:13 INFO - 'PWD': '/builds/slave/test', 02:13:13 INFO - 'SHELL': '/bin/bash', 02:13:13 INFO - 'SHLVL': '1', 02:13:13 INFO - 'TERM': 'linux', 02:13:13 INFO - 'TMOUT': '86400', 02:13:13 INFO - 'USER': 'cltbld', 02:13:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:13 INFO - '_': '/tools/buildbot/bin/python'} 02:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:14 INFO - Running setup.py (path:/tmp/pip-Ijm0D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:14 INFO - Running setup.py (path:/tmp/pip-qiaI70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:14 INFO - Running setup.py (path:/tmp/pip-6RawhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:14 INFO - Running setup.py (path:/tmp/pip-EQJfuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:14 INFO - Running setup.py (path:/tmp/pip-6MY0VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:14 INFO - Running setup.py (path:/tmp/pip-qTflqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:14 INFO - Running setup.py (path:/tmp/pip-d7BrcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:14 INFO - Running setup.py (path:/tmp/pip-4mihFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:14 INFO - Running setup.py (path:/tmp/pip-OHThyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:14 INFO - Running setup.py (path:/tmp/pip-hxoLya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:14 INFO - Running setup.py (path:/tmp/pip-B00sSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:14 INFO - Running setup.py (path:/tmp/pip-pzScOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:15 INFO - Running setup.py (path:/tmp/pip-X86Gpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:15 INFO - Running setup.py (path:/tmp/pip-JsiK57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:15 INFO - Running setup.py (path:/tmp/pip-65UKNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:15 INFO - Running setup.py (path:/tmp/pip-iG3gaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:15 INFO - Running setup.py (path:/tmp/pip-G14wcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:15 INFO - Running setup.py install for manifestparser 02:13:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:15 INFO - Running setup.py install for mozcrash 02:13:15 INFO - Running setup.py install for mozdebug 02:13:15 INFO - Running setup.py install for mozdevice 02:13:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:15 INFO - Running setup.py install for mozfile 02:13:15 INFO - Running setup.py install for mozhttpd 02:13:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozinfo 02:13:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozInstall 02:13:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozleak 02:13:16 INFO - Running setup.py install for mozlog 02:13:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for moznetwork 02:13:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozprocess 02:13:16 INFO - Running setup.py install for mozprofile 02:13:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozrunner 02:13:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:16 INFO - Running setup.py install for mozscreenshot 02:13:16 INFO - Running setup.py install for moztest 02:13:17 INFO - Running setup.py install for mozversion 02:13:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:17 INFO - Cleaning up... 02:13:17 INFO - Return code: 0 02:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:17 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')]} 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:17 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')]} 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:17 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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13:17 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 02:13:17 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 02:13:17 INFO - Using env: {'DISPLAY': ':0', 02:13:17 INFO - 'HOME': '/home/cltbld', 02:13:17 INFO - 'LANG': 'en_US.UTF-8', 02:13:17 INFO - 'LANGUAGE': 'en_US:en', 02:13:17 INFO - 'LOGNAME': 'cltbld', 02:13:17 INFO - 'MAIL': '/var/mail/cltbld', 02:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:17 INFO - 'MOZ_NO_REMOTE': '1', 02:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:17 INFO - 'NO_EM_RESTART': '1', 02:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:17 INFO - 'PWD': '/builds/slave/test', 02:13:17 INFO - 'SHELL': '/bin/bash', 02:13:17 INFO - 'SHLVL': '1', 02:13:17 INFO - 'TERM': 'linux', 02:13:17 INFO - 'TMOUT': '86400', 02:13:17 INFO - 'USER': 'cltbld', 02:13:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:17 INFO - '_': '/tools/buildbot/bin/python'} 02:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:17 INFO - Running setup.py (path:/tmp/pip-7Swehv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:17 INFO - Running setup.py (path:/tmp/pip-0wxCIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:17 INFO - Running setup.py (path:/tmp/pip-poNm_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:17 INFO - Running setup.py (path:/tmp/pip-_1_vTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:17 INFO - Running setup.py (path:/tmp/pip-yBsxFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:17 INFO - Running setup.py (path:/tmp/pip-LU6vzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:17 INFO - Running setup.py (path:/tmp/pip-ylDUMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:17 INFO - Running setup.py (path:/tmp/pip-LqYXf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:18 INFO - Running setup.py (path:/tmp/pip-FHDUoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:18 INFO - Running setup.py (path:/tmp/pip-xunF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:18 INFO - Running setup.py (path:/tmp/pip-oros4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:18 INFO - Running setup.py (path:/tmp/pip-_bdqhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:18 INFO - Running setup.py (path:/tmp/pip-Ji2FgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:18 INFO - Running setup.py (path:/tmp/pip-JqfL93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:18 INFO - Running setup.py (path:/tmp/pip-O1MmkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:18 INFO - Running setup.py (path:/tmp/pip-29EgFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:18 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)) 02:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:18 INFO - Running setup.py (path:/tmp/pip-zJ0AVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:18 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)) 02:13:18 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)) 02:13:18 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)) 02:13:18 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)) 02:13:18 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)) 02:13:18 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)) 02:13:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:18 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 02:13:18 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 02:13:18 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 02:13:18 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 02:13:18 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 02:13:18 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 02:13:20 INFO - Downloading blessings-1.6.tar.gz 02:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:20 INFO - Installing collected packages: blessings 02:13:20 INFO - Running setup.py install for blessings 02:13:20 INFO - Successfully installed blessings 02:13:20 INFO - Cleaning up... 02:13:20 INFO - Return code: 0 02:13:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:21 INFO - Reading from file tmpfile_stdout 02:13:21 INFO - Current package versions: 02:13:21 INFO - argparse == 1.2.1 02:13:21 INFO - blessings == 1.6 02:13:21 INFO - blobuploader == 1.2.4 02:13:21 INFO - docopt == 0.6.1 02:13:21 INFO - manifestparser == 1.1 02:13:21 INFO - mozInstall == 1.12 02:13:21 INFO - mozcrash == 0.17 02:13:21 INFO - mozdebug == 0.1 02:13:21 INFO - mozdevice == 0.48 02:13:21 INFO - mozfile == 1.2 02:13:21 INFO - mozhttpd == 0.7 02:13:21 INFO - mozinfo == 0.9 02:13:21 INFO - mozleak == 0.1 02:13:21 INFO - mozlog == 3.1 02:13:21 INFO - moznetwork == 0.27 02:13:21 INFO - mozprocess == 0.22 02:13:21 INFO - mozprofile == 0.28 02:13:21 INFO - mozrunner == 6.11 02:13:21 INFO - mozscreenshot == 0.1 02:13:21 INFO - mozsystemmonitor == 0.0 02:13:21 INFO - moztest == 0.7 02:13:21 INFO - mozversion == 1.4 02:13:21 INFO - psutil == 3.1.1 02:13:21 INFO - requests == 1.2.3 02:13:21 INFO - wsgiref == 0.1.2 02:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:21 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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13:21 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 02:13:21 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 02:13:21 INFO - Using env: {'DISPLAY': ':0', 02:13:21 INFO - 'HOME': '/home/cltbld', 02:13:21 INFO - 'LANG': 'en_US.UTF-8', 02:13:21 INFO - 'LANGUAGE': 'en_US:en', 02:13:21 INFO - 'LOGNAME': 'cltbld', 02:13:21 INFO - 'MAIL': '/var/mail/cltbld', 02:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:21 INFO - 'MOZ_NO_REMOTE': '1', 02:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:21 INFO - 'NO_EM_RESTART': '1', 02:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:21 INFO - 'PWD': '/builds/slave/test', 02:13:21 INFO - 'SHELL': '/bin/bash', 02:13:21 INFO - 'SHLVL': '1', 02:13:21 INFO - 'TERM': 'linux', 02:13:21 INFO - 'TMOUT': '86400', 02:13:21 INFO - 'USER': 'cltbld', 02:13:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:21 INFO - '_': '/tools/buildbot/bin/python'} 02:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 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)) 02:13:21 INFO - Cleaning up... 02:13:21 INFO - Return code: 0 02:13:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13: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', 'jsonschema'] in /builds/slave/test/build 02:13: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 jsonschema 02:13:21 INFO - Using env: {'DISPLAY': ':0', 02:13:21 INFO - 'HOME': '/home/cltbld', 02:13:21 INFO - 'LANG': 'en_US.UTF-8', 02:13:21 INFO - 'LANGUAGE': 'en_US:en', 02:13:21 INFO - 'LOGNAME': 'cltbld', 02:13:21 INFO - 'MAIL': '/var/mail/cltbld', 02:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:21 INFO - 'MOZ_NO_REMOTE': '1', 02:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:21 INFO - 'NO_EM_RESTART': '1', 02:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:21 INFO - 'PWD': '/builds/slave/test', 02:13:21 INFO - 'SHELL': '/bin/bash', 02:13:21 INFO - 'SHLVL': '1', 02:13:21 INFO - 'TERM': 'linux', 02:13:21 INFO - 'TMOUT': '86400', 02:13:21 INFO - 'USER': 'cltbld', 02:13:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:21 INFO - '_': '/tools/buildbot/bin/python'} 02:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:21 INFO - Downloading/unpacking jsonschema 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:23 INFO - Downloading/unpacking functools32 (from jsonschema) 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:23 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:23 INFO - warning: no files found matching '*.txt' 02:13:23 INFO - no previously-included directories found matching 'build' 02:13:23 INFO - no previously-included directories found matching 'dist' 02:13:23 INFO - no previously-included directories found matching '.git*' 02:13:23 INFO - Installing collected packages: jsonschema, functools32 02:13:23 INFO - Running setup.py install for functools32 02:13:23 INFO - warning: no files found matching '*.txt' 02:13:23 INFO - no previously-included directories found matching 'build' 02:13:23 INFO - no previously-included directories found matching 'dist' 02:13:23 INFO - no previously-included directories found matching '.git*' 02:13:23 INFO - Successfully installed jsonschema functools32 02:13:23 INFO - Cleaning up... 02:13:23 INFO - Return code: 0 02:13:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:13:23 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')]} 02:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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')]} 02:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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 0x7f943ac0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, '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': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', '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 02:13:23 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 02:13:23 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 02:13:23 INFO - Using env: {'DISPLAY': ':0', 02:13:23 INFO - 'HOME': '/home/cltbld', 02:13:23 INFO - 'LANG': 'en_US.UTF-8', 02:13:23 INFO - 'LANGUAGE': 'en_US:en', 02:13:23 INFO - 'LOGNAME': 'cltbld', 02:13:23 INFO - 'MAIL': '/var/mail/cltbld', 02:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:23 INFO - 'MOZ_NO_REMOTE': '1', 02:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:23 INFO - 'NO_EM_RESTART': '1', 02:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:23 INFO - 'PWD': '/builds/slave/test', 02:13:23 INFO - 'SHELL': '/bin/bash', 02:13:23 INFO - 'SHLVL': '1', 02:13:23 INFO - 'TERM': 'linux', 02:13:23 INFO - 'TMOUT': '86400', 02:13:23 INFO - 'USER': 'cltbld', 02:13:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:23 INFO - '_': '/tools/buildbot/bin/python'} 02:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:24 INFO - Downloading/unpacking flake8 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:13:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:25 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 02:13:25 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 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:13:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:13:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:26 INFO - no previously-included directories found matching 'docs/_build' 02:13:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:13:26 INFO - Running setup.py install for pep8 02:13:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:26 INFO - no previously-included directories found matching 'docs/_build' 02:13:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:13:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:13:26 INFO - Cleaning up... 02:13:26 INFO - Return code: 0 02:13:26 INFO - Running post-action listener: _resource_record_post_action 02:13:26 INFO - Running post-action listener: _start_resource_monitoring 02:13:26 INFO - Starting resource monitoring. 02:13:26 INFO - ##### 02:13:26 INFO - ##### Finished create-virtualenv step (success) 02:13:26 INFO - ##### 02:13:26 INFO - ##### 02:13:26 INFO - ##### Running install step. 02:13:26 INFO - ##### 02:13:26 INFO - Running pre-action listener: _resource_record_pre_action 02:13:26 INFO - Running main action method: install 02:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:27 INFO - Reading from file tmpfile_stdout 02:13:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:27 INFO - Reading from file tmpfile_stdout 02:13:27 INFO - Output received: 02:13:27 INFO - Usage: mozinstall [options] installer 02:13:27 INFO - Options: 02:13:27 INFO - -h, --help show this help message and exit 02:13:27 INFO - -d DEST, --destination=DEST 02:13:27 INFO - Directory to install application into. [default: 02:13:27 INFO - "/builds/slave/test"] 02:13:27 INFO - --app=APP Application being installed. [default: firefox] 02:13:27 INFO - mkdir: /builds/slave/test/build/application 02:13:27 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'] 02:13:27 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 02:13:43 INFO - Reading from file tmpfile_stdout 02:13:43 INFO - Output received: 02:13:43 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:43 INFO - Running post-action listener: _resource_record_post_action 02:13:43 INFO - ##### 02:13:43 INFO - ##### Finished install step (success) 02:13:43 INFO - ##### 02:13:43 INFO - ##### 02:13:43 INFO - ##### Running run-tests step. 02:13:43 INFO - ##### 02:13:43 INFO - Running pre-action listener: _resource_record_pre_action 02:13:43 INFO - Running main action method: run_tests 02:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:43 INFO - Python 2.7.3 02:13:43 INFO - Return code: 0 02:13:43 INFO - grabbing minidump binary from tooltool 02:13:43 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')]} 02:13:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a559c0>, '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 0x2a568c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:43 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 02:13:43 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 02:13:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:13:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:43 INFO - Return code: 0 02:13:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:13:44 INFO - Return code: 0 02:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 02:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 02:13:44 INFO - Using env: {'DISPLAY': ':0', 02:13:44 INFO - 'HOME': '/home/cltbld', 02:13:44 INFO - 'LANG': 'en_US.UTF-8', 02:13:44 INFO - 'LANGUAGE': 'en_US:en', 02:13:44 INFO - 'LOGNAME': 'cltbld', 02:13:44 INFO - 'MAIL': '/var/mail/cltbld', 02:13:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:44 INFO - 'MOZ_NO_REMOTE': '1', 02:13:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:44 INFO - 'NO_EM_RESTART': '1', 02:13:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:44 INFO - 'PWD': '/builds/slave/test', 02:13:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:44 INFO - 'SHELL': '/bin/bash', 02:13:44 INFO - 'SHLVL': '1', 02:13:44 INFO - 'TERM': 'linux', 02:13:44 INFO - 'TMOUT': '86400', 02:13:44 INFO - 'USER': 'cltbld', 02:13:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640', 02:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:44 INFO - '_': '/tools/buildbot/bin/python'} 02:13:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 02:13:44 INFO - mozversion application_buildid: 20160510233027 02:13:44 INFO - mozversion application_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 02:13:44 INFO - mozversion application_display_name: Nightly 02:13:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:44 INFO - mozversion application_name: Firefox 02:13:44 INFO - mozversion application_remotingname: firefox 02:13:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:13:44 INFO - mozversion application_vendor: Mozilla 02:13:44 INFO - mozversion application_version: 49.0a1 02:13:44 INFO - mozversion platform_buildid: 20160510233027 02:13:44 INFO - mozversion platform_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 02:13:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:13:44 INFO - mozversion platform_version: 49.0a1 02:13:44 INFO - using testdate: 1462958024 02:13:44 INFO - actual date: 1462958024 02:13:44 INFO - starting webserver on 'localhost:46168' 02:13:44 INFO - SUITE-START | Running 2 tests 02:13:44 INFO - TEST-START | dromaeo_css 02:13:44 INFO - operating with platform_type : linux_ 02:13:44 INFO - Initialising browser for dromaeo_css test... 02:13:44 INFO - TEST-INFO | started process 14371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyT9LUN/profile http://localhost:46168/getInfo.html) 02:13:48 INFO - PROCESS | 14371 | 02:13:48 INFO - PROCESS | 14371 | (process:14440): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:49 INFO - PROCESS | 14371 | __metrics Screen width/height:1600/1200 02:13:49 INFO - PROCESS | 14371 | colorDepth:24 02:13:49 INFO - PROCESS | 14371 | Browser inner width/height: 1024/697 02:13:49 INFO - PROCESS | 14371 | __metrics 02:13:50 ERROR - PROCESS | 14371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:13:51 INFO - TEST-INFO | 14371: exit 0 02:13:51 INFO - Browser initialized. 02:13:51 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:51 INFO - TEST-INFO | started process 14491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyT9LUN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:52 INFO - PROCESS | 14491 | 02:13:52 INFO - PROCESS | 14491 | (process:14553): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:14:02 INFO - PROCESS | 14491 | RSS: Main: 163209216 02:14:02 INFO - PROCESS | 14491 | 02:14:52 INFO - PROCESS | 14491 | 1462958092469 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] 02:17:00 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46168/tests/dromaeo/cssquery-ext.html) 02:17:01 INFO - PROCESS | 14491 | RSS: Main: 165437440 02:17:01 INFO - PROCESS | 14491 | 02:20:03 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-ext.html (next: http://localhost:46168/tests/dromaeo/cssquery-jquery.html) 02:20:04 INFO - PROCESS | 14491 | RSS: Main: 166932480 02:20:04 INFO - PROCESS | 14491 | 02:23:05 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46168/tests/dromaeo/cssquery-mootools.html) 02:23:06 INFO - PROCESS | 14491 | RSS: Main: 167682048 02:23:06 INFO - PROCESS | 14491 | 02:26:08 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46168/tests/dromaeo/cssquery-prototype.html) 02:26:08 INFO - PROCESS | 14491 | RSS: Main: 165560320 02:26:08 INFO - PROCESS | 14491 | 02:29:11 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46168/tests/dromaeo/cssquery-yui.html) 02:29:11 INFO - PROCESS | 14491 | RSS: Main: 166883328 02:29:11 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | Cycle 1(1): loaded http://localhost:46168/tests/dromaeo/cssquery-yui.html (next: http://localhost:46168/tests/dromaeo/cssquery-dojo.html) 02:32:14 INFO - PROCESS | 14491 | RSS: Main: 168648704 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | __start_tp_report 02:32:14 INFO - PROCESS | 14491 | _x_x_mozilla_page_load 02:32:14 INFO - PROCESS | 14491 | _x_x_mozilla_page_load_details 02:32:14 INFO - PROCESS | 14491 | |i|pagename|runs| 02:32:14 INFO - PROCESS | 14491 | |0;dojo.html;3133.8746450141994;3171.7145456908875;3188.091393952724;3190.3300306935544;3197.4404479216146;5352.946470535294;5370.060239458089;5379.246905433238;5508.504234618884;5544.417836127209;5247.317848679676;5404.594655400841;5495.395506494282;5522.392536820947;5565.638233514819;4871.5615594596475;4876.317315575822;4924.950750492503;4991.376077990251;5074.2895994560795;4882.584980276681;5027.1453852844925;5046.394432668085;5061.417936937262;5071.1632580624155;4942.654014219006;4962.305277261186;4978.22837460196;5026.597872170254;5055.039542486916;5038.2190760432195;5047.268146118829;5054.772535235887;5061.797528098871;5103;5027.120253955543;5040.722760248185;5046.318746969149;5059.266406371093;5060.266261392115;5166.044281807877;5341.065313570149;5347.064263753828;5419.295491586068;5435.782568697247;5893.292804863444;5894.882102357972;5897.852553686149;5901.144334071536;5917.940820591782;5699.316082070137;5928.644281343133;5930.169776231331;5933.8813223735715;5942.881142377171;5480.616356855022;5482.780688772445;5528.806491772769;5555.611107222496;5565.3599836018975;5991.850203744854;6023.969880150571;6033.0045542484995;6056.454919057306;6080.75676972925;5551.639143455663;5701.287339082614;5773.9895518284975;5776.653400795965;5808.912866307009;5760.971195144081;5847.181394604759;5854.326752423441;5862.794802181903;5908.231929849092;5653.434656534396;5729.770809167587;5798.9130163047585;5821.388754180834;5836.8540786479825;5714.599978001583;5751.194832723422;5813.186153938452;5848.88302233953;5858.941410585925;4324.17840610283;4398.5821346972625;4425.535318791545;4441.622462090694;4472.373867658465;3956.5449973252867;3958.148997965451;3959.544652364957;3997;4014.3175660137845;5439.646422982572;5596.608237423423;5608.803691870765;5623.903338848885;5646.661200327993;5859.941400586024;5869.972754767984;5875.676837773878;5891.351951285355;5940.079287710412;5590.748416321276;5639.154126880919;5639.210510528529;5651.773929042874;5661.631993920382;4825.758712064383;4999.77501012448;5000.724960127228;5029.597632189416;5040.79836806531;6047.183630209954;6131.957816600026;6135.662538560422;6161.537884658668;6166.445019948136;5921.407859214217;5969.313528944227;5973.850653733692;5984.910226346696;5985.25184351956;5799.681017543907;6027.427394397525;6038.728257228523;6159.907601385893;6172.074188871526;5800.8259752207505;5802.1296805479515;5805.535557155502;5829.883402332014;5832.766689332549;5939;5976.133460648269;5991.310999234969;5992.580519363602;6006.579539432198;5561.499465048165;5677.1768093627015;5714.828555143353;5749.626274292157;5755.7697692093525;5537.335519737496;5677.460641239076;5677.914831277451;5724.942750572441;5729.598928075162;5636.802711905064;5645.633033852787;5656.462636049569;5657.858553536194;5662.490375866192;5489.752961116839;5662.433756624305;5670.432956704297;5735.76681013584;5788.421157884178;5555.472230138131;5605.271314729059;5615.494605485526;5617.915731264116;5653.745581448762 02:32:14 INFO - PROCESS | 14491 | |1;ext.html;590.1737567405631;638.7221558622002;653.4151934019053;672.3108813466197;681.9420349270312;38223.235535289314;42627.36058959114;42916.14167716644;43053.78473107634;43187.35218971718;43109.13781724364;43207.78396108015;43300.566994330045;43566;43660;8759.956200219005;8889.822203555925;8918.286537077018;8975.057618950013;8982.05688402718;8873.467591944504;8898.243649289818;8915.910840891573;8938.821223575525;8972.461652300883;8849.646014159458;8927.55362231889;8935.865962010575;8941.418807777474;8946.507942063185;8817.911820881773;8863.335249856254;8936.151065648786;8942.64229430822;8958.148975847349;8748.737537873874;8777.605007774602;8829.955850220707;8833.55832208387;8838.779030524223;34339.313213735586;34688.306233875184;34909.650903490896;34994.82502587471;35002.64997350019;3453.7582369234165;3487.930241395183;3584.9283014339567;3677.4667673187505;3712.3132220539287;31186.532202016988;31714.36571268585;31950;32088.197795055075;32697.673023269937;4211.4525111735275;4277.508086570022;4282.100758840647;4286.507051689065;4354.194474022316;277044;278226;279137;280495;281835;36130.8193459031;36328;36606.267874642355;36658.08354791098;36668.083297917765;36793;37667.246655066745;37811;39288;39542;16343;16467.917660411862;16492.25784839685;16537.503874883772;16538.421155259748;12657.430415631134;12672.556460523838;12697.238165710087;12709.046821488426;12727.936360318325;20258;20378.79621203769;20670.586588268452;20701.58596828055;20782.1687132516;7354.2645735427095;7386.187519372865;7581.241875812375;7588.734394296173;7688.46180767341;943.6555657185215;993.7664648807524;1041.345187014046;1179.5399794080315;1194.0805579703579;30850.382992340026;31867;31939.361212775613;32044.96008008749;32340;1126.6845283320683;1147.701597584634;1177.128924595793;1200.8198770184542;1240.2558464920976;16363.59091022734;16783.741219408592;16986.235619397157;17066.23201955915;17066.317347306216;486819;492144;493284;494433;496038;58401;58505.41494585085;58566.12150817741;59035.704821475614;59065;1424.7435461616801;1432.6991331820434;1454.5999850041323;1456.4975083596141;1472.0725942656059;29762.404751905273;30535;30555.54166687546;31212.687873120976;31430.214244644067;49381.25928111009;49705;49869;49890;49924;439872;443226;444151;444960;449933;28857.56713649255;29029.12912612625;29464.852675736485;29751.404971900007;29792.10623681293;48610;48880.2667959988;49362.50637493723;49688.503114968385;50487;41379.379309309785;41698.1660366797;42810.785946071315;43024.139517210104;43030;40636.18727625372;41594.79202603968;41964.58035419607;41979.58020419757;42180.78909605555;42235.3664695036;42779.14441711086;43030.13939721126;43435.56564434442;43454.34818477662;35980;37091.629083708816;37279.81360093291;37939;38038;28609.713902860705;28827.279318017216;29091.854540728007;29298.267543311587;29325.26686832846 02:32:14 INFO - PROCESS | 14491 | |2;jquery.html;402.8428912724038;405.3919121318023;409.2592407741987;414.2605449273048;419.07802833765726;13938.303084845742;17612.82387176128;18942.86342819432;19526.511837204078;19533.511662208468;18620.348287809928;18629.347972820953;19008.714869276937;19532.31636892709;19549.609007819836;5549.694766787825;5604.187392828037;5765.971170144144;5807.128930660392;5811.244538210027;5697.6011679182475;5740.311162660487;5753.108268218432;5774.105013722879;5795.420457954192;5551.72241387931;5649.519790817785;5771;5773.682447465388;5784.623999440044;5714.999126070572;5766.4233576642;5767.221425107619;5769.221155144065;5787.074068149097;5074.619403544749;5176.352955880515;5180.818671346522;5185.222216667492;5204.167333226704;22595.435114122112;22804.771952280596;22835.31494055181;23344.416389590227;23390.64914026291;2376.7742064503846;2385.61830107182;2399.700037495313;2668.3329167708075;2769.5014897318474;14810.407583696639;14944.775828362583;14982.250887455693;15205.239738013055;15371.923140384339;1932.4589115047809;1960.3824795189469;2027.7465316835396;2074.8588276447895;2081.5004398944143;71661.28338716598;71846;79749;80844;82145.58927205385;10541.947290263499;10873.184511161695;10923.781524369468;10958;10983.670489885317;14910.179940103399;14966;15022.399104035716;15066.171360575054;15072.472463463726;8012.759617211493;8109.47237951493;8169.673213071529;8221.095679475253;8323.95838020806;7976.401769867283;8020.238077382639;8033.55815430157;8110.270075693216;8131.878021829677;6526.771562995273;6616.4045235929;6636.469082473487;6661.566998145202;6768.390844823989;1883.9246430142641;1931.1020375525447;1952.9707054393912;1958.089488387878;1961.4311849563753;967.2068903499204;974.91713204377;1070.0690399352457;1127.1658972360394;1154.2670404293167;19476.22095116208;19614.70577941332;19737.210511579662;19909.900450497946;19984.400467985983;1064.2390690656218;1065.9626913058005;1081.6809041332826;1081.9945900270607;1115.1691989467736;11211.159163062639;11355.886441135648;11550.653480395602;11562.88437115635;11570.652880413601;494873;495863;514478;516778;520894;50947;84295.15704842996;86377.13622863691;87237;87715.12284877198;1079.0450451350455;1096.923215374932;1147.4778975566264;1182.7575347053833;1186.8397766301612;18039.5490112743;18146.72779908276;18194.272229110687;18396;18488.537786555444;26143.477130457664;32653.836730817144;37927.43108853314;40032.39951400673;40080;51279.20910725015;51531.74234128805;51764.22353664623;52082.47917520928;52423.47576524186;5834.358220595816;7143.606996635606;7368.336849683555;7543.0948286206;8170.937778088811;13951.720965580835;13961.860381396056;14081;14082.507112251022;14284.57146285613;12017.819732703842;12042.819357709466;12205.511779528719;12291.938540307241;12312.630621081382;11825.408729563316;11831.52673893069;11931.940340298243;12323.383830808603;12415.813762793747;12256.28128190436;12404.56584019555;12507.695668579856;12638.178518396275;12700.936495317465;8743.431676940978;8833;8949.418287811272;9055.551111822077;9169.220616247694;12307.692307692021;12383.19509231897;12505.187162834387;12525.56160534377;12537.87462125367 02:32:14 INFO - PROCESS | 14491 | |3;mootools.html;1409.3164815064695;1500.5948393933638;1613.8708903287732;1827.0590645817406;1876.6903460928947;7535.284148005931;8536.274416674582;8659.523726195057;9029.322800789942;9098;8681;8938.284937205024;8945.373823832335;8986.820263594724;9018.72943811685;2338.614128668772;2366.656834758959;2369.8815059247054;2370.419247284418;2374.8693821839793;2262.502249505106;2268.7731226877263;2292.2435596253194;2299.41364951937;2324.744278129413;2290.1640901071155;2302.9884850575722;2315.3748487908256;2377.037299893546;2380.559596474649;2325.3256555598855;2344.718633763959;2355.081518207892;2357.3399448154546;2401.0515846240637;2320.5706944215203;2343.6718859359703;2343.7070366204225;2351.165336305604;2358.033206385374;8903.866442003375;8968.910310896938;8987.146221108984;9052.27581793455;9060.229880460169;5346.652467589594;5374.301340825707;5408.702521361323;5458.099413596752;5562.694051827148;3578.8926332210076;3579.391503444421;3658.5609726832686;3667.2848794485085;3736.4955730976244;1177.3289225141673;1179.598936361641;1181.6100686773343;1206.7465832175253;1227.4415141110862;12598.433070511941;12656.81014784779;12701.745965080647;12720.300383478905;12724.681882953;4780.47024952019;4800.831970881002;4842.903141937141;4873.902521949542;4900.142475066849;10643.946780266204;10654.73363165927;10675.092617127475;10676.572937082585;10702.732431689114;5366.946330536644;5378.435264297271;5383.892322153613;5404.972975135178;5411.945880541144;4190.8533201337805;4800.903981920412;4929;4937.530934561211;4950.801967921315;3968.4840970674204;3984.1633257015774;4049.7570145791346;4091.7954102294766;4118.155778065489;1304.8434187897324;1312.6521471809979;1321.5572783117764;1335.5659410691565;1340.5844188301462;971.7910649210312;1003.8343673293824;1015.9695209143738;1022.2792930983638;1035.2856528994969;5956.55325850563;6058.878822423527;6108.144859719643;6178.691065446799;6209.441150296495;437.81830540326047;446.68731887678103;453.3154936046528;458.08840407589327;462.7408651155364;4184.958150418518;4196.832126714898;4251.766152861561;4258.701890867609;4262.893427664271;10243.231757618209;10534.841977370346;10681.465926703633;10691.358518488916;10719.946400267949;10347.017033381817;10417.270791044553;10470.162387009173;10529.315594486334;10539.683809485728;7796.688132474637;7918.445708800444;8003.399745019147;8057.959710201529;8169.550674712829;6168.907466387918;6355.841103972438;6376.330485298977;6384.201974753156;6496.7726129585235;9835.655752048644;10112.292139550162;10325.535350909076;10338.224633152695;10372.896271037192;10323.63867264642;10420.843687344544;10564.313319634199;10577.048065674126;10657.626983055556;7036.401905837856;7728.574928378768;7925.207479252029;8001.279884810162;8083;8351.20663536963;8379.95810020946;8412.579371031547;8469.195426434479;8477.703280385156;7770.261825126604;7968.960155199187;8005.319547838499;8013.318867896294;8029.839403211786;7422.480426370318;7700.268474494914;7819.413543984338;7888.290053895177;7971.800704982422;6992.26581208986;7143.8571228576175;7215.927840721525;7232.349088582053;7250.383717384081;5083.38999320084;5133.743312834269;5183.403908550565;5219.791208351775;5235.214717792362;5136.280920671184;5157.510036546522;5220.5382492902045;5236;5318.042752304622 02:32:14 INFO - PROCESS | 14491 | |4;prototype.html;332.9600447946247;335.47665641599104;336.6582918337887;340.63211731330165;340.9181796368869;5677.630953987988;5680.807030523585;5716.914246286304;5719.799807006755;5729.255196824407;5618.494335509803;5620.662760234389;5627.7467513961865;5649.604527683064;5660.660360378381;4071.7149799514045;4198.8110535026;4249.893752656178;4319.719218250803;4338.739675619458;4267.231898258312;4296.849610263642;4321.58944900234;4334.436523251973;4375.956240437603;4310.655147588185;4346.913061738764;4360.36774667673;4361.978190109045;4362.411074504948;4087.6525495332785;4322.438083049215;4325.113351762881;4332.718373305725;4336.262835318003;3850.7304488685804;3853.84584616615;3863.8261278242267;3876.7013050628075;3902.824372903226;5367.2485851980755;5430.56555475565;5447.918281225785;5472.2338872557875;5499.340079190482;4916.680415772963;4984.675996060245;4995.700257984497;5030.773615187289;5079.644424890259;5837.052288594233;5837.474627283523;5864.211415518265;5895.793647222326;5898.691177939845;4278.315469524861;4279.828806847722;4292.527821939584;4299.50555686097;4318.870433886988;5857.6778277194735;6118.877622447526;6129.662868542228;6141.477974372184;6167.537434692371;4269.530351661315;4279.422277992493;4301.763403012865;4320.4167437395545;4332.133573285356;4342.196693611692;4349.304111342233;4366.672499562545;4373.300271956472;4376.562343765598;4730.9763451182525;4995.775190116454;4998.550130488274;4999.675086102113;5001.7499125043605;5808.970955145197;5828.300603927556;5853.970730146322;5881.73553182028;5927.2590926134235;1530.7933428986944;1549.4809238904868;1550.6511035017256;1556.7353549896545;1561.188182145278;971.9805603887883;1010.242318261304;1035.632350515556;1053.4048262731533;1056.313396292416;5630.915536266959;5709.600327977085;5714.514266287329;5746.2761171648335;5794.797182098607;6024.457798798129;6045.818625441244;6051.788187413419;6056.485198758067;6081.908771368433;5488.4237155098135;5682.090865461506;5798.75326804739;5834.27071616048;5865.507159457299;3230.596175478065;3254.6582608826207;3268.313654132611;3289.967100329014;3290.967090329066;6179.16581261533;6327.683615819191;6330.164252366762;6349.9682501587195;6357.523185761086;6245.751529449394;6250.218722659668;6264.2796078451565;6281.654509001957;6316.557840951089;6151.815445536551;6237.688115594202;6344.555881088372;6416.454601358843;6446.871062578723;6053.515718742578;6094.299155597163;6116.969415152896;6151.9384806151365;6161.815145545641;6006.729697163725;6095;6107.434877351612;6109.297430795337;6112.205413296243;6023.337432882292;6333.145025421509;6363.904541431974;6378.107065010995;6384.553081284265;4219.789010549522;4235.195312890541;4236.152769446061;4236.851710190129;4258.95741042598;5848.795292164924;6156.753729850756;6201.844953876189;6222.471089957405;6235.844103897439;5846.327672317738;5862;5871.882562348644;5918.763249469973;5936.821895343147;5953.970230148821;5971.313298970674;5986.431289027535;6043.184170137151;6076.635401875901;5547.861303467445;5817.563682723898;5855.443732845373;5868.23712917318;5912;5931.525477961666;5969.791057312973;5993.790217342372;6035.728392222449;6037.003894357557;5760.567957403296;5819.185314056121;5902.2622172228475;5902.822915312548;5923.348431672599 02:32:14 INFO - PROCESS | 14491 | |5;yui.html;844.9408541402103;874.7506960516246;875.221053262596;882.3073886998703;886.6896586194832;13133.605991820248;13877.028607997432;13972.231527266022;14006.369713362898;14397.424103035892;14123.293835308219;14856.108633482;15017.924910375461;15034.924825375885;15045.699086018272;697.88136016877;834.3575446905879;837.4514692876161;845.974620761375;849.0829903703985;829.2950991657074;829.8713699376576;836.0302049622439;844.7170197983683;853.4879072556479;897.8832751742297;899.5052721003455;901.0944001278706;901.8286525560155;901.9639214431447;889.9822003559925;890.6170346750895;890.7238755985601;892.9598168082387;895.7536677413731;657.5594351784316;658.8319978405524;659.044385640818;659.3373659472247;660.3990368764449;14501.129932204101;14901.92549037248;14984.850151498455;15024.323905424282;15043.473478428203;14624.853751462562;14808.185549794756;14813.925930370388;14819.555413337617;14960.62598435037;11390.886091139148;11487.195896287263;11544.134189935789;11552.884471155265;11701.122415818763;3860.208657225262;3871.457995880579;3975.2447035063246;3998.3802510610903;4042.686127008734;58552.70723646397;59032.704836475976;59740.70129649324;60009.39990600082;60289.39710602838;11637.185397022127;11665.358405287621;11784.88215117855;12050.096242781827;12109.757804843854;21578;21591.56816863654;21619.35141945744;21621.459463513536;21635.891820540797;8684.609192586222;8772.95613521941;8944.463332200088;9070.501122438329;9164.312676549285;4767.928481072787;4825.227963525819;4858.6356023298395;4882.340883980688;4888.804447822118;3487.773294735834;3577.2130131371055;3583.4624806278744;3588.6411358864425;3592.76647017943;594.8156071617726;651.9511036672174;655.9212894452601;659.7921654678761;662.7282814046218;610.7251736718495;683.7094234950126;766.1878408886598;769.6690423118113;777.1606664802;9246.352755307063;9293.767655808659;9338.719838404859;9450.85823712645;9590.808183836285;671.5567725301278;720.6216736213426;730.4375630764282;783.5768684910084;800.095891642452;4537.410136682276;4565.817367305337;4589.954100459019;4610.2623580227;4612.630989520831;67306.32693673098;68551.3144868555;69750.65124674344;71278.29773618098;71399.64300178569;62235.688821556505;62574;62610.68694656497;63817.361826381144;64232.67883660552;55998.72000639971;56240.43759562434;56356.718216408655;56621.71689141528;57711;8615.353848461265;8646.270745850728;8802.25180859634;8868.290536757173;8921.197092261467;29837.403251934407;30562.694373055983;31391.37217255688;32592.511112333807;32925.17687057843;46594.534054659016;46661.30008049814;46859.76570117127;46871.76564117157;47191.76404117957;12747.936260318638;12908.354582271037;12921.612351629467;13009.934950325187;13085.869141308845;13652.180869147485;14268;14461.349239284047;14644.13926152811;14656.193909334663;13278.402471888981;13734.519291825138;13906.58280251594;13908.304584770924;14453.205073721047;13219.867801322249;13374.398152082986;13508.864911351155;13514.189148651112;13764.17414955106;13332.866671333162;13390.799138012742;13401;13499.797503037658;13992.860071399156;11238.325700458;11258.38078905668;11451.427428628702;11629.418529073344;12007.519699211934;11543.422828858356;11602.303861768321;11636.36000020007;11842.171048026556;11941.104417168921 02:32:14 INFO - PROCESS | 14491 | __end_tp_report 02:32:14 INFO - PROCESS | 14491 | __start_cc_report 02:32:14 INFO - PROCESS | 14491 | _x_x_mozilla_cycle_collect,313 02:32:14 INFO - PROCESS | 14491 | __end_cc_report 02:32:14 INFO - PROCESS | 14491 | __startTimestamp1462959134498__endTimestamp 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | ------- Summary: start ------- 02:32:14 INFO - PROCESS | 14491 | Number of tests: 6 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#0] dojo.html Cycles:165 Average:5443.73 Median:5646.66 stddev:626.94 (11.1%) stddev-sans-first:602.11 02:32:14 INFO - PROCESS | 14491 | Values: 3133.9 3171.7 3188.1 3190.3 3197.4 5352.9 5370.1 5379.2 5508.5 5544.4 5247.3 5404.6 5495.4 5522.4 5565.6 4871.6 4876.3 4925.0 4991.4 5074.3 4882.6 5027.1 5046.4 5061.4 5071.2 4942.7 4962.3 4978.2 5026.6 5055.0 5038.2 5047.3 5054.8 5061.8 5103.0 5027.1 5040.7 5046.3 5059.3 5060.3 5166.0 5341.1 5347.1 5419.3 5435.8 5893.3 5894.9 5897.9 5901.1 5917.9 5699.3 5928.6 5930.2 5933.9 5942.9 5480.6 5482.8 5528.8 5555.6 5565.4 5991.9 6024.0 6033.0 6056.5 6080.8 5551.6 5701.3 5774.0 5776.7 5808.9 5761.0 5847.2 5854.3 5862.8 5908.2 5653.4 5729.8 5798.9 5821.4 5836.9 5714.6 5751.2 5813.2 5848.9 5858.9 4324.2 4398.6 4425.5 4441.6 4472.4 3956.5 3958.1 3959.5 3997.0 4014.3 5439.6 5596.6 5608.8 5623.9 5646.7 5859.9 5870.0 5875.7 5891.4 5940.1 5590.7 5639.2 5639.2 5651.8 5661.6 4825.8 4999.8 5000.7 5029.6 5040.8 6047.2 6132.0 6135.7 6161.5 6166.4 5921.4 5969.3 5973.9 5984.9 5985.3 5799.7 6027.4 6038.7 6159.9 6172.1 5800.8 5802.1 5805.5 5829.9 5832.8 5939.0 5976.1 5991.3 5992.6 6006.6 5561.5 5677.2 5714.8 5749.6 5755.8 5537.3 5677.5 5677.9 5724.9 5729.6 5636.8 5645.6 5656.5 5657.9 5662.5 5489.8 5662.4 5670.4 5735.8 5788.4 5555.5 5605.3 5615.5 5617.9 5653.7 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#1] ext.html Cycles:180 Average:56026.95 Median:41487.09 stddev:110137.60 (265.5%) stddev-sans-first:110367.92 02:32:14 INFO - PROCESS | 14491 | Values: 590.2 638.7 653.4 672.3 681.9 38223.2 42627.4 42916.1 43053.8 43187.4 43109.1 43207.8 43300.6 43566.0 43660.0 8760.0 8889.8 8918.3 8975.1 8982.1 8873.5 8898.2 8915.9 8938.8 8972.5 8849.6 8927.6 8935.9 8941.4 8946.5 8817.9 8863.3 8936.2 8942.6 8958.1 8748.7 8777.6 8830.0 8833.6 8838.8 34339.3 34688.3 34909.7 34994.8 35002.6 3453.8 3487.9 3584.9 3677.5 3712.3 31186.5 31714.4 31950.0 32088.2 32697.7 4211.5 4277.5 4282.1 4286.5 4354.2 277044.0 278226.0 279137.0 280495.0 281835.0 36130.8 36328.0 36606.3 36658.1 36668.1 36793.0 37667.2 37811.0 39288.0 39542.0 16343.0 16467.9 16492.3 16537.5 16538.4 12657.4 12672.6 12697.2 12709.0 12727.9 20258.0 20378.8 20670.6 20701.6 20782.2 7354.3 7386.2 7581.2 7588.7 7688.5 943.7 993.8 1041.3 1179.5 1194.1 30850.4 31867.0 31939.4 32045.0 32340.0 1126.7 1147.7 1177.1 1200.8 1240.3 16363.6 16783.7 16986.2 17066.2 17066.3 486819.0 492144.0 493284.0 494433.0 496038.0 58401.0 58505.4 58566.1 59035.7 59065.0 1424.7 1432.7 1454.6 1456.5 1472.1 29762.4 30535.0 30555.5 31212.7 31430.2 49381.3 49705.0 49869.0 49890.0 49924.0 439872.0 443226.0 444151.0 444960.0 449933.0 28857.6 29029.1 29464.9 29751.4 29792.1 48610.0 48880.3 49362.5 49688.5 50487.0 41379.4 41698.2 42810.8 43024.1 43030.0 40636.2 41594.8 41964.6 41979.6 42180.8 42235.4 42779.1 43030.1 43435.6 43454.3 35980.0 37091.6 37279.8 37939.0 38038.0 28609.7 28827.3 29091.9 29298.3 29325.3 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#2] jquery.html Cycles:180 Average:28978.23 Median:23089.87 stddev:83384.53 (361.1%) stddev-sans-first:83590.84 02:32:14 INFO - PROCESS | 14491 | Values: 402.8 405.4 409.3 414.3 419.1 13938.3 17612.8 18942.9 19526.5 19533.5 18620.3 18629.3 19008.7 19532.3 19549.6 5549.7 5604.2 5766.0 5807.1 5811.2 5697.6 5740.3 5753.1 5774.1 5795.4 5551.7 5649.5 5771.0 5773.7 5784.6 5715.0 5766.4 5767.2 5769.2 5787.1 5074.6 5176.4 5180.8 5185.2 5204.2 22595.4 22804.8 22835.3 23344.4 23390.6 2376.8 2385.6 2399.7 2668.3 2769.5 14810.4 14944.8 14982.3 15205.2 15371.9 1932.5 1960.4 2027.7 2074.9 2081.5 71661.3 71846.0 79749.0 80844.0 82145.6 10541.9 10873.2 10923.8 10958.0 10983.7 14910.2 14966.0 15022.4 15066.2 15072.5 8012.8 8109.5 8169.7 8221.1 8324.0 7976.4 8020.2 8033.6 8110.3 8131.9 6526.8 6616.4 6636.5 6661.6 6768.4 1883.9 1931.1 1953.0 1958.1 1961.4 967.2 974.9 1070.1 1127.2 1154.3 19476.2 19614.7 19737.2 19909.9 19984.4 1064.2 1066.0 1081.7 1082.0 1115.2 11211.2 11355.9 11550.7 11562.9 11570.7 494873.0 495863.0 514478.0 516778.0 520894.0 50947.0 84295.2 86377.1 87237.0 87715.1 1079.0 1096.9 1147.5 1182.8 1186.8 18039.5 18146.7 18194.3 18396.0 18488.5 26143.5 32653.8 37927.4 40032.4 40080.0 51279.2 51531.7 51764.2 52082.5 52423.5 5834.4 7143.6 7368.3 7543.1 8170.9 13951.7 13961.9 14081.0 14082.5 14284.6 12017.8 12042.8 12205.5 12291.9 12312.6 11825.4 11831.5 11931.9 12323.4 12415.8 12256.3 12404.6 12507.7 12638.2 12700.9 8743.4 8833.0 8949.4 9055.6 9169.2 12307.7 12383.2 12505.2 12525.6 12537.9 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#3] mootools.html Cycles:180 Average:5864.24 Median:450.00 stddev:3320.91 (738.0%) stddev-sans-first:3313.35 02:32:14 INFO - PROCESS | 14491 | Values: 1409.3 1500.6 1613.9 1827.1 1876.7 7535.3 8536.3 8659.5 9029.3 9098.0 8681.0 8938.3 8945.4 8986.8 9018.7 2338.6 2366.7 2369.9 2370.4 2374.9 2262.5 2268.8 2292.2 2299.4 2324.7 2290.2 2303.0 2315.4 2377.0 2380.6 2325.3 2344.7 2355.1 2357.3 2401.1 2320.6 2343.7 2343.7 2351.2 2358.0 8903.9 8968.9 8987.1 9052.3 9060.2 5346.7 5374.3 5408.7 5458.1 5562.7 3578.9 3579.4 3658.6 3667.3 3736.5 1177.3 1179.6 1181.6 1206.7 1227.4 12598.4 12656.8 12701.7 12720.3 12724.7 4780.5 4800.8 4842.9 4873.9 4900.1 10643.9 10654.7 10675.1 10676.6 10702.7 5366.9 5378.4 5383.9 5405.0 5411.9 4190.9 4800.9 4929.0 4937.5 4950.8 3968.5 3984.2 4049.8 4091.8 4118.2 1304.8 1312.7 1321.6 1335.6 1340.6 971.8 1003.8 1016.0 1022.3 1035.3 5956.6 6058.9 6108.1 6178.7 6209.4 437.8 446.7 453.3 458.1 462.7 4185.0 4196.8 4251.8 4258.7 4262.9 10243.2 10534.8 10681.5 10691.4 10719.9 10347.0 10417.3 10470.2 10529.3 10539.7 7796.7 7918.4 8003.4 8058.0 8169.6 6168.9 6355.8 6376.3 6384.2 6496.8 9835.7 10112.3 10325.5 10338.2 10372.9 10323.6 10420.8 10564.3 10577.0 10657.6 7036.4 7728.6 7925.2 8001.3 8083.0 8351.2 8380.0 8412.6 8469.2 8477.7 7770.3 7969.0 8005.3 8013.3 8029.8 7422.5 7700.3 7819.4 7888.3 7971.8 6992.3 7143.9 7215.9 7232.3 7250.4 5083.4 5133.7 5183.4 5219.8 5235.2 5136.3 5157.5 5220.5 5236.0 5318.0 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#4] prototype.html Cycles:180 Average:4987.58 Median:5712.06 stddev:1479.89 (25.9%) stddev-sans-first:1442.21 02:32:14 INFO - PROCESS | 14491 | Values: 333.0 335.5 336.7 340.6 340.9 5677.6 5680.8 5716.9 5719.8 5729.3 5618.5 5620.7 5627.7 5649.6 5660.7 4071.7 4198.8 4249.9 4319.7 4338.7 4267.2 4296.8 4321.6 4334.4 4376.0 4310.7 4346.9 4360.4 4362.0 4362.4 4087.7 4322.4 4325.1 4332.7 4336.3 3850.7 3853.8 3863.8 3876.7 3902.8 5367.2 5430.6 5447.9 5472.2 5499.3 4916.7 4984.7 4995.7 5030.8 5079.6 5837.1 5837.5 5864.2 5895.8 5898.7 4278.3 4279.8 4292.5 4299.5 4318.9 5857.7 6118.9 6129.7 6141.5 6167.5 4269.5 4279.4 4301.8 4320.4 4332.1 4342.2 4349.3 4366.7 4373.3 4376.6 4731.0 4995.8 4998.6 4999.7 5001.7 5809.0 5828.3 5854.0 5881.7 5927.3 1530.8 1549.5 1550.7 1556.7 1561.2 972.0 1010.2 1035.6 1053.4 1056.3 5630.9 5709.6 5714.5 5746.3 5794.8 6024.5 6045.8 6051.8 6056.5 6081.9 5488.4 5682.1 5798.8 5834.3 5865.5 3230.6 3254.7 3268.3 3290.0 3291.0 6179.2 6327.7 6330.2 6350.0 6357.5 6245.8 6250.2 6264.3 6281.7 6316.6 6151.8 6237.7 6344.6 6416.5 6446.9 6053.5 6094.3 6117.0 6151.9 6161.8 6006.7 6095.0 6107.4 6109.3 6112.2 6023.3 6333.1 6363.9 6378.1 6384.6 4219.8 4235.2 4236.2 4236.9 4259.0 5848.8 6156.8 6201.8 6222.5 6235.8 5846.3 5862.0 5871.9 5918.8 5936.8 5954.0 5971.3 5986.4 6043.2 6076.6 5547.9 5817.6 5855.4 5868.2 5912.0 5931.5 5969.8 5993.8 6035.7 6037.0 5760.6 5819.2 5902.3 5902.8 5923.3 02:32:14 INFO - PROCESS | 14491 | 02:32:14 INFO - PROCESS | 14491 | [#5] yui.html Cycles:180 Average:15916.93 Median:46627.92 stddev:18881.47 (40.5%) stddev-sans-first:18900.51 02:32:14 INFO - PROCESS | 14491 | Values: 844.9 874.8 875.2 882.3 886.7 13133.6 13877.0 13972.2 14006.4 14397.4 14123.3 14856.1 15017.9 15034.9 15045.7 697.9 834.4 837.5 846.0 849.1 829.3 829.9 836.0 844.7 853.5 897.9 899.5 901.1 901.8 902.0 890.0 890.6 890.7 893.0 895.8 657.6 658.8 659.0 659.3 660.4 14501.1 14901.9 14984.9 15024.3 15043.5 14624.9 14808.2 14813.9 14819.6 14960.6 11390.9 11487.2 11544.1 11552.9 11701.1 3860.2 3871.5 3975.2 3998.4 4042.7 58552.7 59032.7 59740.7 60009.4 60289.4 11637.2 11665.4 11784.9 12050.1 12109.8 21578.0 21591.6 21619.4 21621.5 21635.9 8684.6 8773.0 8944.5 9070.5 9164.3 4767.9 4825.2 4858.6 4882.3 4888.8 3487.8 3577.2 3583.5 3588.6 3592.8 594.8 652.0 655.9 659.8 662.7 610.7 683.7 766.2 769.7 777.2 9246.4 9293.8 9338.7 9450.9 9590.8 671.6 720.6 730.4 783.6 800.1 4537.4 4565.8 4590.0 4610.3 4612.6 67306.3 68551.3 69750.7 71278.3 71399.6 62235.7 62574.0 62610.7 63817.4 64232.7 55998.7 56240.4 56356.7 56621.7 57711.0 8615.4 8646.3 8802.3 8868.3 8921.2 29837.4 30562.7 31391.4 32592.5 32925.2 46594.5 46661.3 46859.8 46871.8 47191.8 12747.9 12908.4 12921.6 13009.9 13085.9 13652.2 14268.0 14461.3 14644.1 14656.2 13278.4 13734.5 13906.6 13908.3 14453.2 13219.9 13374.4 13508.9 13514.2 13764.2 13332.9 13390.8 13401.0 13499.8 13992.9 11238.3 11258.4 11451.4 11629.4 12007.5 11543.4 11602.3 11636.4 11842.2 11941.1 02:32:14 INFO - PROCESS | 14491 | -------- Summary: end -------- 02:32:14 INFO - PROCESS | 14491 | 02:32:15 INFO - TEST-INFO | 14491: exit 0 02:32:15 INFO - TEST-OK | dromaeo_css | took 1110173ms 02:32:15 INFO - TEST-START | kraken 02:32:15 INFO - operating with platform_type : linux_ 02:32:15 INFO - Initialising browser for kraken test... 02:32:15 INFO - TEST-INFO | started process 14720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps564V4/profile http://localhost:46168/getInfo.html) 02:32:18 INFO - PROCESS | 14720 | 02:32:18 INFO - PROCESS | 14720 | (process:14791): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:32:19 INFO - PROCESS | 14720 | __metrics Screen width/height:1600/1200 02:32:19 INFO - PROCESS | 14720 | colorDepth:24 02:32:19 INFO - PROCESS | 14720 | Browser inner width/height: 1024/697 02:32:19 INFO - PROCESS | 14720 | __metrics 02:32:20 ERROR - PROCESS | 14720 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:32:21 INFO - TEST-INFO | 14720: exit 0 02:32:21 INFO - Browser initialized. 02:32:21 INFO - Running cycle 1/1 for kraken test... 02:32:21 INFO - TEST-INFO | started process 14843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps564V4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:22 INFO - PROCESS | 14843 | 02:32:22 INFO - PROCESS | 14843 | (process:14906): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:32:32 INFO - PROCESS | 14843 | RSS: Main: 162824192 02:32:32 INFO - PROCESS | 14843 | 02:32:35 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46168/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:36 INFO - PROCESS | 14843 | RSS: Main: 167878656 02:32:36 INFO - PROCESS | 14843 | 02:32:39 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46168/tests/kraken/driver.html?testName=audio-dft) 02:32:39 INFO - PROCESS | 14843 | RSS: Main: 167596032 02:32:39 INFO - PROCESS | 14843 | 02:32:42 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46168/tests/kraken/driver.html?testName=audio-fft) 02:32:43 INFO - PROCESS | 14843 | RSS: Main: 162361344 02:32:43 INFO - PROCESS | 14843 | 02:32:45 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46168/tests/kraken/driver.html?testName=audio-oscillator) 02:32:46 INFO - PROCESS | 14843 | RSS: Main: 162955264 02:32:46 INFO - PROCESS | 14843 | 02:32:48 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:48 INFO - PROCESS | 14843 | RSS: Main: 163094528 02:32:48 INFO - PROCESS | 14843 | 02:32:52 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46168/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:52 INFO - PROCESS | 14843 | RSS: Main: 163037184 02:32:52 INFO - PROCESS | 14843 | 02:32:56 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46168/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:56 INFO - PROCESS | 14843 | RSS: Main: 161816576 02:32:56 INFO - PROCESS | 14843 | 02:32:59 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46168/tests/kraken/driver.html?testName=json-parse-financial) 02:33:00 INFO - PROCESS | 14843 | RSS: Main: 162562048 02:33:00 INFO - PROCESS | 14843 | 02:33:02 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:02 INFO - PROCESS | 14843 | RSS: Main: 162717696 02:33:02 INFO - PROCESS | 14843 | 02:33:04 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:05 INFO - PROCESS | 14843 | RSS: Main: 163074048 02:33:05 INFO - PROCESS | 14843 | 02:33:07 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:08 INFO - PROCESS | 14843 | RSS: Main: 163627008 02:33:08 INFO - PROCESS | 14843 | 02:33:10 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:11 INFO - PROCESS | 14843 | RSS: Main: 163581952 02:33:11 INFO - PROCESS | 14843 | 02:33:14 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:14 INFO - PROCESS | 14843 | RSS: Main: 163778560 02:33:14 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:46168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46168/tests/kraken/driver.html?testName=ai-astar) 02:33:16 INFO - PROCESS | 14843 | RSS: Main: 165576704 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | __start_tp_report 02:33:16 INFO - PROCESS | 14843 | _x_x_mozilla_page_load 02:33:16 INFO - PROCESS | 14843 | _x_x_mozilla_page_load_details 02:33:16 INFO - PROCESS | 14843 | |i|pagename|runs| 02:33:16 INFO - PROCESS | 14843 | |0;ai-astar;108;111;102;111;112;111;105;111;111;112 02:33:16 INFO - PROCESS | 14843 | |1;audio-beat-detection;155;136;149;205;127;160;158;130;189;128 02:33:16 INFO - PROCESS | 14843 | |2;audio-dft;160;162;161;162;163;175;162;163;161;162 02:33:16 INFO - PROCESS | 14843 | |3;audio-fft;75;75;75;161;76;75;75;76;166;77 02:33:16 INFO - PROCESS | 14843 | |4;audio-oscillator;91;93;176;92;92;92;146;91;92;136 02:33:16 INFO - PROCESS | 14843 | |5;imaging-gaussian-blur;121;120;121;120;121;121;119;121;121;121 02:33:16 INFO - PROCESS | 14843 | |6;imaging-darkroom;147;147;148;146;147;146;146;146;147;146 02:33:16 INFO - PROCESS | 14843 | |7;imaging-desaturate;96;96;95;96;96;96;95;96;96;95 02:33:16 INFO - PROCESS | 14843 | |8;json-parse-financial;58;56;58;56;58;62;59;117;55;58 02:33:16 INFO - PROCESS | 14843 | |9;json-stringify-tinderbox;61;61;61;60;59;59;59;60;60;60 02:33:16 INFO - PROCESS | 14843 | |10;stanford-crypto-aes;78;92;80;80;77;78;83;78;80;79 02:33:16 INFO - PROCESS | 14843 | |11;stanford-crypto-ccm;127;130;122;122;132;123;132;132;200;125 02:33:16 INFO - PROCESS | 14843 | |12;stanford-crypto-pbkdf2;166;163;171;167;166;173;164;164;168;165 02:33:16 INFO - PROCESS | 14843 | |13;stanford-crypto-sha256-iterative;65;67;66;63;66;64;64;63;67;62 02:33:16 INFO - PROCESS | 14843 | __end_tp_report 02:33:16 INFO - PROCESS | 14843 | __start_cc_report 02:33:16 INFO - PROCESS | 14843 | _x_x_mozilla_cycle_collect,848 02:33:16 INFO - PROCESS | 14843 | __end_cc_report 02:33:16 INFO - PROCESS | 14843 | __startTimestamp1462959196665__endTimestamp 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | ------- Summary: start ------- 02:33:16 INFO - PROCESS | 14843 | Number of tests: 14 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:3.54 02:33:16 INFO - PROCESS | 14843 | Values: 108.0 111.0 102.0 111.0 112.0 111.0 105.0 111.0 111.0 112.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:156.50 stddev:26.26 (16.8%) stddev-sans-first:27.85 02:33:16 INFO - PROCESS | 14843 | Values: 155.0 136.0 149.0 205.0 127.0 160.0 158.0 130.0 189.0 128.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:4.28 (2.6%) stddev-sans-first:4.39 02:33:16 INFO - PROCESS | 14843 | Values: 160.0 162.0 161.0 162.0 163.0 175.0 162.0 163.0 161.0 162.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.13 (49.5%) stddev-sans-first:38.80 02:33:16 INFO - PROCESS | 14843 | Values: 75.0 75.0 75.0 161.0 76.0 75.0 75.0 76.0 166.0 77.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:30.97 (33.7%) stddev-sans-first:32.07 02:33:16 INFO - PROCESS | 14843 | Values: 91.0 93.0 176.0 92.0 92.0 92.0 146.0 91.0 92.0 136.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#5] imaging-gaussian-blur Cycles:10 Average:120.60 Median:121.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:33:16 INFO - PROCESS | 14843 | Values: 121.0 120.0 121.0 120.0 121.0 121.0 119.0 121.0 121.0 121.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:33:16 INFO - PROCESS | 14843 | Values: 147.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:33:16 INFO - PROCESS | 14843 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:58.00 stddev:18.83 (32.5%) stddev-sans-first:19.86 02:33:16 INFO - PROCESS | 14843 | Values: 58.0 56.0 58.0 56.0 58.0 62.0 59.0 117.0 55.0 58.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 02:33:16 INFO - PROCESS | 14843 | Values: 61.0 61.0 61.0 60.0 59.0 59.0 59.0 60.0 60.0 60.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:4.38 (5.5%) stddev-sans-first:4.55 02:33:16 INFO - PROCESS | 14843 | Values: 78.0 92.0 80.0 80.0 77.0 78.0 83.0 78.0 80.0 79.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:131.00 stddev:23.38 (17.8%) stddev-sans-first:24.64 02:33:16 INFO - PROCESS | 14843 | Values: 127.0 130.0 122.0 122.0 132.0 123.0 132.0 132.0 200.0 125.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.50 stddev:3.20 (1.9%) stddev-sans-first:3.38 02:33:16 INFO - PROCESS | 14843 | Values: 166.0 163.0 171.0 167.0 166.0 173.0 164.0 164.0 168.0 165.0 02:33:16 INFO - PROCESS | 14843 | 02:33:16 INFO - PROCESS | 14843 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.50 stddev:1.77 (2.7%) stddev-sans-first:1.87 02:33:16 INFO - PROCESS | 14843 | Values: 65.0 67.0 66.0 63.0 66.0 64.0 64.0 63.0 67.0 62.0 02:33:16 INFO - PROCESS | 14843 | -------- Summary: end -------- 02:33:16 INFO - PROCESS | 14843 | 02:33:17 INFO - TEST-INFO | 14843: exit 0 02:33:17 INFO - TEST-OK | kraken | took 62458ms 02:33:17 INFO - SUITE-END | took 1172s 02:33:17 INFO - Completed test suite (00:19:32) 02:33:17 INFO - javascript benchmark 02:33:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8746450141994, 3171.7145456908875, 3188.091393952724, 3190.3300306935544, 3197.4404479216146, 5352.946470535294, 5370.060239458089, 5379.246905433238, 5508.504234618884, 5544.417836127209, 5247.317848679676, 5404.594655400841, 5495.395506494282, 5522.392536820947, 5565.638233514819, 4871.5615594596475, 4876.317315575822, 4924.950750492503, 4991.376077990251, 5074.2895994560795, 4882.584980276681, 5027.1453852844925, 5046.394432668085, 5061.417936937262, 5071.1632580624155, 4942.654014219006, 4962.305277261186, 4978.22837460196, 5026.597872170254, 5055.039542486916, 5038.2190760432195, 5047.268146118829, 5054.772535235887, 5061.797528098871, 5103.0, 5027.120253955543, 5040.722760248185, 5046.318746969149, 5059.266406371093, 5060.266261392115, 5166.044281807877, 5341.065313570149, 5347.064263753828, 5419.295491586068, 5435.782568697247, 5893.292804863444, 5894.882102357972, 5897.852553686149, 5901.144334071536, 5917.940820591782, 5699.316082070137, 5928.644281343133, 5930.169776231331, 5933.8813223735715, 5942.881142377171, 5480.616356855022, 5482.780688772445, 5528.806491772769, 5555.611107222496, 5565.3599836018975, 5991.850203744854, 6023.969880150571, 6033.0045542484995, 6056.454919057306, 6080.75676972925, 5551.639143455663, 5701.287339082614, 5773.9895518284975, 5776.653400795965, 5808.912866307009, 5760.971195144081, 5847.181394604759, 5854.326752423441, 5862.794802181903, 5908.231929849092, 5653.434656534396, 5729.770809167587, 5798.9130163047585, 5821.388754180834, 5836.8540786479825, 5714.599978001583, 5751.194832723422, 5813.186153938452, 5848.88302233953, 5858.941410585925, 4324.17840610283, 4398.5821346972625, 4425.535318791545, 4441.622462090694, 4472.373867658465, 3956.5449973252867, 3958.148997965451, 3959.544652364957, 3997.0, 4014.3175660137845, 5439.646422982572, 5596.608237423423, 5608.803691870765, 5623.903338848885, 5646.661200327993, 5859.941400586024, 5869.972754767984, 5875.676837773878, 5891.351951285355, 5940.079287710412, 5590.748416321276, 5639.154126880919, 5639.210510528529, 5651.773929042874, 5661.631993920382, 4825.758712064383, 4999.77501012448, 5000.724960127228, 5029.597632189416, 5040.79836806531, 6047.183630209954, 6131.957816600026, 6135.662538560422, 6161.537884658668, 6166.445019948136, 5921.407859214217, 5969.313528944227, 5973.850653733692, 5984.910226346696, 5985.25184351956, 5799.681017543907, 6027.427394397525, 6038.728257228523, 6159.907601385893, 6172.074188871526, 5800.8259752207505, 5802.1296805479515, 5805.535557155502, 5829.883402332014, 5832.766689332549, 5939.0, 5976.133460648269, 5991.310999234969, 5992.580519363602, 6006.579539432198, 5561.499465048165, 5677.1768093627015, 5714.828555143353, 5749.626274292157, 5755.7697692093525, 5537.335519737496, 5677.460641239076, 5677.914831277451, 5724.942750572441, 5729.598928075162, 5636.802711905064, 5645.633033852787, 5656.462636049569, 5657.858553536194, 5662.490375866192, 5489.752961116839, 5662.433756624305, 5670.432956704297, 5735.76681013584, 5788.421157884178, 5555.472230138131, 5605.271314729059, 5615.494605485526, 5617.915731264116, 5653.745581448762], "value": 5401.067167122868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.1737567405631, 638.7221558622002, 653.4151934019053, 672.3108813466197, 681.9420349270312, 38223.235535289314, 42627.36058959114, 42916.14167716644, 43053.78473107634, 43187.35218971718, 43109.13781724364, 43207.78396108015, 43300.566994330045, 43566.0, 43660.0, 8759.956200219005, 8889.822203555925, 8918.286537077018, 8975.057618950013, 8982.05688402718, 8873.467591944504, 8898.243649289818, 8915.910840891573, 8938.821223575525, 8972.461652300883, 8849.646014159458, 8927.55362231889, 8935.865962010575, 8941.418807777474, 8946.507942063185, 8817.911820881773, 8863.335249856254, 8936.151065648786, 8942.64229430822, 8958.148975847349, 8748.737537873874, 8777.605007774602, 8829.955850220707, 8833.55832208387, 8838.779030524223, 34339.313213735586, 34688.306233875184, 34909.650903490896, 34994.82502587471, 35002.64997350019, 3453.7582369234165, 3487.930241395183, 3584.9283014339567, 3677.4667673187505, 3712.3132220539287, 31186.532202016988, 31714.36571268585, 31950.0, 32088.197795055075, 32697.673023269937, 4211.4525111735275, 4277.508086570022, 4282.100758840647, 4286.507051689065, 4354.194474022316, 277044.0, 278226.0, 279137.0, 280495.0, 281835.0, 36130.8193459031, 36328.0, 36606.267874642355, 36658.08354791098, 36668.083297917765, 36793.0, 37667.246655066745, 37811.0, 39288.0, 39542.0, 16343.0, 16467.917660411862, 16492.25784839685, 16537.503874883772, 16538.421155259748, 12657.430415631134, 12672.556460523838, 12697.238165710087, 12709.046821488426, 12727.936360318325, 20258.0, 20378.79621203769, 20670.586588268452, 20701.58596828055, 20782.1687132516, 7354.2645735427095, 7386.187519372865, 7581.241875812375, 7588.734394296173, 7688.46180767341, 943.6555657185215, 993.7664648807524, 1041.345187014046, 1179.5399794080315, 1194.0805579703579, 30850.382992340026, 31867.0, 31939.361212775613, 32044.96008008749, 32340.0, 1126.6845283320683, 1147.701597584634, 1177.128924595793, 1200.8198770184542, 1240.2558464920976, 16363.59091022734, 16783.741219408592, 16986.235619397157, 17066.23201955915, 17066.317347306216, 486819.0, 492144.0, 493284.0, 494433.0, 496038.0, 58401.0, 58505.41494585085, 58566.12150817741, 59035.704821475614, 59065.0, 1424.7435461616801, 1432.6991331820434, 1454.5999850041323, 1456.4975083596141, 1472.0725942656059, 29762.404751905273, 30535.0, 30555.54166687546, 31212.687873120976, 31430.214244644067, 49381.25928111009, 49705.0, 49869.0, 49890.0, 49924.0, 439872.0, 443226.0, 444151.0, 444960.0, 449933.0, 28857.56713649255, 29029.12912612625, 29464.852675736485, 29751.404971900007, 29792.10623681293, 48610.0, 48880.2667959988, 49362.50637493723, 49688.503114968385, 50487.0, 41379.379309309785, 41698.1660366797, 42810.785946071315, 43024.139517210104, 43030.0, 40636.18727625372, 41594.79202603968, 41964.58035419607, 41979.58020419757, 42180.78909605555, 42235.3664695036, 42779.14441711086, 43030.13939721126, 43435.56564434442, 43454.34818477662, 35980.0, 37091.629083708816, 37279.81360093291, 37939.0, 38038.0, 28609.713902860705, 28827.279318017216, 29091.854540728007, 29298.267543311587, 29325.26686832846], "value": 19585.84956134461, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8428912724038, 405.3919121318023, 409.2592407741987, 414.2605449273048, 419.07802833765726, 13938.303084845742, 17612.82387176128, 18942.86342819432, 19526.511837204078, 19533.511662208468, 18620.348287809928, 18629.347972820953, 19008.714869276937, 19532.31636892709, 19549.609007819836, 5549.694766787825, 5604.187392828037, 5765.971170144144, 5807.128930660392, 5811.244538210027, 5697.6011679182475, 5740.311162660487, 5753.108268218432, 5774.105013722879, 5795.420457954192, 5551.72241387931, 5649.519790817785, 5771.0, 5773.682447465388, 5784.623999440044, 5714.999126070572, 5766.4233576642, 5767.221425107619, 5769.221155144065, 5787.074068149097, 5074.619403544749, 5176.352955880515, 5180.818671346522, 5185.222216667492, 5204.167333226704, 22595.435114122112, 22804.771952280596, 22835.31494055181, 23344.416389590227, 23390.64914026291, 2376.7742064503846, 2385.61830107182, 2399.700037495313, 2668.3329167708075, 2769.5014897318474, 14810.407583696639, 14944.775828362583, 14982.250887455693, 15205.239738013055, 15371.923140384339, 1932.4589115047809, 1960.3824795189469, 2027.7465316835396, 2074.8588276447895, 2081.5004398944143, 71661.28338716598, 71846.0, 79749.0, 80844.0, 82145.58927205385, 10541.947290263499, 10873.184511161695, 10923.781524369468, 10958.0, 10983.670489885317, 14910.179940103399, 14966.0, 15022.399104035716, 15066.171360575054, 15072.472463463726, 8012.759617211493, 8109.47237951493, 8169.673213071529, 8221.095679475253, 8323.95838020806, 7976.401769867283, 8020.238077382639, 8033.55815430157, 8110.270075693216, 8131.878021829677, 6526.771562995273, 6616.4045235929, 6636.469082473487, 6661.566998145202, 6768.390844823989, 1883.9246430142641, 1931.1020375525447, 1952.9707054393912, 1958.089488387878, 1961.4311849563753, 967.2068903499204, 974.91713204377, 1070.0690399352457, 1127.1658972360394, 1154.2670404293167, 19476.22095116208, 19614.70577941332, 19737.210511579662, 19909.900450497946, 19984.400467985983, 1064.2390690656218, 1065.9626913058005, 1081.6809041332826, 1081.9945900270607, 1115.1691989467736, 11211.159163062639, 11355.886441135648, 11550.653480395602, 11562.88437115635, 11570.652880413601, 494873.0, 495863.0, 514478.0, 516778.0, 520894.0, 50947.0, 84295.15704842996, 86377.13622863691, 87237.0, 87715.12284877198, 1079.0450451350455, 1096.923215374932, 1147.4778975566264, 1182.7575347053833, 1186.8397766301612, 18039.5490112743, 18146.72779908276, 18194.272229110687, 18396.0, 18488.537786555444, 26143.477130457664, 32653.836730817144, 37927.43108853314, 40032.39951400673, 40080.0, 51279.20910725015, 51531.74234128805, 51764.22353664623, 52082.47917520928, 52423.47576524186, 5834.358220595816, 7143.606996635606, 7368.336849683555, 7543.0948286206, 8170.937778088811, 13951.720965580835, 13961.860381396056, 14081.0, 14082.507112251022, 14284.57146285613, 12017.819732703842, 12042.819357709466, 12205.511779528719, 12291.938540307241, 12312.630621081382, 11825.408729563316, 11831.52673893069, 11931.940340298243, 12323.383830808603, 12415.813762793747, 12256.28128190436, 12404.56584019555, 12507.695668579856, 12638.178518396275, 12700.936495317465, 8743.431676940978, 8833.0, 8949.418287811272, 9055.551111822077, 9169.220616247694, 12307.692307692021, 12383.19509231897, 12505.187162834387, 12525.56160534377, 12537.87462125367], "value": 9431.417919636611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.3164815064695, 1500.5948393933638, 1613.8708903287732, 1827.0590645817406, 1876.6903460928947, 7535.284148005931, 8536.274416674582, 8659.523726195057, 9029.322800789942, 9098.0, 8681.0, 8938.284937205024, 8945.373823832335, 8986.820263594724, 9018.72943811685, 2338.614128668772, 2366.656834758959, 2369.8815059247054, 2370.419247284418, 2374.8693821839793, 2262.502249505106, 2268.7731226877263, 2292.2435596253194, 2299.41364951937, 2324.744278129413, 2290.1640901071155, 2302.9884850575722, 2315.3748487908256, 2377.037299893546, 2380.559596474649, 2325.3256555598855, 2344.718633763959, 2355.081518207892, 2357.3399448154546, 2401.0515846240637, 2320.5706944215203, 2343.6718859359703, 2343.7070366204225, 2351.165336305604, 2358.033206385374, 8903.866442003375, 8968.910310896938, 8987.146221108984, 9052.27581793455, 9060.229880460169, 5346.652467589594, 5374.301340825707, 5408.702521361323, 5458.099413596752, 5562.694051827148, 3578.8926332210076, 3579.391503444421, 3658.5609726832686, 3667.2848794485085, 3736.4955730976244, 1177.3289225141673, 1179.598936361641, 1181.6100686773343, 1206.7465832175253, 1227.4415141110862, 12598.433070511941, 12656.81014784779, 12701.745965080647, 12720.300383478905, 12724.681882953, 4780.47024952019, 4800.831970881002, 4842.903141937141, 4873.902521949542, 4900.142475066849, 10643.946780266204, 10654.73363165927, 10675.092617127475, 10676.572937082585, 10702.732431689114, 5366.946330536644, 5378.435264297271, 5383.892322153613, 5404.972975135178, 5411.945880541144, 4190.8533201337805, 4800.903981920412, 4929.0, 4937.530934561211, 4950.801967921315, 3968.4840970674204, 3984.1633257015774, 4049.7570145791346, 4091.7954102294766, 4118.155778065489, 1304.8434187897324, 1312.6521471809979, 1321.5572783117764, 1335.5659410691565, 1340.5844188301462, 971.7910649210312, 1003.8343673293824, 1015.9695209143738, 1022.2792930983638, 1035.2856528994969, 5956.55325850563, 6058.878822423527, 6108.144859719643, 6178.691065446799, 6209.441150296495, 437.81830540326047, 446.68731887678103, 453.3154936046528, 458.08840407589327, 462.7408651155364, 4184.958150418518, 4196.832126714898, 4251.766152861561, 4258.701890867609, 4262.893427664271, 10243.231757618209, 10534.841977370346, 10681.465926703633, 10691.358518488916, 10719.946400267949, 10347.017033381817, 10417.270791044553, 10470.162387009173, 10529.315594486334, 10539.683809485728, 7796.688132474637, 7918.445708800444, 8003.399745019147, 8057.959710201529, 8169.550674712829, 6168.907466387918, 6355.841103972438, 6376.330485298977, 6384.201974753156, 6496.7726129585235, 9835.655752048644, 10112.292139550162, 10325.535350909076, 10338.224633152695, 10372.896271037192, 10323.63867264642, 10420.843687344544, 10564.313319634199, 10577.048065674126, 10657.626983055556, 7036.401905837856, 7728.574928378768, 7925.207479252029, 8001.279884810162, 8083.0, 8351.20663536963, 8379.95810020946, 8412.579371031547, 8469.195426434479, 8477.703280385156, 7770.261825126604, 7968.960155199187, 8005.319547838499, 8013.318867896294, 8029.839403211786, 7422.480426370318, 7700.268474494914, 7819.413543984338, 7888.290053895177, 7971.800704982422, 6992.26581208986, 7143.8571228576175, 7215.927840721525, 7232.349088582053, 7250.383717384081, 5083.38999320084, 5133.743312834269, 5183.403908550565, 5219.791208351775, 5235.214717792362, 5136.280920671184, 5157.510036546522, 5220.5382492902045, 5236.0, 5318.042752304622], "value": 4632.077679260519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9600447946247, 335.47665641599104, 336.6582918337887, 340.63211731330165, 340.9181796368869, 5677.630953987988, 5680.807030523585, 5716.914246286304, 5719.799807006755, 5729.255196824407, 5618.494335509803, 5620.662760234389, 5627.7467513961865, 5649.604527683064, 5660.660360378381, 4071.7149799514045, 4198.8110535026, 4249.893752656178, 4319.719218250803, 4338.739675619458, 4267.231898258312, 4296.849610263642, 4321.58944900234, 4334.436523251973, 4375.956240437603, 4310.655147588185, 4346.913061738764, 4360.36774667673, 4361.978190109045, 4362.411074504948, 4087.6525495332785, 4322.438083049215, 4325.113351762881, 4332.718373305725, 4336.262835318003, 3850.7304488685804, 3853.84584616615, 3863.8261278242267, 3876.7013050628075, 3902.824372903226, 5367.2485851980755, 5430.56555475565, 5447.918281225785, 5472.2338872557875, 5499.340079190482, 4916.680415772963, 4984.675996060245, 4995.700257984497, 5030.773615187289, 5079.644424890259, 5837.052288594233, 5837.474627283523, 5864.211415518265, 5895.793647222326, 5898.691177939845, 4278.315469524861, 4279.828806847722, 4292.527821939584, 4299.50555686097, 4318.870433886988, 5857.6778277194735, 6118.877622447526, 6129.662868542228, 6141.477974372184, 6167.537434692371, 4269.530351661315, 4279.422277992493, 4301.763403012865, 4320.4167437395545, 4332.133573285356, 4342.196693611692, 4349.304111342233, 4366.672499562545, 4373.300271956472, 4376.562343765598, 4730.9763451182525, 4995.775190116454, 4998.550130488274, 4999.675086102113, 5001.7499125043605, 5808.970955145197, 5828.300603927556, 5853.970730146322, 5881.73553182028, 5927.2590926134235, 1530.7933428986944, 1549.4809238904868, 1550.6511035017256, 1556.7353549896545, 1561.188182145278, 971.9805603887883, 1010.242318261304, 1035.632350515556, 1053.4048262731533, 1056.313396292416, 5630.915536266959, 5709.600327977085, 5714.514266287329, 5746.2761171648335, 5794.797182098607, 6024.457798798129, 6045.818625441244, 6051.788187413419, 6056.485198758067, 6081.908771368433, 5488.4237155098135, 5682.090865461506, 5798.75326804739, 5834.27071616048, 5865.507159457299, 3230.596175478065, 3254.6582608826207, 3268.313654132611, 3289.967100329014, 3290.967090329066, 6179.16581261533, 6327.683615819191, 6330.164252366762, 6349.9682501587195, 6357.523185761086, 6245.751529449394, 6250.218722659668, 6264.2796078451565, 6281.654509001957, 6316.557840951089, 6151.815445536551, 6237.688115594202, 6344.555881088372, 6416.454601358843, 6446.871062578723, 6053.515718742578, 6094.299155597163, 6116.969415152896, 6151.9384806151365, 6161.815145545641, 6006.729697163725, 6095.0, 6107.434877351612, 6109.297430795337, 6112.205413296243, 6023.337432882292, 6333.145025421509, 6363.904541431974, 6378.107065010995, 6384.553081284265, 4219.789010549522, 4235.195312890541, 4236.152769446061, 4236.851710190129, 4258.95741042598, 5848.795292164924, 6156.753729850756, 6201.844953876189, 6222.471089957405, 6235.844103897439, 5846.327672317738, 5862.0, 5871.882562348644, 5918.763249469973, 5936.821895343147, 5953.970230148821, 5971.313298970674, 5986.431289027535, 6043.184170137151, 6076.635401875901, 5547.861303467445, 5817.563682723898, 5855.443732845373, 5868.23712917318, 5912.0, 5931.525477961666, 5969.791057312973, 5993.790217342372, 6035.728392222449, 6037.003894357557, 5760.567957403296, 5819.185314056121, 5902.2622172228475, 5902.822915312548, 5923.348431672599], "value": 4514.33525710091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.9408541402103, 874.7506960516246, 875.221053262596, 882.3073886998703, 886.6896586194832, 13133.605991820248, 13877.028607997432, 13972.231527266022, 14006.369713362898, 14397.424103035892, 14123.293835308219, 14856.108633482, 15017.924910375461, 15034.924825375885, 15045.699086018272, 697.88136016877, 834.3575446905879, 837.4514692876161, 845.974620761375, 849.0829903703985, 829.2950991657074, 829.8713699376576, 836.0302049622439, 844.7170197983683, 853.4879072556479, 897.8832751742297, 899.5052721003455, 901.0944001278706, 901.8286525560155, 901.9639214431447, 889.9822003559925, 890.6170346750895, 890.7238755985601, 892.9598168082387, 895.7536677413731, 657.5594351784316, 658.8319978405524, 659.044385640818, 659.3373659472247, 660.3990368764449, 14501.129932204101, 14901.92549037248, 14984.850151498455, 15024.323905424282, 15043.473478428203, 14624.853751462562, 14808.185549794756, 14813.925930370388, 14819.555413337617, 14960.62598435037, 11390.886091139148, 11487.195896287263, 11544.134189935789, 11552.884471155265, 11701.122415818763, 3860.208657225262, 3871.457995880579, 3975.2447035063246, 3998.3802510610903, 4042.686127008734, 58552.70723646397, 59032.704836475976, 59740.70129649324, 60009.39990600082, 60289.39710602838, 11637.185397022127, 11665.358405287621, 11784.88215117855, 12050.096242781827, 12109.757804843854, 21578.0, 21591.56816863654, 21619.35141945744, 21621.459463513536, 21635.891820540797, 8684.609192586222, 8772.95613521941, 8944.463332200088, 9070.501122438329, 9164.312676549285, 4767.928481072787, 4825.227963525819, 4858.6356023298395, 4882.340883980688, 4888.804447822118, 3487.773294735834, 3577.2130131371055, 3583.4624806278744, 3588.6411358864425, 3592.76647017943, 594.8156071617726, 651.9511036672174, 655.9212894452601, 659.7921654678761, 662.7282814046218, 610.7251736718495, 683.7094234950126, 766.1878408886598, 769.6690423118113, 777.1606664802, 9246.352755307063, 9293.767655808659, 9338.719838404859, 9450.85823712645, 9590.808183836285, 671.5567725301278, 720.6216736213426, 730.4375630764282, 783.5768684910084, 800.095891642452, 4537.410136682276, 4565.817367305337, 4589.954100459019, 4610.2623580227, 4612.630989520831, 67306.32693673098, 68551.3144868555, 69750.65124674344, 71278.29773618098, 71399.64300178569, 62235.688821556505, 62574.0, 62610.68694656497, 63817.361826381144, 64232.67883660552, 55998.72000639971, 56240.43759562434, 56356.718216408655, 56621.71689141528, 57711.0, 8615.353848461265, 8646.270745850728, 8802.25180859634, 8868.290536757173, 8921.197092261467, 29837.403251934407, 30562.694373055983, 31391.37217255688, 32592.511112333807, 32925.17687057843, 46594.534054659016, 46661.30008049814, 46859.76570117127, 46871.76564117157, 47191.76404117957, 12747.936260318638, 12908.354582271037, 12921.612351629467, 13009.934950325187, 13085.869141308845, 13652.180869147485, 14268.0, 14461.349239284047, 14644.13926152811, 14656.193909334663, 13278.402471888981, 13734.519291825138, 13906.58280251594, 13908.304584770924, 14453.205073721047, 13219.867801322249, 13374.398152082986, 13508.864911351155, 13514.189148651112, 13764.17414955106, 13332.866671333162, 13390.799138012742, 13401.0, 13499.797503037658, 13992.860071399156, 11238.325700458, 11258.38078905668, 11451.427428628702, 11629.418529073344, 12007.519699211934, 11543.422828858356, 11602.303861768321, 11636.36000020007, 11842.171048026556, 11941.104417168921], "value": 7109.982741280718, "unit": "score"}], "name": "dromaeo_css", "value": 7275.783741629362, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 102.0, 111.0, 112.0, 111.0, 105.0, 111.0, 111.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 136.0, 149.0, 205.0, 127.0, 160.0, 158.0, 130.0, 189.0, 128.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 163.0, 175.0, 162.0, 163.0, 161.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 161.0, 76.0, 75.0, 75.0, 76.0, 166.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 176.0, 92.0, 92.0, 92.0, 146.0, 91.0, 92.0, 136.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 121.0, 120.0, 121.0, 121.0, 119.0, 121.0, 121.0, 121.0], "value": 120.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 56.0, 58.0, 62.0, 59.0, 117.0, 55.0, 58.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 92.0, 80.0, 80.0, 77.0, 78.0, 83.0, 78.0, 80.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 122.0, 122.0, 132.0, 123.0, 132.0, 132.0, 200.0, 125.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 171.0, 167.0, 166.0, 173.0, 164.0, 164.0, 168.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 63.0, 66.0, 64.0, 64.0, 63.0, 67.0, 62.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1562.4000000000003, "alertThreshold": 2.0}]} 02:33:17 INFO - Return code: 0 02:33:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:33:17 ERROR - # TBPL SUCCESS # 02:33:17 INFO - Running post-action listener: _resource_record_post_action 02:33:17 INFO - ##### 02:33:17 INFO - ##### Finished run-tests step (success) 02:33:17 INFO - ##### 02:33:17 INFO - Running post-run listener: _resource_record_post_run 02:33:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535810048; Read time: 24; Write time: 428044 02:33:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244797440; Read time: 0; Write time: 227796 02:33:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291012608; Read time: 24; Write time: 200248 02:33:19 INFO - Running post-run listener: _upload_blobber_files 02:33:19 INFO - Blob upload gear active. 02:33:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:19 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 02:33:19 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:33:19 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:33:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:33:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:20 INFO - (blobuploader) - INFO - Done attempting. 02:33:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:33:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:20 INFO - (blobuploader) - INFO - Done attempting. 02:33:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:20 INFO - Return code: 0 02:33:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:33:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f1e003455adb334cc2bda3bb4143c1097116381663fb46ed58791a75df9c9b137e34c9390dc0d13256c7c42bb6018213034061d5d21cb96882b360bff38a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b663b1780727a2dee128dbc0a7ca2e57a1fe98d66022e0ab9df15a4dd20a98b36e6623df344847903045753966606902edcb7970df26eb4f349585f6559a2d8a"} 02:33:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:33:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:33:20 INFO - Contents: 02:33:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f1e003455adb334cc2bda3bb4143c1097116381663fb46ed58791a75df9c9b137e34c9390dc0d13256c7c42bb6018213034061d5d21cb96882b360bff38a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b663b1780727a2dee128dbc0a7ca2e57a1fe98d66022e0ab9df15a4dd20a98b36e6623df344847903045753966606902edcb7970df26eb4f349585f6559a2d8a"} 02:33:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:33:20 INFO - Copying logs to upload dir... 02:33:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:33:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.063256 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-11 02:33:20.946750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:33:20.949878) ========= 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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 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/sha512/b7f1e003455adb334cc2bda3bb4143c1097116381663fb46ed58791a75df9c9b137e34c9390dc0d13256c7c42bb6018213034061d5d21cb96882b360bff38a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b663b1780727a2dee128dbc0a7ca2e57a1fe98d66022e0ab9df15a4dd20a98b36e6623df344847903045753966606902edcb7970df26eb4f349585f6559a2d8a"} build_url:https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/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/sha512/b7f1e003455adb334cc2bda3bb4143c1097116381663fb46ed58791a75df9c9b137e34c9390dc0d13256c7c42bb6018213034061d5d21cb96882b360bff38a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b663b1780727a2dee128dbc0a7ca2e57a1fe98d66022e0ab9df15a4dd20a98b36e6623df344847903045753966606902edcb7970df26eb4f349585f6559a2d8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:33:20.974602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:33:20.974920) ========= 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=41bf3e9aed84707956354da8000001c5-1462955433.464327-1115024640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:33:21.060283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:33:21.060606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:33:21.060890) ========= ========= Total master_lag: 0.17 =========