builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1462806307.8 results: success (0) buildid: 20160509053032 builduid: f297f90dd753436b8df1d453c8f3b0f7 revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.803984) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.804691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.804983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.827655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.828010) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 08:05:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-09 08:05:08 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089770 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.932522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.933086) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.983345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:07.983713) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da2b27e1aabd9e23870c09072753faba6ad0a42d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev da2b27e1aabd9e23870c09072753faba6ad0a42d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 08:05:08,546 truncating revision to first 12 chars 2016-05-09 08:05:08,546 Setting DEBUG logging. 2016-05-09 08:05:08,546 attempt 1/10 2016-05-09 08:05:08,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da2b27e1aabd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 08:05:08,795 unpacking tar archive at: fx-team-da2b27e1aabd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:08.540652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:08.540916) ========= script_repo_revision: da2b27e1aabd9e23870c09072753faba6ad0a42d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:08.541313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:08.541584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 08:05:08.551289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-09 08:05:08.551569) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:09 INFO - MultiFileLogger online at 20160509 08:05:09 in /builds/slave/test 08:05:09 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 08:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:09 INFO - {'append_to_log': False, 08:05:09 INFO - 'base_work_dir': '/builds/slave/test', 08:05:09 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:09 INFO - 'branch': 'Fx-Team', 08:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:09 INFO - 'config_files': ('talos/linux_config.py',), 08:05:09 INFO - 'default_actions': ('clobber', 08:05:09 INFO - 'read-buildbot-config', 08:05:09 INFO - 'download-and-extract', 08:05:09 INFO - 'populate-webroot', 08:05:09 INFO - 'create-virtualenv', 08:05:09 INFO - 'install', 08:05:09 INFO - 'run-tests'), 08:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:09 INFO - 'download_minidump_stackwalk': True, 08:05:09 INFO - 'download_symbols': 'ondemand', 08:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:09 INFO - 'installer_path': 'installer.exe', 08:05:09 INFO - 'log_level': 'info', 08:05:09 INFO - 'log_name': 'talos', 08:05:09 INFO - 'log_to_console': True, 08:05:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:09 INFO - 'opt_config_files': (), 08:05:09 INFO - 'pip_index': False, 08:05:09 INFO - 'sps_profile': False, 08:05:09 INFO - 'sps_profile_interval': 0, 08:05:09 INFO - 'suite': 'dromaeojs-e10s', 08:05:09 INFO - 'system_bits': '32', 08:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:09 INFO - 'title': 'talos-linux64-ix-051', 08:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:09 INFO - 'use_talos_json': True, 08:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:09 INFO - 'work_dir': 'build'} 08:05:09 INFO - ##### 08:05:09 INFO - ##### Running clobber step. 08:05:09 INFO - ##### 08:05:09 INFO - Running pre-action listener: _resource_record_pre_action 08:05:09 INFO - Running main action method: clobber 08:05:09 INFO - rmtree: /builds/slave/test/build 08:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:10 INFO - Running post-action listener: _resource_record_post_action 08:05:10 INFO - ##### 08:05:10 INFO - ##### Finished clobber step (success) 08:05:10 INFO - ##### 08:05:10 INFO - ##### 08:05:10 INFO - ##### Running read-buildbot-config step. 08:05:10 INFO - ##### 08:05:10 INFO - Running pre-action listener: _resource_record_pre_action 08:05:10 INFO - Running main action method: read_buildbot_config 08:05:10 INFO - Using buildbot properties: 08:05:10 INFO - { 08:05:10 INFO - "project": "", 08:05:10 INFO - "product": "firefox", 08:05:10 INFO - "script_repo_revision": "production", 08:05:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:05:10 INFO - "repository": "", 08:05:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:05:10 INFO - "buildid": "20160509053032", 08:05:10 INFO - "pgo_build": "True", 08:05:10 INFO - "basedir": "/builds/slave/test", 08:05:10 INFO - "buildnumber": 303, 08:05:10 INFO - "slavename": "talos-linux64-ix-051", 08:05:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:05:10 INFO - "platform": "ubuntu64_hw", 08:05:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:10 INFO - "branch": "fx-team", 08:05:10 INFO - "repo_path": "integration/fx-team", 08:05:10 INFO - "revision": "da2b27e1aabd9e23870c09072753faba6ad0a42d", 08:05:10 INFO - "stage_platform": "linux64-pgo", 08:05:10 INFO - "builduid": "f297f90dd753436b8df1d453c8f3b0f7", 08:05:10 INFO - "slavebuilddir": "test" 08:05:10 INFO - } 08:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:05:10 INFO - Running post-action listener: _resource_record_post_action 08:05:10 INFO - ##### 08:05:10 INFO - ##### Finished read-buildbot-config step (success) 08:05:10 INFO - ##### 08:05:10 INFO - ##### 08:05:10 INFO - ##### Running download-and-extract step. 08:05:10 INFO - ##### 08:05:10 INFO - Running pre-action listener: _resource_record_pre_action 08:05:10 INFO - Running main action method: download_and_extract 08:05:10 INFO - mkdir: /builds/slave/test/build/tests 08:05: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')]} 08:05:10 INFO - https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:12 INFO - Downloaded 1361 bytes. 08:05:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:12 INFO - Using the following test package requirements: 08:05:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'jsshell-linux-x86_64.zip'], 08:05:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:12 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')]} 08:05:12 INFO - https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:14 INFO - Downloaded 23896834 bytes. 08:05:14 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'] 08:05:14 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 08:05:15 INFO - Return code: 0 08:05:15 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 08:05:15 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')]} 08:05:15 INFO - https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:32 INFO - Downloaded 23896834 bytes. 08:05:32 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'] 08:05:32 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 08:05:33 INFO - Return code: 0 08:05:33 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')]} 08:05:33 INFO - https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:34 INFO - Downloaded 10840152 bytes. 08:05:34 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'] 08:05:34 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 08:05:34 INFO - Return code: 0 08:05: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')]} 08:05:34 INFO - https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmIxP--rRMmgMsLHi50E1Q/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 08:05:36 INFO - Downloaded 58440100 bytes. 08:05:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:36 INFO - mkdir: /builds/slave/test/properties 08:05:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:36 INFO - Contents: 08:05:36 INFO - build_url:https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:37 INFO - Running post-action listener: _resource_record_post_action 08:05:37 INFO - Running post-action listener: set_extra_try_arguments 08:05:37 INFO - ##### 08:05:37 INFO - ##### Finished download-and-extract step (success) 08:05:37 INFO - ##### 08:05:37 INFO - ##### 08:05:37 INFO - ##### Running populate-webroot step. 08:05:37 INFO - ##### 08:05:37 INFO - Running pre-action listener: _resource_record_pre_action 08:05:37 INFO - Running main action method: populate_webroot 08:05:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:37 INFO - '--tppagecycles', 08:05:37 INFO - '7'], 08:05:37 INFO - 'tests': ['tsvgm']}}, 08:05:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['damp', 'tps']}, 08:05:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'tests': ['damp', 'tps']}, 08:05:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['dromaeo_dom']}, 08:05:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['a11yr', 08:05:37 INFO - 'ts_paint', 08:05:37 INFO - 'tpaint', 08:05:37 INFO - 'sessionrestore', 08:05:37 INFO - 'sessionrestore_no_auto_restore', 08:05:37 INFO - 'tabpaint']}, 08:05:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['tsvgx', 08:05:37 INFO - 'tsvgr_opacity', 08:05:37 INFO - 'tart', 08:05:37 INFO - 'tscrollx', 08:05:37 INFO - 'cart']}, 08:05:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:37 INFO - 'tsvgr_opacity', 08:05:37 INFO - 'tart', 08:05:37 INFO - 'tscrollx', 08:05:37 INFO - 'cart']}, 08:05:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'talos_options': ['--disable-e10s'], 08:05:37 INFO - 'tests': ['tp5o']}, 08:05:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'tests': ['tp5o']}, 08:05:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'talos_options': ['--disable-e10s', 08:05:37 INFO - '--xperf_path', 08:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:37 INFO - 'tests': ['tp5n']}, 08:05:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:37 INFO - 'talos_options': ['--xperf_path', 08:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:37 INFO - 'tests': ['tp5n']}}, 08:05:37 INFO - 'talos.zip': {'path': '', 08:05:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:37 INFO - Running post-action listener: _resource_record_post_action 08:05:37 INFO - ##### 08:05:37 INFO - ##### Finished populate-webroot step (success) 08:05:37 INFO - ##### 08:05:37 INFO - ##### 08:05:37 INFO - ##### Running create-virtualenv step. 08:05:37 INFO - ##### 08:05:37 INFO - Running pre-action listener: _resource_record_pre_action 08:05:37 INFO - Running main action method: create_virtualenv 08:05:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:37 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 08:05:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:37 INFO - Using real prefix '/usr' 08:05:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:39 INFO - Installing pip.................done. 08:05:39 INFO - Return code: 0 08:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:39 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')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:39 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 08:05:39 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 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 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 08:05:39 INFO - Cleaning up... 08:05:39 INFO - Return code: 0 08:05:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:05:39 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')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:39 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 08:05:39 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 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:40 INFO - Downloading/unpacking psutil>=0.7.1 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 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 08:05:40 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 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:42 INFO - Installing collected packages: psutil 08:05:42 INFO - Running setup.py install for psutil 08:05:42 INFO - building 'psutil._psutil_linux' extension 08:05:42 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 08:05:42 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 08:05:42 INFO - building 'psutil._psutil_posix' extension 08:05:42 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 08:05:42 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 08:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:42 INFO - Successfully installed psutil 08:05:42 INFO - Cleaning up... 08:05:42 INFO - Return code: 0 08:05:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:05:42 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')]} 08:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:42 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')]} 08:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:42 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:42 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 08:05:42 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 08:05:42 INFO - Using env: {'DISPLAY': ':0', 08:05:42 INFO - 'HOME': '/home/cltbld', 08:05:42 INFO - 'LANG': 'en_US.UTF-8', 08:05:42 INFO - 'LANGUAGE': 'en_US:en', 08:05:42 INFO - 'LOGNAME': 'cltbld', 08:05:42 INFO - 'MAIL': '/var/mail/cltbld', 08:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:42 INFO - 'MOZ_NO_REMOTE': '1', 08:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:42 INFO - 'NO_EM_RESTART': '1', 08:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:42 INFO - 'PWD': '/builds/slave/test', 08:05:42 INFO - 'SHELL': '/bin/bash', 08:05:42 INFO - 'SHLVL': '1', 08:05:42 INFO - 'TERM': 'linux', 08:05:42 INFO - 'TMOUT': '86400', 08:05:42 INFO - 'USER': 'cltbld', 08:05:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:42 INFO - '_': '/tools/buildbot/bin/python'} 08:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:05:44 INFO - Installing collected packages: mozsystemmonitor 08:05:44 INFO - Running setup.py install for mozsystemmonitor 08:05:44 INFO - Successfully installed mozsystemmonitor 08:05:44 INFO - Cleaning up... 08:05:45 INFO - Return code: 0 08:05:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:45 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')]} 08:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:45 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')]} 08:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:45 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:45 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 08:05:45 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 08:05:45 INFO - Using env: {'DISPLAY': ':0', 08:05:45 INFO - 'HOME': '/home/cltbld', 08:05:45 INFO - 'LANG': 'en_US.UTF-8', 08:05:45 INFO - 'LANGUAGE': 'en_US:en', 08:05:45 INFO - 'LOGNAME': 'cltbld', 08:05:45 INFO - 'MAIL': '/var/mail/cltbld', 08:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:45 INFO - 'MOZ_NO_REMOTE': '1', 08:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:45 INFO - 'NO_EM_RESTART': '1', 08:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:45 INFO - 'PWD': '/builds/slave/test', 08:05:45 INFO - 'SHELL': '/bin/bash', 08:05:45 INFO - 'SHLVL': '1', 08:05:45 INFO - 'TERM': 'linux', 08:05:45 INFO - 'TMOUT': '86400', 08:05:45 INFO - 'USER': 'cltbld', 08:05:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:45 INFO - '_': '/tools/buildbot/bin/python'} 08:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:45 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 08:05:45 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 08:05:45 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 08:05:45 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 08:05:45 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 08:05:45 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 08:05:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 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 08:05:47 INFO - Downloading docopt-0.6.1.tar.gz 08:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:47 INFO - Running setup.py install for blobuploader 08:05:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:47 INFO - Running setup.py install for requests 08:05:48 INFO - Running setup.py install for docopt 08:05:48 INFO - Successfully installed blobuploader requests docopt 08:05:48 INFO - Cleaning up... 08:05:48 INFO - Return code: 0 08:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:48 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')]} 08:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:48 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')]} 08:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:48 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:48 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 08:05:48 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 08:05:48 INFO - Using env: {'DISPLAY': ':0', 08:05:48 INFO - 'HOME': '/home/cltbld', 08:05:48 INFO - 'LANG': 'en_US.UTF-8', 08:05:48 INFO - 'LANGUAGE': 'en_US:en', 08:05:48 INFO - 'LOGNAME': 'cltbld', 08:05:48 INFO - 'MAIL': '/var/mail/cltbld', 08:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:48 INFO - 'MOZ_NO_REMOTE': '1', 08:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:48 INFO - 'NO_EM_RESTART': '1', 08:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:48 INFO - 'PWD': '/builds/slave/test', 08:05:48 INFO - 'SHELL': '/bin/bash', 08:05:48 INFO - 'SHLVL': '1', 08:05:48 INFO - 'TERM': 'linux', 08:05:48 INFO - 'TMOUT': '86400', 08:05:48 INFO - 'USER': 'cltbld', 08:05:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:48 INFO - '_': '/tools/buildbot/bin/python'} 08:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:48 INFO - Running setup.py (path:/tmp/pip-UVSYGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:48 INFO - Running setup.py (path:/tmp/pip-0L_WZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:48 INFO - Running setup.py (path:/tmp/pip-uoxi1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:48 INFO - Running setup.py (path:/tmp/pip-vrCOIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:48 INFO - Running setup.py (path:/tmp/pip-FEKkU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:49 INFO - Running setup.py (path:/tmp/pip-1UlRZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:49 INFO - Running setup.py (path:/tmp/pip-o1eXJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:49 INFO - Running setup.py (path:/tmp/pip-d9O2oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:49 INFO - Running setup.py (path:/tmp/pip-ERH9cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:49 INFO - Running setup.py (path:/tmp/pip-q_nPD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:49 INFO - Running setup.py (path:/tmp/pip-TTn8Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:49 INFO - Running setup.py (path:/tmp/pip-GaJF2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:49 INFO - Running setup.py (path:/tmp/pip-GA2bV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:49 INFO - Running setup.py (path:/tmp/pip-nWgH37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:49 INFO - Running setup.py (path:/tmp/pip-jpE8UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:49 INFO - Running setup.py (path:/tmp/pip-nzLhvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:49 INFO - Running setup.py (path:/tmp/pip-9kU_7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:49 INFO - Running setup.py install for manifestparser 08:05:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for mozcrash 08:05:50 INFO - Running setup.py install for mozdebug 08:05:50 INFO - Running setup.py install for mozdevice 08:05:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for mozfile 08:05:50 INFO - Running setup.py install for mozhttpd 08:05:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for mozinfo 08:05:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for mozInstall 08:05:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for mozleak 08:05:50 INFO - Running setup.py install for mozlog 08:05:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:50 INFO - Running setup.py install for moznetwork 08:05:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Running setup.py install for mozprocess 08:05:51 INFO - Running setup.py install for mozprofile 08:05:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Running setup.py install for mozrunner 08:05:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Running setup.py install for mozscreenshot 08:05:51 INFO - Running setup.py install for moztest 08:05:51 INFO - Running setup.py install for mozversion 08:05:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:51 INFO - Cleaning up... 08:05:51 INFO - Return code: 0 08:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:51 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 08:05:51 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 08:05:51 INFO - Using env: {'DISPLAY': ':0', 08:05:51 INFO - 'HOME': '/home/cltbld', 08:05:51 INFO - 'LANG': 'en_US.UTF-8', 08:05:51 INFO - 'LANGUAGE': 'en_US:en', 08:05:51 INFO - 'LOGNAME': 'cltbld', 08:05:51 INFO - 'MAIL': '/var/mail/cltbld', 08:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:51 INFO - 'MOZ_NO_REMOTE': '1', 08:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:51 INFO - 'NO_EM_RESTART': '1', 08:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:51 INFO - 'PWD': '/builds/slave/test', 08:05:51 INFO - 'SHELL': '/bin/bash', 08:05:51 INFO - 'SHLVL': '1', 08:05:51 INFO - 'TERM': 'linux', 08:05:51 INFO - 'TMOUT': '86400', 08:05:51 INFO - 'USER': 'cltbld', 08:05:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:51 INFO - '_': '/tools/buildbot/bin/python'} 08:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:51 INFO - Running setup.py (path:/tmp/pip-Dhb09M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:51 INFO - Running setup.py (path:/tmp/pip-bHhDq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:52 INFO - Running setup.py (path:/tmp/pip-jF4lnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:52 INFO - Running setup.py (path:/tmp/pip-9QifCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:52 INFO - Running setup.py (path:/tmp/pip-EIK2W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:52 INFO - Running setup.py (path:/tmp/pip-jMcWMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:52 INFO - Running setup.py (path:/tmp/pip-CVRhMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:52 INFO - Running setup.py (path:/tmp/pip-zDdI1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:52 INFO - Running setup.py (path:/tmp/pip-y04lfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:52 INFO - Running setup.py (path:/tmp/pip-ulkxGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:52 INFO - Running setup.py (path:/tmp/pip-rb95o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:52 INFO - Running setup.py (path:/tmp/pip-ahFyB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:52 INFO - Running setup.py (path:/tmp/pip-AblekF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:52 INFO - Running setup.py (path:/tmp/pip-a4NDoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:52 INFO - Running setup.py (path:/tmp/pip-X4HQPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:52 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)) 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:53 INFO - Running setup.py (path:/tmp/pip-h_6FfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:53 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)) 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:53 INFO - Running setup.py (path:/tmp/pip-God348-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:53 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)) 08:05:53 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)) 08:05:53 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)) 08:05:53 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)) 08:05:53 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)) 08:05:53 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)) 08:05:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:53 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 08:05:53 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 08:05:53 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 08:05:53 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 08:05:53 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 08:05:53 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 08:05:55 INFO - Downloading blessings-1.6.tar.gz 08:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:55 INFO - Installing collected packages: blessings 08:05:55 INFO - Running setup.py install for blessings 08:05:55 INFO - Successfully installed blessings 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:55 INFO - Reading from file tmpfile_stdout 08:05:55 INFO - Current package versions: 08:05:55 INFO - argparse == 1.2.1 08:05:55 INFO - blessings == 1.6 08:05:55 INFO - blobuploader == 1.2.4 08:05:55 INFO - docopt == 0.6.1 08:05:55 INFO - manifestparser == 1.1 08:05:55 INFO - mozInstall == 1.12 08:05:55 INFO - mozcrash == 0.17 08:05:55 INFO - mozdebug == 0.1 08:05:55 INFO - mozdevice == 0.48 08:05:55 INFO - mozfile == 1.2 08:05:55 INFO - mozhttpd == 0.7 08:05:55 INFO - mozinfo == 0.9 08:05:55 INFO - mozleak == 0.1 08:05:55 INFO - mozlog == 3.1 08:05:55 INFO - moznetwork == 0.27 08:05:55 INFO - mozprocess == 0.22 08:05:55 INFO - mozprofile == 0.28 08:05:55 INFO - mozrunner == 6.11 08:05:55 INFO - mozscreenshot == 0.1 08:05:55 INFO - mozsystemmonitor == 0.0 08:05:55 INFO - moztest == 0.7 08:05:55 INFO - mozversion == 1.4 08:05:55 INFO - psutil == 3.1.1 08:05:55 INFO - requests == 1.2.3 08:05:55 INFO - wsgiref == 0.1.2 08:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:55 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')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:55 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 08:05:55 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 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:55 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')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:55 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 08:05:55 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 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 INFO - Downloading/unpacking jsonschema 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:55 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 08:05:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:57 INFO - Downloading/unpacking functools32 (from jsonschema) 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:57 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 08:05:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:58 INFO - warning: no files found matching '*.txt' 08:05:58 INFO - no previously-included directories found matching 'build' 08:05:58 INFO - no previously-included directories found matching 'dist' 08:05:58 INFO - no previously-included directories found matching '.git*' 08:05:58 INFO - Installing collected packages: jsonschema, functools32 08:05:58 INFO - Running setup.py install for functools32 08:05:58 INFO - warning: no files found matching '*.txt' 08:05:58 INFO - no previously-included directories found matching 'build' 08:05:58 INFO - no previously-included directories found matching 'dist' 08:05:58 INFO - no previously-included directories found matching '.git*' 08:05:58 INFO - Successfully installed jsonschema functools32 08:05:58 INFO - Cleaning up... 08:05:58 INFO - Return code: 0 08:05:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:58 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 0x7fdad7cc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', '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 08:05:58 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 08:05:58 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 08:05:58 INFO - Using env: {'DISPLAY': ':0', 08:05:58 INFO - 'HOME': '/home/cltbld', 08:05:58 INFO - 'LANG': 'en_US.UTF-8', 08:05:58 INFO - 'LANGUAGE': 'en_US:en', 08:05:58 INFO - 'LOGNAME': 'cltbld', 08:05:58 INFO - 'MAIL': '/var/mail/cltbld', 08:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:58 INFO - 'MOZ_NO_REMOTE': '1', 08:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:58 INFO - 'NO_EM_RESTART': '1', 08:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:58 INFO - 'PWD': '/builds/slave/test', 08:05:58 INFO - 'SHELL': '/bin/bash', 08:05:58 INFO - 'SHLVL': '1', 08:05:58 INFO - 'TERM': 'linux', 08:05:58 INFO - 'TMOUT': '86400', 08:05:58 INFO - 'USER': 'cltbld', 08:05:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:58 INFO - '_': '/tools/buildbot/bin/python'} 08:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:58 INFO - Downloading/unpacking flake8 08:05:58 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 08:05:58 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 08:05:58 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 08:05:58 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 08:05:58 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 08:05:58 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 08:06:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:06:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:06:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:00 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 08:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:01 INFO - no previously-included directories found matching 'docs/_build' 08:06:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:06:01 INFO - Running setup.py install for pep8 08:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:01 INFO - no previously-included directories found matching 'docs/_build' 08:06:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:06:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:06:01 INFO - Cleaning up... 08:06:01 INFO - Return code: 0 08:06:01 INFO - Running post-action listener: _resource_record_post_action 08:06:01 INFO - Running post-action listener: _start_resource_monitoring 08:06:01 INFO - Starting resource monitoring. 08:06:01 INFO - ##### 08:06:01 INFO - ##### Finished create-virtualenv step (success) 08:06:01 INFO - ##### 08:06:01 INFO - ##### 08:06:01 INFO - ##### Running install step. 08:06:01 INFO - ##### 08:06:01 INFO - Running pre-action listener: _resource_record_pre_action 08:06:01 INFO - Running main action method: install 08:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:01 INFO - Reading from file tmpfile_stdout 08:06:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:01 INFO - Reading from file tmpfile_stdout 08:06:01 INFO - Output received: 08:06:01 INFO - Usage: mozinstall [options] installer 08:06:01 INFO - Options: 08:06:01 INFO - -h, --help show this help message and exit 08:06:01 INFO - -d DEST, --destination=DEST 08:06:01 INFO - Directory to install application into. [default: 08:06:01 INFO - "/builds/slave/test"] 08:06:01 INFO - --app=APP Application being installed. [default: firefox] 08:06:01 INFO - mkdir: /builds/slave/test/build/application 08:06:01 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'] 08:06:01 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 08:06:18 INFO - Reading from file tmpfile_stdout 08:06:18 INFO - Output received: 08:06:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:06:18 INFO - Running post-action listener: _resource_record_post_action 08:06:18 INFO - ##### 08:06:18 INFO - ##### Finished install step (success) 08:06:18 INFO - ##### 08:06:18 INFO - ##### 08:06:18 INFO - ##### Running run-tests step. 08:06:18 INFO - ##### 08:06:18 INFO - Running pre-action listener: _resource_record_pre_action 08:06:18 INFO - Running main action method: run_tests 08:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:18 INFO - Python 2.7.3 08:06:18 INFO - Return code: 0 08:06:18 INFO - grabbing minidump binary from tooltool 08:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4b9c0>, '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 0xe4c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:18 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 08:06:18 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 08:06:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:18 INFO - Return code: 0 08:06:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:06:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:06:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:06:19 INFO - Return code: 0 08:06:19 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/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:06:19 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/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 08:06:19 INFO - Using env: {'DISPLAY': ':0', 08:06:19 INFO - 'HOME': '/home/cltbld', 08:06:19 INFO - 'LANG': 'en_US.UTF-8', 08:06:19 INFO - 'LANGUAGE': 'en_US:en', 08:06:19 INFO - 'LOGNAME': 'cltbld', 08:06:19 INFO - 'MAIL': '/var/mail/cltbld', 08:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:19 INFO - 'MOZ_NO_REMOTE': '1', 08:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:19 INFO - 'NO_EM_RESTART': '1', 08:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:19 INFO - 'PWD': '/builds/slave/test', 08:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:19 INFO - 'SHELL': '/bin/bash', 08:06:19 INFO - 'SHLVL': '1', 08:06:19 INFO - 'TERM': 'linux', 08:06:19 INFO - 'TMOUT': '86400', 08:06:19 INFO - 'USER': 'cltbld', 08:06:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506', 08:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:19 INFO - '_': '/tools/buildbot/bin/python'} 08:06:19 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/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:06:19 INFO - mozversion application_buildid: 20160509053032 08:06:19 INFO - mozversion application_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 08:06:19 INFO - mozversion application_display_name: Nightly 08:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:19 INFO - mozversion application_name: Firefox 08:06:19 INFO - mozversion application_remotingname: firefox 08:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:19 INFO - mozversion application_vendor: Mozilla 08:06:19 INFO - mozversion application_version: 49.0a1 08:06:19 INFO - mozversion platform_buildid: 20160509053032 08:06:19 INFO - mozversion platform_changeset: da2b27e1aabd9e23870c09072753faba6ad0a42d 08:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:19 INFO - mozversion platform_version: 49.0a1 08:06:19 INFO - using testdate: 1462806379 08:06:19 INFO - actual date: 1462806379 08:06:19 INFO - starting webserver on 'localhost:58004' 08:06:19 INFO - SUITE-START | Running 2 tests 08:06:19 INFO - TEST-START | dromaeo_css 08:06:19 INFO - operating with platform_type : linux_ 08:06:19 INFO - Initialising browser for dromaeo_css test... 08:06:19 INFO - TEST-INFO | started process 17609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMBTpA/profile http://localhost:58004/getInfo.html) 08:06:23 INFO - PROCESS | 17609 | 08:06:23 INFO - PROCESS | 17609 | (process:17679): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:23 INFO - PROCESS | 17609 | __metrics Screen width/height:1600/1200 08:06:23 INFO - PROCESS | 17609 | colorDepth:24 08:06:23 INFO - PROCESS | 17609 | Browser inner width/height: 1024/697 08:06:23 INFO - PROCESS | 17609 | __metrics 08:06:24 ERROR - PROCESS | 17609 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 08:06:25 INFO - TEST-INFO | 17609: exit 0 08:06:25 INFO - Browser initialized. 08:06:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:25 INFO - TEST-INFO | started process 17730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMBTpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:27 INFO - PROCESS | 17730 | 08:06:27 INFO - PROCESS | 17730 | (process:17793): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:37 INFO - PROCESS | 17730 | RSS: Main: 163426304 08:06:37 INFO - PROCESS | 17730 | 08:07:26 INFO - PROCESS | 17730 | 1462806446971 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] 08:09:34 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58004/tests/dromaeo/cssquery-ext.html) 08:09:35 INFO - PROCESS | 17730 | RSS: Main: 166219776 08:09:35 INFO - PROCESS | 17730 | 08:12:37 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-ext.html (next: http://localhost:58004/tests/dromaeo/cssquery-jquery.html) 08:12:38 INFO - PROCESS | 17730 | RSS: Main: 166203392 08:12:38 INFO - PROCESS | 17730 | 08:15:40 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58004/tests/dromaeo/cssquery-mootools.html) 08:15:41 INFO - PROCESS | 17730 | RSS: Main: 167182336 08:15:41 INFO - PROCESS | 17730 | 08:18:42 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58004/tests/dromaeo/cssquery-prototype.html) 08:18:43 INFO - PROCESS | 17730 | RSS: Main: 164732928 08:18:43 INFO - PROCESS | 17730 | 08:21:45 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58004/tests/dromaeo/cssquery-yui.html) 08:21:46 INFO - PROCESS | 17730 | RSS: Main: 165322752 08:21:46 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:58004/tests/dromaeo/cssquery-yui.html (next: http://localhost:58004/tests/dromaeo/cssquery-dojo.html) 08:24:48 INFO - PROCESS | 17730 | RSS: Main: 167604224 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | __start_tp_report 08:24:48 INFO - PROCESS | 17730 | _x_x_mozilla_page_load 08:24:48 INFO - PROCESS | 17730 | _x_x_mozilla_page_load_details 08:24:48 INFO - PROCESS | 17730 | |i|pagename|runs| 08:24:48 INFO - PROCESS | 17730 | |0;dojo.html;3193.409219294431;3218.7103160715533;3225.4033003894297;3245.0589329094564;3272.640009598944;5545.833624991252;5552.86117847054;5595.972020139893;5613.775448982041;5663.377028526858;5488.451154884509;5582.720863956806;5628.465295796893;5641.5204707599905;5667.149927510875;5008.749562521868;5062.493750624945;5171.870703232412;5190.8702282443055;5201.219817027439;741.2213841169934;4964.304997300381;5056.873578160538;5093.719845408501;5095.184770436731;5061.19020956647;5082.08522465956;5099.515546023141;5110.667806592578;5118.9488105119035;5111.6677415968215;5111.821086261963;5112.41207261166;5120.667156634807;5121.718305493197;4982.103221420143;5016.698998060092;5046.142155833517;5049.116404629175;5081.568066714333;5513.531349835269;5554.0835762099205;5591.832245032656;5598.44015598441;5609;5834.474897259224;6041.72812223451;6077.544184186204;6087.295557243979;6099.664518451484;6025;6032.27612686476;6053.545984051169;6111.113888486189;6147.969260153715;5688.772449102073;5695.914561281543;5703.657780533182;5705.828825135211;5705.885882282372;6062.9996050652035;6070.6357618543025;6250;6252.124702541648;6254.15568898202;5786.508146807484;5808.099744539603;5808.738606762706;5824.941750582525;5864.853378665567;5956.255468066492;5966.343702192756;5968.582199246011;5969.3732158122775;5977.043673012384;5861.179434879035;5929.229200203946;5933.940660593339;5959.970200148971;6010.729517171738;5977.581569290195;6014.7594096236535;6042.425969532887;6049.425304596057;6054.152418661391;4524.932126018112;4546.931796023062;4550.772461376918;4580.061087477059;4623.144718227139;3936.645701886844;3993.0815912340327;4025.6175663311938;4038.2932986727205;4052.6555242804693;5628.212050312959;5630.690312032878;5680.176374425685;5734.996375634248;5788;6107.419795119546;6120;6123.08153776937;6124.755009799558;6128;5613.270274864323;5739.799107031234;5789.45000224978;5825.067989121805;5883.235179426647;5093.159628661304;5114.079465696136;5143.408508021551;5159.509846564571;5181.06740786662;6039.516838652898;6345.17512723343;6356;6372.426481616677;6382.457491113215;5934.554908381975;6019.789307374221;6031.607945483705;6068.6358818471035;6080.300765412034;6235.705904580055;6243.406876346739;6276.058591211355;6311.116443697794;6330.905036424365;5839.328477225174;5948.851278718067;5995.520358371233;5999.970000149971;6004.369541198112;6029.487493563096;6063.151158837678;6081.847953801191;6094.25973485117;6132.816015519542;5861.472467477947;5880.647161170344;5895.557833162444;5904.409559044061;5930.851728706644;5660.886782264414;5764.481196692318;5772.855678608068;5823.242978412779;5875.471207591338;5780.537556995346;5792.4497172768515;5793.246877905845;5799.3040835100055;5822.854428639318;5902.704864756659;5938.346781853907;5941.940580594139;5952.0476723724;5960.880782384242;5675.971620141873;5781.306243250669;5808.767649293981;5823.330317013429;5846.035404158266 08:24:48 INFO - PROCESS | 17730 | |1;ext.html;589.6049646736686;626.9592476489028;645.1033064040984;652.302036820602;671.2180309938922;36876;41755.37366939498;41865.37201941973;41987;42088.789556052216;43327.78336108315;43994.12011759763;44086;44087;44120.55879441205;8737.169968852964;8820.911790882074;8888.511131887744;8889.377743557954;8931.732048038537;8720.781980450476;8736.475811451333;8791.560421978875;8843.690470833522;8847.513386763725;8854.203121719043;8874.645014199457;8917.68788092417;8925.821483570324;8951.149640784148;8797.692080777175;8851.911480885205;8864.113588641085;8867.911320886806;8870.512121833297;8708.21626053652;8751.212390884788;8848.46909185451;8854.778630534223;8873.11268873114;37442.62557374419;40557.18885622301;40783.796081019405;40869.591304086876;40913;3472.1493234157792;3519.137811236238;3533.3993221152464;3622;3946.2699400610977;30651.38697226043;32181.35637287241;32805.507917381256;33881.491777623356;34101.31797364064;4340.414044104037;4346.76092814895;4365.716228445141;4374;4486.394336764528;321182;333838;334429;334622;335014.99999999756;33238.16904577405;64281.357186428475;65502.34497655058;65600.6719966397;65610.34389656138;36509.26981460356;38550.42174367387;38721.61278387236;38792.418113728316;39178.6082139175;15380.154091525073;15671.981321214085;15672;15690.372385104469;15702.76445853313;12680.873191267969;12702.745945081047;12779.297138657463;12826;12829.037822163189;8839.46963182211;8910.376273660911;8914.86627700585;8939.910600894038;9017.594208260643;3462.058572562047;3511.455724362728;3549.3140758139675;3567.714582833367;3570.6607872252093;1021.9029192226726;1076.9730756730987;1085.880553139154;1200.6818193178815;1200.9519619215134;30061.699383006326;31231.84384078065;31353.843230784158;32774;33223.83388083093;1114.1699433921617;1159.1227344532526;1190.7618476304601;1236.9257844529357;1326.7047857914258;16497.257623406975;16608.83391166097;16661.166941652868;16823.327066917187;16855.325786968384;489948;516319;523357;524263;868506;58584.70707646434;58868.4113158863;59741.40258597445;59833.10250346248;60010;1500.3623460029662;1503.5564508470027;1504.1351223046793;1507.6758496922994;1515.1969456188237;33115.50326745149;33213.9326222291;33478.4978225322;33504.16239593932;33809;52330.47669523256;53291;53342.466575335304;53671.46328536665;53727;466639;468950;470096;470474;470813;44303.33544996763;44650;45152.32271515996;45641.77179114083;45868.77065614651;49883.75058124686;49959;50112.24831627601;50160.24759628536;51087;40882;41434;41846;42201.78899105485;43040.569594303655;40589.79705101574;40827;40863;42197.15605687931;42312.78843605762;38191;42933.35599966066;42987.35518967156;43024.56975430206;43131.568684314014;36101.27797444089;36541.91258573905;36682.44976325411;37360;37387.62612373842;28517.720462147117;29205.41589168247;29278.853605732686;29515.85242073776;29555.704442955295 08:24:48 INFO - PROCESS | 17730 | |2;jquery.html;408.3624665092978;408.89164371441575;412.75028607692343;418.37870761918566;422.82875435448636;17965.55086122846;19689.901550492246;19732.210711571537;19932.402027939148;20803.895980520116;19039.333623323186;19544.218231270766;20057.498562535908;20107.497312567193;20176.89911550444;5547.140193270049;5906.173135760997;5944.405559444064;5944.821655350324;5950.285965684124;5609.551235901118;5799.971000144993;5870.647761134324;5890.734916928748;5893.410658934094;5833.766649334043;5840.6787626680725;5863;5872;5878.617889837168;5786.305643322808;5797.36229014808;5848.824535263928;5856.150858125569;5936.287645482526;5241.3710354757295;5273.947260527384;5280.498352656491;5287.788488460457;5315.202719592054;22480.437989050406;23412;23475.882620586788;23481.7651823483;23603.88198059016;2232.441889527618;2381.416552944522;2477.9876100619563;2500.8124390670773;2804.0886711818534;10356.378617282911;10657.626983055556;10764.515596798085;10851.51168197433;10871.891281087246;1953.8534609904173;1988.5823976964855;2163.9783602163934;2173.804357607807;2186.2602107610555;60151.99999999956;69236;71888.6405567974;73260.26739732588;75231.24768752298;10748.408837514013;11248.94375528117;11277.548898043986;11358.602448914413;11446.427678616035;15934.60163495922;15956.680866382607;16027.278772455267;16045.358185672676;16194.352225910832;7882.330001949784;8014;8173.060098088677;8221.301189398848;8266.04940431846;7624.656890439944;7685;7737.419693523008;7822.726204582926;7822.960885195537;4745.881352966204;4888.804447822047;4894.3147959285725;4943.456219815817;4967.05625931072;1933.1397528100142;1955.8044195580612;1989.5225145964864;1997.9001049947444;2001.8198362147186;912.1790388650268;1007.5365331947386;1013.761765984993;1019.1744686803713;1099.9230053896151;17615.471535853943;19026.238950442104;19484.902575487315;19691.704624430644;19915.900420497805;1017.7099526635021;1025.436010194405;1026.8408396698524;1098.8956049175315;1132.8527291452224;10502.947485262677;11097.944510277559;11118;11121.110311175087;11181.888181118085;498066;505053;519063;525141;531088;54346;94307.52846235725;94931;97999.51000244953;99447;936.6768464879606;1027.4708525109575;1077.106002018323;1077.8275475923815;1087.1465899269035;17289.654206916042;17363.652726945136;17750.556236094202;18005.639887202444;18057.909710451364;29219.561706573993;36689.26621467609;37342.8132859334;41224;44538.55461445344;55283.17075243794;57271;58661.70669146627;58832.4116758844;59530;8861.424007439497;8996.59515321799;9001.144891235323;9020.954895225483;9410.011948745283;10071.496425178859;13508.459661613819;13791.862081379459;14018.789718154032;14096.929515352358;12133.69665758363;12233.571824986082;12418.254904705747;12538.373081346079;12601.936990314989;12045.217060891015;12346.75306493883;12426.937865310616;12520.49918003306;12639.87360126387;12264.632061038183;12332.50669973191;12398.442070107047;12494.625161245178;12896.548620798227;7543.47195696296;7883.093444253984;7948.046234451903;8121.228483294078;9221.86167207479;11731.88268117308;12095.879041209475;12264.816027759412;12266.570670026505;12267.386630668252 08:24:48 INFO - PROCESS | 17730 | |3;mootools.html;1577.4794317875098;1605.3016937632128;1779.8754087213892;1850.2044121027952;1865.1793210987173;7929.326007289373;8408.411411201218;8439.746807595766;9068.41055331403;9090.2273306769;8433.072362040171;8690;8692.30461563075;8741.562921853914;8778.561071946393;2341.964870526939;2346.554154710608;2363.61000434928;2375.774301441369;2377.9286621401384;2334.2063698342645;2364.3143488388346;2404.266698656909;2408.157144999254;2408.1812183857487;2337.532493501298;2339.5671800716837;2342.0865862313713;2368.4197371643972;2378.82158838087;2342.390978345625;2344.355302291875;2348.9295321140307;2354.0348457132577;2380.4643955110137;2186.2238905188588;2329.429289823987;2348.2250857217077;2358.929232123039;2360;8627.094155113686;8654.524001179932;8711.520866352348;8715.128487151298;8717.215450609476;5205.791768329263;5296.549793267577;5329.973350133263;5339.439358867302;5340.91988620171;3348.4475061614803;3494.5631796025496;3497.300539892032;3502.8248587570774;3542.6103128655827;1067.834485654717;1113.7494063835654;1126.7690123524658;1160.9477573509212;1167.2762887010024;12313.322767247797;12348.444320005621;12389.690257743538;12424.192427492184;12448.066395020409;4567.406237189144;4588.908221835544;4701.294805779161;4733.502982186889;4756.619470442356;9850.064243896819;9877.851832222523;9881.555330010167;9897.505124743733;9897.950510247403;5302.072137376021;5318.25544423781;5336.0661884170895;5382.327209098863;5408.78364865401;4507.391502147234;4861.319415281863;4941.061198372297;4963.230699241623;4991.975040124848;3882.281777871103;3897.8051097445014;3978.622030907059;4005.239004589177;4012.739171953872;1181.7163880668577;1185.318441895896;1198.6224339333082;1207.2454715802623;1229.170310040719;848.2026894718945;977.4184360305607;977.9902200978041;987.6395115782831;989.6734077754323;5792.565557583198;6019.729112189962;6087.786927457518;6190.3190649028575;6399.552031357854;1018.3177271228295;1053.6786280184617;1055.7571758495435;1065.760203954104;1075.4300220882944;4085.6935729820384;4361.9749358900635;4366.170427618742;4415.801288942005;4435.822567097344;10347.534360953776;10575.259731818698;10836.187285953585;10859.674209773719;10874;10634.946825265824;10691.037806597444;10758.354498730101;10771.569137234423;10798.028177464066;8071.4753541019645;8277.875831862528;8325.583720813935;8344.415890887702;8447.831043379221;6181.5363847710705;6225.3774622539195;6239.313675495782;6268.27914789805;6269.811905642838;9915.157211636802;10025.849612255675;10093.596256149673;10216.182705383402;10289.176865850864;10283.382997020202;10346.430946298025;10526.631567895087;10551.050405463546;10564.260501764802;7141.143062832493;7858.803529911569;7877.448578599443;7885.093214280431;8077;8775.824483510167;8810.383273170817;8882.511461869659;8920.598573064099;8928;7842.176571460142;8001.599920004093;8013.559254241072;8074.293051449861;8121.675132994614;7798.961005194938;7865.921340786519;7922.366210703015;7933.206679332021;7988.320992715684;7291.598962057138;7330.157031941395;7378.483506154517;7423.962880185564;7476.065491813523;5456.863578410572;5467;5506.449355064461;5559.499645031967;5564.693941833238;5352.795620985247;5390.407055224001;5537.307836520435;5571.66570005801;5692.971535142297 08:24:48 INFO - PROCESS | 17730 | |4;prototype.html;336.5540658627319;336.86424176337727;339.48927273632336;346.9340825243205;347.22741899274104;5517.393086760459;5582.553395728347;5609.298837645294;5631.57763167762;5658.869025611306;5451.836444906659;5483.616146869721;5530.419305972875;5547.916781248285;5565.220869078333;4089.161721847029;4258.872233832974;4273.2735434975975;4283.329501494404;4331.242032644291;4216.852410165645;4307.33236348365;4316.892077698051;4323.654107671395;4345.174416860802;4270.444842170529;4278.358246263055;4291.120320334339;4309.965608254012;4323.697341186103;4296.591823776736;4308.9569104309185;4313.849015284466;4315.30955047194;4332.573758695125;3553.7157027437743;3731.768516389585;3734.9439758403646;3736.6263373662687;3748.737588368815;5381.385584324726;5413.566914646819;5436.565074794007;5470.152126420371;5490.752916118784;4931.950680493185;4951.752412379366;4955.925661115086;4957.479464656195;4979.253112033188;5648.632838865502;5726.770929162829;5780.1907732917425;5798.82603521895;5816.592838501307;4106.1582375612925;4114.691398145121;4115.135821477494;4134.400511925784;4161.56303588122;5780.71096445176;5987.6108052976415;5996.340402555716;6044.1263208405535;6115.296740874812;4117;4119.155573107506;4129.245070844939;4132.8140233689555;4143.647789937889;4026.416169655442;4135.97932010338;4152.335626299838;4168.43726096973;4184.686148538872;4801.855944321676;4815.903681926412;4822.276658501253;4848.224284114524;4864.586510146606;5455.509004189642;5765.135229715493;5812.715815564193;5910.615809972338;5916.822495325147;1451.484722923368;1459.8102246708072;1469.1992863889207;1472.6539263273123;1480.4078368652624;967.9467629280316;968.9806203875883;995.7560397702609;1001.5893483671805;1009.9597414662909;5397.919031214535;5582.860428489239;5677.744501497443;5712.800311934458;5723.742431590588;6009.819705408845;6056.454919057306;6098.939010609926;6106.328303886569;6108.816735497942;5525.944740552623;5663.584103974006;5691.089425691869;5699.572532060112;5706.9429305707245;3105.3013072058607;3114.3304189599344;3138.905832825019;3143.339898621269;3185.3151572412044;5939.524838012949;6038;6047.667378294236;6051.364606716232;6073.939260607337;5669.052092911746;6061.939380606137;6070.332263451017;6090.208272924491;6102.298235702862;6014.556506438511;6030;6066.603691541816;6152.062100438347;6185.567010309235;5558.694271815089;5818.94181058201;5875.618084824473;5944.286685597756;5956.910646340221;5852.912206316823;5880.323762767336;5893.261487861006;5907.877503274364;5918.585699001029;5757.169342432205;6074.453299203093;6117.3576774439825;6177.752889884354;6184.907226391518;4040.535338436;4106.2198182345255;4112.157007813331;4131.834726611022;4132.91734165321;5851.97590421666;5873.883962047197;5876;5920;5955.5235581154275;5585.497305242548;5721.22763426932;5763.827085187451;5803.303603567599;5816.3892791258;5679.37526872052;5701.458361455655;5719.914201287067;5732.971335143297;5745.850829834134;5478.958997790407;5505.807296744595;5620.4098569649595;5639.943600564106;5668.178114173505;5604.2154098425435;5673.631213971079;5827.825165245049;5858.7070646468355;5883.676397797991;5642.830715078554;5675.432456754292;5693.402192769865;5713.457221563945;5771.1920331154515 08:24:48 INFO - PROCESS | 17730 | |5;yui.html;777.1684297801352;784.1844481738992;788.9802754931129;877.8814859993906;900.315760022383;13414.530491432803;13966.23185724786;14397.208153551577;14499.130052196862;14510.492132775355;13353.796623557102;13418.73162536751;13430.66423339417;13443.26062066586;13449.462021519152;705.8764716174675;848.6266042941118;874.54960695242;876.5398165962889;876.5836227791812;849.70685113636;859.5959898847532;861.2162931732125;864.1142828600703;864.8140649760301;898.6360523987795;899.9055099214586;900.0279697926256;902.2736696958946;904.3217586809892;892.0588778838323;893.8927328720563;894.7315805258462;896.0233345653269;896.66375109334;650.2392201124695;652.0610321137547;652.0870780906721;654.3489228217906;655.1483072006421;14173.503927362595;14240.928795355956;14249.430022799075;14322.85677143236;14329.928350358286;13851.099678520965;14110.929445352707;14176.645583860383;14263.928680356636;14350.928245358811;11462.598809041727;11621.941890290494;11706.941465292704;11739.178257521977;11842.407879605986;3831.770093794353;3849.4610754494392;3932.233214523169;4036.9596304037173;4065.7560546367313;51637.22544161841;51661.74169129168;53375.199372009454;53589.196162057604;54336.184957225276;11225.94387028076;11265.774684506265;11281.71795705114;11294.096472282197;11429.314241145392;19537.609247814966;19552.41342759691;19567;19580.510487237934;20143;8443.36674749384;8503.914960850312;8533.232009119085;8621.353398495137;8716.607752651145;4890.095332363453;4914.238293064581;4985.152524070917;5020.221865610836;5022.121128802518;3279.721223695965;3367.7642565020706;3372.1906742381652;3382.255903701182;3385;596.5287422935919;609.5702529716539;655.1842955520408;659.7427003468651;662.5627086123136;668.3784080804899;709.9538529995534;731.7621772923821;731.9642705571663;736.7716008037526;8669.479831210148;9062.093790621017;9365.672201472917;9433.812356615752;9440.905590944003;742.2503271695626;742.6138408027796;750.1748077115129;750.7897788619196;767.4972892755254;4213.262679031157;4281.935770963438;4283.678724095706;4314.331278651814;4384.649228061748;57763.711181443825;58232;58666.41333586695;58668.11997820036;58688.119678204865;50871.49128508742;51232.74383628058;51534;51961.220581691305;53294.73352633289;47836.5216347839;47966.52033479621;48517.757411213424;49125.75437122863;50044;7970.242826931432;8025.879611805711;8093.312068474245;8208.794780130545;8332.833343333221;31888.5216721754;32257.99999999906;32366.19084522906;32843.83578082094;33203;38924.80537597294;42058;42517.14965700731;42649;43069.35395969126;10832.24174307791;11313.434328283389;12073.27560346347;12100.092493063232;12424.75150497003;12230.510779569073;12288.815667764811;12662.430190641628;12947.5468358607;13085.41115649817;11547.653570392902;11731;11735;11778.645455772696;11790.469428875549;11642.883571164519;11778.646640600795;11881.881181188077;12089.637310880687;12116.636500904988;11833.171677982802;11895.464704088165;11983.400829958293;11986.64040078799;12075.154739168174;9604.519774011133;9676.612935482503;10093.394396336244;10226.744331391776;10664.200184986003;10075.34510256831;10463.11063559606;10478.161747060369;10507.474626268504;10554.841677374692 08:24:48 INFO - PROCESS | 17730 | __end_tp_report 08:24:48 INFO - PROCESS | 17730 | __start_cc_report 08:24:48 INFO - PROCESS | 17730 | _x_x_mozilla_cycle_collect,344 08:24:48 INFO - PROCESS | 17730 | __end_cc_report 08:24:48 INFO - PROCESS | 17730 | __startTimestamp1462807488978__endTimestamp 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | ------- Summary: start ------- 08:24:48 INFO - PROCESS | 17730 | Number of tests: 6 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#0] dojo.html Cycles:165 Average:5558.58 Median:5808.10 stddev:757.06 (13.0%) stddev-sans-first:736.30 08:24:48 INFO - PROCESS | 17730 | Values: 3193.4 3218.7 3225.4 3245.1 3272.6 5545.8 5552.9 5596.0 5613.8 5663.4 5488.5 5582.7 5628.5 5641.5 5667.1 5008.7 5062.5 5171.9 5190.9 5201.2 741.2 4964.3 5056.9 5093.7 5095.2 5061.2 5082.1 5099.5 5110.7 5118.9 5111.7 5111.8 5112.4 5120.7 5121.7 4982.1 5016.7 5046.1 5049.1 5081.6 5513.5 5554.1 5591.8 5598.4 5609.0 5834.5 6041.7 6077.5 6087.3 6099.7 6025.0 6032.3 6053.5 6111.1 6148.0 5688.8 5695.9 5703.7 5705.8 5705.9 6063.0 6070.6 6250.0 6252.1 6254.2 5786.5 5808.1 5808.7 5824.9 5864.9 5956.3 5966.3 5968.6 5969.4 5977.0 5861.2 5929.2 5933.9 5960.0 6010.7 5977.6 6014.8 6042.4 6049.4 6054.2 4524.9 4546.9 4550.8 4580.1 4623.1 3936.6 3993.1 4025.6 4038.3 4052.7 5628.2 5630.7 5680.2 5735.0 5788.0 6107.4 6120.0 6123.1 6124.8 6128.0 5613.3 5739.8 5789.5 5825.1 5883.2 5093.2 5114.1 5143.4 5159.5 5181.1 6039.5 6345.2 6356.0 6372.4 6382.5 5934.6 6019.8 6031.6 6068.6 6080.3 6235.7 6243.4 6276.1 6311.1 6330.9 5839.3 5948.9 5995.5 6000.0 6004.4 6029.5 6063.2 6081.8 6094.3 6132.8 5861.5 5880.6 5895.6 5904.4 5930.9 5660.9 5764.5 5772.9 5823.2 5875.5 5780.5 5792.4 5793.2 5799.3 5822.9 5902.7 5938.3 5941.9 5952.0 5960.9 5676.0 5781.3 5808.8 5823.3 5846.0 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#1] ext.html Cycles:180 Average:61646.81 Median:41926.19 stddev:128233.31 (305.9%) stddev-sans-first:128511.10 08:24:48 INFO - PROCESS | 17730 | Values: 589.6 627.0 645.1 652.3 671.2 36876.0 41755.4 41865.4 41987.0 42088.8 43327.8 43994.1 44086.0 44087.0 44120.6 8737.2 8820.9 8888.5 8889.4 8931.7 8720.8 8736.5 8791.6 8843.7 8847.5 8854.2 8874.6 8917.7 8925.8 8951.1 8797.7 8851.9 8864.1 8867.9 8870.5 8708.2 8751.2 8848.5 8854.8 8873.1 37442.6 40557.2 40783.8 40869.6 40913.0 3472.1 3519.1 3533.4 3622.0 3946.3 30651.4 32181.4 32805.5 33881.5 34101.3 4340.4 4346.8 4365.7 4374.0 4486.4 321182.0 333838.0 334429.0 334622.0 335015.0 33238.2 64281.4 65502.3 65600.7 65610.3 36509.3 38550.4 38721.6 38792.4 39178.6 15380.2 15672.0 15672.0 15690.4 15702.8 12680.9 12702.7 12779.3 12826.0 12829.0 8839.5 8910.4 8914.9 8939.9 9017.6 3462.1 3511.5 3549.3 3567.7 3570.7 1021.9 1077.0 1085.9 1200.7 1201.0 30061.7 31231.8 31353.8 32774.0 33223.8 1114.2 1159.1 1190.8 1236.9 1326.7 16497.3 16608.8 16661.2 16823.3 16855.3 489948.0 516319.0 523357.0 524263.0 868506.0 58584.7 58868.4 59741.4 59833.1 60010.0 1500.4 1503.6 1504.1 1507.7 1515.2 33115.5 33213.9 33478.5 33504.2 33809.0 52330.5 53291.0 53342.5 53671.5 53727.0 466639.0 468950.0 470096.0 470474.0 470813.0 44303.3 44650.0 45152.3 45641.8 45868.8 49883.8 49959.0 50112.2 50160.2 51087.0 40882.0 41434.0 41846.0 42201.8 43040.6 40589.8 40827.0 40863.0 42197.2 42312.8 38191.0 42933.4 42987.4 43024.6 43131.6 36101.3 36541.9 36682.4 37360.0 37387.6 28517.7 29205.4 29278.9 29515.9 29555.7 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#2] jquery.html Cycles:180 Average:29366.75 Median:23443.94 stddev:84681.71 (361.2%) stddev-sans-first:84891.35 08:24:48 INFO - PROCESS | 17730 | Values: 408.4 408.9 412.8 418.4 422.8 17965.6 19689.9 19732.2 19932.4 20803.9 19039.3 19544.2 20057.5 20107.5 20176.9 5547.1 5906.2 5944.4 5944.8 5950.3 5609.6 5800.0 5870.6 5890.7 5893.4 5833.8 5840.7 5863.0 5872.0 5878.6 5786.3 5797.4 5848.8 5856.2 5936.3 5241.4 5273.9 5280.5 5287.8 5315.2 22480.4 23412.0 23475.9 23481.8 23603.9 2232.4 2381.4 2478.0 2500.8 2804.1 10356.4 10657.6 10764.5 10851.5 10871.9 1953.9 1988.6 2164.0 2173.8 2186.3 60152.0 69236.0 71888.6 73260.3 75231.2 10748.4 11248.9 11277.5 11358.6 11446.4 15934.6 15956.7 16027.3 16045.4 16194.4 7882.3 8014.0 8173.1 8221.3 8266.0 7624.7 7685.0 7737.4 7822.7 7823.0 4745.9 4888.8 4894.3 4943.5 4967.1 1933.1 1955.8 1989.5 1997.9 2001.8 912.2 1007.5 1013.8 1019.2 1099.9 17615.5 19026.2 19484.9 19691.7 19915.9 1017.7 1025.4 1026.8 1098.9 1132.9 10502.9 11097.9 11118.0 11121.1 11181.9 498066.0 505053.0 519063.0 525141.0 531088.0 54346.0 94307.5 94931.0 97999.5 99447.0 936.7 1027.5 1077.1 1077.8 1087.1 17289.7 17363.7 17750.6 18005.6 18057.9 29219.6 36689.3 37342.8 41224.0 44538.6 55283.2 57271.0 58661.7 58832.4 59530.0 8861.4 8996.6 9001.1 9021.0 9410.0 10071.5 13508.5 13791.9 14018.8 14096.9 12133.7 12233.6 12418.3 12538.4 12601.9 12045.2 12346.8 12426.9 12520.5 12639.9 12264.6 12332.5 12398.4 12494.6 12896.5 7543.5 7883.1 7948.0 8121.2 9221.9 11731.9 12095.9 12264.8 12266.6 12267.4 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#3] mootools.html Cycles:180 Average:5876.42 Median:4901.19 stddev:3272.57 (66.8%) stddev-sans-first:3265.81 08:24:48 INFO - PROCESS | 17730 | Values: 1577.5 1605.3 1779.9 1850.2 1865.2 7929.3 8408.4 8439.7 9068.4 9090.2 8433.1 8690.0 8692.3 8741.6 8778.6 2342.0 2346.6 2363.6 2375.8 2377.9 2334.2 2364.3 2404.3 2408.2 2408.2 2337.5 2339.6 2342.1 2368.4 2378.8 2342.4 2344.4 2348.9 2354.0 2380.5 2186.2 2329.4 2348.2 2358.9 2360.0 8627.1 8654.5 8711.5 8715.1 8717.2 5205.8 5296.5 5330.0 5339.4 5340.9 3348.4 3494.6 3497.3 3502.8 3542.6 1067.8 1113.7 1126.8 1160.9 1167.3 12313.3 12348.4 12389.7 12424.2 12448.1 4567.4 4588.9 4701.3 4733.5 4756.6 9850.1 9877.9 9881.6 9897.5 9898.0 5302.1 5318.3 5336.1 5382.3 5408.8 4507.4 4861.3 4941.1 4963.2 4992.0 3882.3 3897.8 3978.6 4005.2 4012.7 1181.7 1185.3 1198.6 1207.2 1229.2 848.2 977.4 978.0 987.6 989.7 5792.6 6019.7 6087.8 6190.3 6399.6 1018.3 1053.7 1055.8 1065.8 1075.4 4085.7 4362.0 4366.2 4415.8 4435.8 10347.5 10575.3 10836.2 10859.7 10874.0 10634.9 10691.0 10758.4 10771.6 10798.0 8071.5 8277.9 8325.6 8344.4 8447.8 6181.5 6225.4 6239.3 6268.3 6269.8 9915.2 10025.8 10093.6 10216.2 10289.2 10283.4 10346.4 10526.6 10551.1 10564.3 7141.1 7858.8 7877.4 7885.1 8077.0 8775.8 8810.4 8882.5 8920.6 8928.0 7842.2 8001.6 8013.6 8074.3 8121.7 7799.0 7865.9 7922.4 7933.2 7988.3 7291.6 7330.2 7378.5 7424.0 7476.1 5456.9 5467.0 5506.4 5559.5 5564.7 5352.8 5390.4 5537.3 5571.7 5693.0 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#4] prototype.html Cycles:180 Average:4855.36 Median:5584.18 stddev:1438.44 (25.8%) stddev-sans-first:1401.91 08:24:48 INFO - PROCESS | 17730 | Values: 336.6 336.9 339.5 346.9 347.2 5517.4 5582.6 5609.3 5631.6 5658.9 5451.8 5483.6 5530.4 5547.9 5565.2 4089.2 4258.9 4273.3 4283.3 4331.2 4216.9 4307.3 4316.9 4323.7 4345.2 4270.4 4278.4 4291.1 4310.0 4323.7 4296.6 4309.0 4313.8 4315.3 4332.6 3553.7 3731.8 3734.9 3736.6 3748.7 5381.4 5413.6 5436.6 5470.2 5490.8 4932.0 4951.8 4955.9 4957.5 4979.3 5648.6 5726.8 5780.2 5798.8 5816.6 4106.2 4114.7 4115.1 4134.4 4161.6 5780.7 5987.6 5996.3 6044.1 6115.3 4117.0 4119.2 4129.2 4132.8 4143.6 4026.4 4136.0 4152.3 4168.4 4184.7 4801.9 4815.9 4822.3 4848.2 4864.6 5455.5 5765.1 5812.7 5910.6 5916.8 1451.5 1459.8 1469.2 1472.7 1480.4 967.9 969.0 995.8 1001.6 1010.0 5397.9 5582.9 5677.7 5712.8 5723.7 6009.8 6056.5 6098.9 6106.3 6108.8 5525.9 5663.6 5691.1 5699.6 5706.9 3105.3 3114.3 3138.9 3143.3 3185.3 5939.5 6038.0 6047.7 6051.4 6073.9 5669.1 6061.9 6070.3 6090.2 6102.3 6014.6 6030.0 6066.6 6152.1 6185.6 5558.7 5818.9 5875.6 5944.3 5956.9 5852.9 5880.3 5893.3 5907.9 5918.6 5757.2 6074.5 6117.4 6177.8 6184.9 4040.5 4106.2 4112.2 4131.8 4132.9 5852.0 5873.9 5876.0 5920.0 5955.5 5585.5 5721.2 5763.8 5803.3 5816.4 5679.4 5701.5 5719.9 5733.0 5745.9 5479.0 5505.8 5620.4 5639.9 5668.2 5604.2 5673.6 5827.8 5858.7 5883.7 5642.8 5675.4 5693.4 5713.5 5771.2 08:24:48 INFO - PROCESS | 17730 | 08:24:48 INFO - PROCESS | 17730 | [#5] yui.html Cycles:180 Average:14298.65 Median:23691.84 stddev:16188.52 (68.3%) stddev-sans-first:16202.09 08:24:48 INFO - PROCESS | 17730 | Values: 777.2 784.2 789.0 877.9 900.3 13414.5 13966.2 14397.2 14499.1 14510.5 13353.8 13418.7 13430.7 13443.3 13449.5 705.9 848.6 874.5 876.5 876.6 849.7 859.6 861.2 864.1 864.8 898.6 899.9 900.0 902.3 904.3 892.1 893.9 894.7 896.0 896.7 650.2 652.1 652.1 654.3 655.1 14173.5 14240.9 14249.4 14322.9 14329.9 13851.1 14110.9 14176.6 14263.9 14350.9 11462.6 11621.9 11706.9 11739.2 11842.4 3831.8 3849.5 3932.2 4037.0 4065.8 51637.2 51661.7 53375.2 53589.2 54336.2 11225.9 11265.8 11281.7 11294.1 11429.3 19537.6 19552.4 19567.0 19580.5 20143.0 8443.4 8503.9 8533.2 8621.4 8716.6 4890.1 4914.2 4985.2 5020.2 5022.1 3279.7 3367.8 3372.2 3382.3 3385.0 596.5 609.6 655.2 659.7 662.6 668.4 710.0 731.8 732.0 736.8 8669.5 9062.1 9365.7 9433.8 9440.9 742.3 742.6 750.2 750.8 767.5 4213.3 4281.9 4283.7 4314.3 4384.6 57763.7 58232.0 58666.4 58668.1 58688.1 50871.5 51232.7 51534.0 51961.2 53294.7 47836.5 47966.5 48517.8 49125.8 50044.0 7970.2 8025.9 8093.3 8208.8 8332.8 31888.5 32258.0 32366.2 32843.8 33203.0 38924.8 42058.0 42517.1 42649.0 43069.4 10832.2 11313.4 12073.3 12100.1 12424.8 12230.5 12288.8 12662.4 12947.5 13085.4 11547.7 11731.0 11735.0 11778.6 11790.5 11642.9 11778.6 11881.9 12089.6 12116.6 11833.2 11895.5 11983.4 11986.6 12075.2 9604.5 9676.6 10093.4 10226.7 10664.2 10075.3 10463.1 10478.2 10507.5 10554.8 08:24:48 INFO - PROCESS | 17730 | -------- Summary: end -------- 08:24:48 INFO - PROCESS | 17730 | 08:24:49 INFO - TEST-INFO | 17730: exit 0 08:24:49 INFO - TEST-OK | dromaeo_css | took 1110179ms 08:24:49 INFO - TEST-START | kraken 08:24:49 INFO - operating with platform_type : linux_ 08:24:49 INFO - Initialising browser for kraken test... 08:24:49 INFO - TEST-INFO | started process 17971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuHlrK/profile http://localhost:58004/getInfo.html) 08:24:53 INFO - PROCESS | 17971 | 08:24:53 INFO - PROCESS | 17971 | (process:18036): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:24:53 INFO - PROCESS | 17971 | __metrics Screen width/height:1600/1200 08:24:53 INFO - PROCESS | 17971 | colorDepth:24 08:24:53 INFO - PROCESS | 17971 | Browser inner width/height: 1024/697 08:24:53 INFO - PROCESS | 17971 | __metrics 08:24:54 ERROR - PROCESS | 17971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 08:24:55 INFO - TEST-INFO | 17971: exit 0 08:24:55 INFO - Browser initialized. 08:24:55 INFO - Running cycle 1/1 for kraken test... 08:24:55 INFO - TEST-INFO | started process 18087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuHlrK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:57 INFO - PROCESS | 18087 | 08:24:57 INFO - PROCESS | 18087 | (process:18146): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:25:07 INFO - PROCESS | 18087 | RSS: Main: 163721216 08:25:07 INFO - PROCESS | 18087 | 08:25:09 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58004/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:10 INFO - PROCESS | 18087 | RSS: Main: 168452096 08:25:10 INFO - PROCESS | 18087 | 08:25:13 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58004/tests/kraken/driver.html?testName=audio-dft) 08:25:14 INFO - PROCESS | 18087 | RSS: Main: 167927808 08:25:14 INFO - PROCESS | 18087 | 08:25:16 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58004/tests/kraken/driver.html?testName=audio-fft) 08:25:17 INFO - PROCESS | 18087 | RSS: Main: 162828288 08:25:17 INFO - PROCESS | 18087 | 08:25:19 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58004/tests/kraken/driver.html?testName=audio-oscillator) 08:25:20 INFO - PROCESS | 18087 | RSS: Main: 163086336 08:25:20 INFO - PROCESS | 18087 | 08:25:22 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:23 INFO - PROCESS | 18087 | RSS: Main: 163663872 08:25:23 INFO - PROCESS | 18087 | 08:25:26 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58004/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:27 INFO - PROCESS | 18087 | RSS: Main: 163033088 08:25:27 INFO - PROCESS | 18087 | 08:25:30 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58004/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:31 INFO - PROCESS | 18087 | RSS: Main: 162066432 08:25:31 INFO - PROCESS | 18087 | 08:25:34 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58004/tests/kraken/driver.html?testName=json-parse-financial) 08:25:34 INFO - PROCESS | 18087 | RSS: Main: 162918400 08:25:34 INFO - PROCESS | 18087 | 08:25:36 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:37 INFO - PROCESS | 18087 | RSS: Main: 163037184 08:25:37 INFO - PROCESS | 18087 | 08:25:38 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:39 INFO - PROCESS | 18087 | RSS: Main: 162983936 08:25:39 INFO - PROCESS | 18087 | 08:25:41 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:42 INFO - PROCESS | 18087 | RSS: Main: 163119104 08:25:42 INFO - PROCESS | 18087 | 08:25:45 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:45 INFO - PROCESS | 18087 | RSS: Main: 162902016 08:25:45 INFO - PROCESS | 18087 | 08:25:48 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:49 INFO - PROCESS | 18087 | RSS: Main: 163463168 08:25:49 INFO - PROCESS | 18087 | 08:25:50 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:58004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58004/tests/kraken/driver.html?testName=ai-astar) 08:25:51 INFO - PROCESS | 18087 | RSS: Main: 164765696 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | __start_tp_report 08:25:51 INFO - PROCESS | 18087 | _x_x_mozilla_page_load 08:25:51 INFO - PROCESS | 18087 | _x_x_mozilla_page_load_details 08:25:51 INFO - PROCESS | 18087 | |i|pagename|runs| 08:25:51 INFO - PROCESS | 18087 | |0;ai-astar;108;114;101;111;111;111;106;110;112;111 08:25:51 INFO - PROCESS | 18087 | |1;audio-beat-detection;159;128;152;211;127;163;156;129;180;134 08:25:51 INFO - PROCESS | 18087 | |2;audio-dft;163;163;163;163;165;174;162;165;163;164 08:25:51 INFO - PROCESS | 18087 | |3;audio-fft;76;76;77;168;76;76;75;75;163;77 08:25:51 INFO - PROCESS | 18087 | |4;audio-oscillator;91;92;174;92;92;92;147;93;102;145 08:25:51 INFO - PROCESS | 18087 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;118 08:25:51 INFO - PROCESS | 18087 | |6;imaging-darkroom;147;146;148;146;146;147;146;146;146;146 08:25:51 INFO - PROCESS | 18087 | |7;imaging-desaturate;95;94;95;95;95;96;96;96;95;95 08:25:51 INFO - PROCESS | 18087 | |8;json-parse-financial;59;59;60;60;65;62;62;60;60;59 08:25:51 INFO - PROCESS | 18087 | |9;json-stringify-tinderbox;58;59;59;60;59;59;59;59;60;59 08:25:51 INFO - PROCESS | 18087 | |10;stanford-crypto-aes;79;78;83;80;79;79;85;79;139;85 08:25:51 INFO - PROCESS | 18087 | |11;stanford-crypto-ccm;129;127;131;127;124;135;137;134;146;134 08:25:51 INFO - PROCESS | 18087 | |12;stanford-crypto-pbkdf2;167;166;165;170;172;168;172;169;165;177 08:25:51 INFO - PROCESS | 18087 | |13;stanford-crypto-sha256-iterative;73;67;74;64;65;66;68;68;64;64 08:25:51 INFO - PROCESS | 18087 | __end_tp_report 08:25:51 INFO - PROCESS | 18087 | __start_cc_report 08:25:51 INFO - PROCESS | 18087 | _x_x_mozilla_cycle_collect,860 08:25:51 INFO - PROCESS | 18087 | __end_cc_report 08:25:51 INFO - PROCESS | 18087 | __startTimestamp1462807551156__endTimestamp 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | ------- Summary: start ------- 08:25:51 INFO - PROCESS | 18087 | Number of tests: 14 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.69 (3.3%) stddev-sans-first:3.87 08:25:51 INFO - PROCESS | 18087 | Values: 108.0 114.0 101.0 111.0 111.0 111.0 106.0 110.0 112.0 111.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:157.50 stddev:26.81 (17.0%) stddev-sans-first:28.37 08:25:51 INFO - PROCESS | 18087 | Values: 159.0 128.0 152.0 211.0 127.0 163.0 156.0 129.0 180.0 134.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:3.47 (2.1%) stddev-sans-first:3.64 08:25:51 INFO - PROCESS | 18087 | Values: 163.0 163.0 163.0 163.0 165.0 174.0 162.0 165.0 163.0 164.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.76 (49.7%) stddev-sans-first:39.49 08:25:51 INFO - PROCESS | 18087 | Values: 76.0 76.0 77.0 168.0 76.0 76.0 75.0 75.0 163.0 77.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:92.00 stddev:31.02 (33.7%) stddev-sans-first:31.96 08:25:51 INFO - PROCESS | 18087 | Values: 91.0 92.0 174.0 92.0 92.0 92.0 147.0 93.0 102.0 145.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:25:51 INFO - PROCESS | 18087 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:25:51 INFO - PROCESS | 18087 | Values: 147.0 146.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:25:51 INFO - PROCESS | 18087 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:1.90 (3.2%) stddev-sans-first:1.92 08:25:51 INFO - PROCESS | 18087 | Values: 59.0 59.0 60.0 60.0 65.0 62.0 62.0 60.0 60.0 59.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 08:25:51 INFO - PROCESS | 18087 | Values: 58.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 59.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:79.50 stddev:18.60 (23.4%) stddev-sans-first:19.52 08:25:51 INFO - PROCESS | 18087 | Values: 79.0 78.0 83.0 80.0 79.0 79.0 85.0 79.0 139.0 85.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:134.00 stddev:6.33 (4.7%) stddev-sans-first:6.59 08:25:51 INFO - PROCESS | 18087 | Values: 129.0 127.0 131.0 127.0 124.0 135.0 137.0 134.0 146.0 134.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:3.78 (2.2%) stddev-sans-first:3.94 08:25:51 INFO - PROCESS | 18087 | Values: 167.0 166.0 165.0 170.0 172.0 168.0 172.0 169.0 165.0 177.0 08:25:51 INFO - PROCESS | 18087 | 08:25:51 INFO - PROCESS | 18087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:3.62 (5.4%) stddev-sans-first:3.20 08:25:51 INFO - PROCESS | 18087 | Values: 73.0 67.0 74.0 64.0 65.0 66.0 68.0 68.0 64.0 64.0 08:25:51 INFO - PROCESS | 18087 | -------- Summary: end -------- 08:25:51 INFO - PROCESS | 18087 | 08:25:52 INFO - TEST-INFO | 18087: exit 0 08:25:52 INFO - TEST-OK | kraken | took 62428ms 08:25:52 INFO - SUITE-END | took 1172s 08:25:52 INFO - Completed test suite (00:19:32) 08:25:52 INFO - javascript benchmark 08:25:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3193.409219294431, 3218.7103160715533, 3225.4033003894297, 3245.0589329094564, 3272.640009598944, 5545.833624991252, 5552.86117847054, 5595.972020139893, 5613.775448982041, 5663.377028526858, 5488.451154884509, 5582.720863956806, 5628.465295796893, 5641.5204707599905, 5667.149927510875, 5008.749562521868, 5062.493750624945, 5171.870703232412, 5190.8702282443055, 5201.219817027439, 741.2213841169934, 4964.304997300381, 5056.873578160538, 5093.719845408501, 5095.184770436731, 5061.19020956647, 5082.08522465956, 5099.515546023141, 5110.667806592578, 5118.9488105119035, 5111.6677415968215, 5111.821086261963, 5112.41207261166, 5120.667156634807, 5121.718305493197, 4982.103221420143, 5016.698998060092, 5046.142155833517, 5049.116404629175, 5081.568066714333, 5513.531349835269, 5554.0835762099205, 5591.832245032656, 5598.44015598441, 5609.0, 5834.474897259224, 6041.72812223451, 6077.544184186204, 6087.295557243979, 6099.664518451484, 6025.0, 6032.27612686476, 6053.545984051169, 6111.113888486189, 6147.969260153715, 5688.772449102073, 5695.914561281543, 5703.657780533182, 5705.828825135211, 5705.885882282372, 6062.9996050652035, 6070.6357618543025, 6250.0, 6252.124702541648, 6254.15568898202, 5786.508146807484, 5808.099744539603, 5808.738606762706, 5824.941750582525, 5864.853378665567, 5956.255468066492, 5966.343702192756, 5968.582199246011, 5969.3732158122775, 5977.043673012384, 5861.179434879035, 5929.229200203946, 5933.940660593339, 5959.970200148971, 6010.729517171738, 5977.581569290195, 6014.7594096236535, 6042.425969532887, 6049.425304596057, 6054.152418661391, 4524.932126018112, 4546.931796023062, 4550.772461376918, 4580.061087477059, 4623.144718227139, 3936.645701886844, 3993.0815912340327, 4025.6175663311938, 4038.2932986727205, 4052.6555242804693, 5628.212050312959, 5630.690312032878, 5680.176374425685, 5734.996375634248, 5788.0, 6107.419795119546, 6120.0, 6123.08153776937, 6124.755009799558, 6128.0, 5613.270274864323, 5739.799107031234, 5789.45000224978, 5825.067989121805, 5883.235179426647, 5093.159628661304, 5114.079465696136, 5143.408508021551, 5159.509846564571, 5181.06740786662, 6039.516838652898, 6345.17512723343, 6356.0, 6372.426481616677, 6382.457491113215, 5934.554908381975, 6019.789307374221, 6031.607945483705, 6068.6358818471035, 6080.300765412034, 6235.705904580055, 6243.406876346739, 6276.058591211355, 6311.116443697794, 6330.905036424365, 5839.328477225174, 5948.851278718067, 5995.520358371233, 5999.970000149971, 6004.369541198112, 6029.487493563096, 6063.151158837678, 6081.847953801191, 6094.25973485117, 6132.816015519542, 5861.472467477947, 5880.647161170344, 5895.557833162444, 5904.409559044061, 5930.851728706644, 5660.886782264414, 5764.481196692318, 5772.855678608068, 5823.242978412779, 5875.471207591338, 5780.537556995346, 5792.4497172768515, 5793.246877905845, 5799.3040835100055, 5822.854428639318, 5902.704864756659, 5938.346781853907, 5941.940580594139, 5952.0476723724, 5960.880782384242, 5675.971620141873, 5781.306243250669, 5808.767649293981, 5823.330317013429, 5846.035404158266], "value": 5507.395578521124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6049646736686, 626.9592476489028, 645.1033064040984, 652.302036820602, 671.2180309938922, 36876.0, 41755.37366939498, 41865.37201941973, 41987.0, 42088.789556052216, 43327.78336108315, 43994.12011759763, 44086.0, 44087.0, 44120.55879441205, 8737.169968852964, 8820.911790882074, 8888.511131887744, 8889.377743557954, 8931.732048038537, 8720.781980450476, 8736.475811451333, 8791.560421978875, 8843.690470833522, 8847.513386763725, 8854.203121719043, 8874.645014199457, 8917.68788092417, 8925.821483570324, 8951.149640784148, 8797.692080777175, 8851.911480885205, 8864.113588641085, 8867.911320886806, 8870.512121833297, 8708.21626053652, 8751.212390884788, 8848.46909185451, 8854.778630534223, 8873.11268873114, 37442.62557374419, 40557.18885622301, 40783.796081019405, 40869.591304086876, 40913.0, 3472.1493234157792, 3519.137811236238, 3533.3993221152464, 3622.0, 3946.2699400610977, 30651.38697226043, 32181.35637287241, 32805.507917381256, 33881.491777623356, 34101.31797364064, 4340.414044104037, 4346.76092814895, 4365.716228445141, 4374.0, 4486.394336764528, 321182.0, 333838.0, 334429.0, 334622.0, 335014.99999999756, 33238.16904577405, 64281.357186428475, 65502.34497655058, 65600.6719966397, 65610.34389656138, 36509.26981460356, 38550.42174367387, 38721.61278387236, 38792.418113728316, 39178.6082139175, 15380.154091525073, 15671.981321214085, 15672.0, 15690.372385104469, 15702.76445853313, 12680.873191267969, 12702.745945081047, 12779.297138657463, 12826.0, 12829.037822163189, 8839.46963182211, 8910.376273660911, 8914.86627700585, 8939.910600894038, 9017.594208260643, 3462.058572562047, 3511.455724362728, 3549.3140758139675, 3567.714582833367, 3570.6607872252093, 1021.9029192226726, 1076.9730756730987, 1085.880553139154, 1200.6818193178815, 1200.9519619215134, 30061.699383006326, 31231.84384078065, 31353.843230784158, 32774.0, 33223.83388083093, 1114.1699433921617, 1159.1227344532526, 1190.7618476304601, 1236.9257844529357, 1326.7047857914258, 16497.257623406975, 16608.83391166097, 16661.166941652868, 16823.327066917187, 16855.325786968384, 489948.0, 516319.0, 523357.0, 524263.0, 868506.0, 58584.70707646434, 58868.4113158863, 59741.40258597445, 59833.10250346248, 60010.0, 1500.3623460029662, 1503.5564508470027, 1504.1351223046793, 1507.6758496922994, 1515.1969456188237, 33115.50326745149, 33213.9326222291, 33478.4978225322, 33504.16239593932, 33809.0, 52330.47669523256, 53291.0, 53342.466575335304, 53671.46328536665, 53727.0, 466639.0, 468950.0, 470096.0, 470474.0, 470813.0, 44303.33544996763, 44650.0, 45152.32271515996, 45641.77179114083, 45868.77065614651, 49883.75058124686, 49959.0, 50112.24831627601, 50160.24759628536, 51087.0, 40882.0, 41434.0, 41846.0, 42201.78899105485, 43040.569594303655, 40589.79705101574, 40827.0, 40863.0, 42197.15605687931, 42312.78843605762, 38191.0, 42933.35599966066, 42987.35518967156, 43024.56975430206, 43131.568684314014, 36101.27797444089, 36541.91258573905, 36682.44976325411, 37360.0, 37387.62612373842, 28517.720462147117, 29205.41589168247, 29278.853605732686, 29515.85242073776, 29555.704442955295], "value": 19607.845489177696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.3624665092978, 408.89164371441575, 412.75028607692343, 418.37870761918566, 422.82875435448636, 17965.55086122846, 19689.901550492246, 19732.210711571537, 19932.402027939148, 20803.895980520116, 19039.333623323186, 19544.218231270766, 20057.498562535908, 20107.497312567193, 20176.89911550444, 5547.140193270049, 5906.173135760997, 5944.405559444064, 5944.821655350324, 5950.285965684124, 5609.551235901118, 5799.971000144993, 5870.647761134324, 5890.734916928748, 5893.410658934094, 5833.766649334043, 5840.6787626680725, 5863.0, 5872.0, 5878.617889837168, 5786.305643322808, 5797.36229014808, 5848.824535263928, 5856.150858125569, 5936.287645482526, 5241.3710354757295, 5273.947260527384, 5280.498352656491, 5287.788488460457, 5315.202719592054, 22480.437989050406, 23412.0, 23475.882620586788, 23481.7651823483, 23603.88198059016, 2232.441889527618, 2381.416552944522, 2477.9876100619563, 2500.8124390670773, 2804.0886711818534, 10356.378617282911, 10657.626983055556, 10764.515596798085, 10851.51168197433, 10871.891281087246, 1953.8534609904173, 1988.5823976964855, 2163.9783602163934, 2173.804357607807, 2186.2602107610555, 60151.99999999956, 69236.0, 71888.6405567974, 73260.26739732588, 75231.24768752298, 10748.408837514013, 11248.94375528117, 11277.548898043986, 11358.602448914413, 11446.427678616035, 15934.60163495922, 15956.680866382607, 16027.278772455267, 16045.358185672676, 16194.352225910832, 7882.330001949784, 8014.0, 8173.060098088677, 8221.301189398848, 8266.04940431846, 7624.656890439944, 7685.0, 7737.419693523008, 7822.726204582926, 7822.960885195537, 4745.881352966204, 4888.804447822047, 4894.3147959285725, 4943.456219815817, 4967.05625931072, 1933.1397528100142, 1955.8044195580612, 1989.5225145964864, 1997.9001049947444, 2001.8198362147186, 912.1790388650268, 1007.5365331947386, 1013.761765984993, 1019.1744686803713, 1099.9230053896151, 17615.471535853943, 19026.238950442104, 19484.902575487315, 19691.704624430644, 19915.900420497805, 1017.7099526635021, 1025.436010194405, 1026.8408396698524, 1098.8956049175315, 1132.8527291452224, 10502.947485262677, 11097.944510277559, 11118.0, 11121.110311175087, 11181.888181118085, 498066.0, 505053.0, 519063.0, 525141.0, 531088.0, 54346.0, 94307.52846235725, 94931.0, 97999.51000244953, 99447.0, 936.6768464879606, 1027.4708525109575, 1077.106002018323, 1077.8275475923815, 1087.1465899269035, 17289.654206916042, 17363.652726945136, 17750.556236094202, 18005.639887202444, 18057.909710451364, 29219.561706573993, 36689.26621467609, 37342.8132859334, 41224.0, 44538.55461445344, 55283.17075243794, 57271.0, 58661.70669146627, 58832.4116758844, 59530.0, 8861.424007439497, 8996.59515321799, 9001.144891235323, 9020.954895225483, 9410.011948745283, 10071.496425178859, 13508.459661613819, 13791.862081379459, 14018.789718154032, 14096.929515352358, 12133.69665758363, 12233.571824986082, 12418.254904705747, 12538.373081346079, 12601.936990314989, 12045.217060891015, 12346.75306493883, 12426.937865310616, 12520.49918003306, 12639.87360126387, 12264.632061038183, 12332.50669973191, 12398.442070107047, 12494.625161245178, 12896.548620798227, 7543.47195696296, 7883.093444253984, 7948.046234451903, 8121.228483294078, 9221.86167207479, 11731.88268117308, 12095.879041209475, 12264.816027759412, 12266.570670026505, 12267.386630668252], "value": 9356.619619362802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.4794317875098, 1605.3016937632128, 1779.8754087213892, 1850.2044121027952, 1865.1793210987173, 7929.326007289373, 8408.411411201218, 8439.746807595766, 9068.41055331403, 9090.2273306769, 8433.072362040171, 8690.0, 8692.30461563075, 8741.562921853914, 8778.561071946393, 2341.964870526939, 2346.554154710608, 2363.61000434928, 2375.774301441369, 2377.9286621401384, 2334.2063698342645, 2364.3143488388346, 2404.266698656909, 2408.157144999254, 2408.1812183857487, 2337.532493501298, 2339.5671800716837, 2342.0865862313713, 2368.4197371643972, 2378.82158838087, 2342.390978345625, 2344.355302291875, 2348.9295321140307, 2354.0348457132577, 2380.4643955110137, 2186.2238905188588, 2329.429289823987, 2348.2250857217077, 2358.929232123039, 2360.0, 8627.094155113686, 8654.524001179932, 8711.520866352348, 8715.128487151298, 8717.215450609476, 5205.791768329263, 5296.549793267577, 5329.973350133263, 5339.439358867302, 5340.91988620171, 3348.4475061614803, 3494.5631796025496, 3497.300539892032, 3502.8248587570774, 3542.6103128655827, 1067.834485654717, 1113.7494063835654, 1126.7690123524658, 1160.9477573509212, 1167.2762887010024, 12313.322767247797, 12348.444320005621, 12389.690257743538, 12424.192427492184, 12448.066395020409, 4567.406237189144, 4588.908221835544, 4701.294805779161, 4733.502982186889, 4756.619470442356, 9850.064243896819, 9877.851832222523, 9881.555330010167, 9897.505124743733, 9897.950510247403, 5302.072137376021, 5318.25544423781, 5336.0661884170895, 5382.327209098863, 5408.78364865401, 4507.391502147234, 4861.319415281863, 4941.061198372297, 4963.230699241623, 4991.975040124848, 3882.281777871103, 3897.8051097445014, 3978.622030907059, 4005.239004589177, 4012.739171953872, 1181.7163880668577, 1185.318441895896, 1198.6224339333082, 1207.2454715802623, 1229.170310040719, 848.2026894718945, 977.4184360305607, 977.9902200978041, 987.6395115782831, 989.6734077754323, 5792.565557583198, 6019.729112189962, 6087.786927457518, 6190.3190649028575, 6399.552031357854, 1018.3177271228295, 1053.6786280184617, 1055.7571758495435, 1065.760203954104, 1075.4300220882944, 4085.6935729820384, 4361.9749358900635, 4366.170427618742, 4415.801288942005, 4435.822567097344, 10347.534360953776, 10575.259731818698, 10836.187285953585, 10859.674209773719, 10874.0, 10634.946825265824, 10691.037806597444, 10758.354498730101, 10771.569137234423, 10798.028177464066, 8071.4753541019645, 8277.875831862528, 8325.583720813935, 8344.415890887702, 8447.831043379221, 6181.5363847710705, 6225.3774622539195, 6239.313675495782, 6268.27914789805, 6269.811905642838, 9915.157211636802, 10025.849612255675, 10093.596256149673, 10216.182705383402, 10289.176865850864, 10283.382997020202, 10346.430946298025, 10526.631567895087, 10551.050405463546, 10564.260501764802, 7141.143062832493, 7858.803529911569, 7877.448578599443, 7885.093214280431, 8077.0, 8775.824483510167, 8810.383273170817, 8882.511461869659, 8920.598573064099, 8928.0, 7842.176571460142, 8001.599920004093, 8013.559254241072, 8074.293051449861, 8121.675132994614, 7798.961005194938, 7865.921340786519, 7922.366210703015, 7933.206679332021, 7988.320992715684, 7291.598962057138, 7330.157031941395, 7378.483506154517, 7423.962880185564, 7476.065491813523, 5456.863578410572, 5467.0, 5506.449355064461, 5559.499645031967, 5564.693941833238, 5352.795620985247, 5390.407055224001, 5537.307836520435, 5571.66570005801, 5692.971535142297], "value": 4727.873454114335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.5540658627319, 336.86424176337727, 339.48927273632336, 346.9340825243205, 347.22741899274104, 5517.393086760459, 5582.553395728347, 5609.298837645294, 5631.57763167762, 5658.869025611306, 5451.836444906659, 5483.616146869721, 5530.419305972875, 5547.916781248285, 5565.220869078333, 4089.161721847029, 4258.872233832974, 4273.2735434975975, 4283.329501494404, 4331.242032644291, 4216.852410165645, 4307.33236348365, 4316.892077698051, 4323.654107671395, 4345.174416860802, 4270.444842170529, 4278.358246263055, 4291.120320334339, 4309.965608254012, 4323.697341186103, 4296.591823776736, 4308.9569104309185, 4313.849015284466, 4315.30955047194, 4332.573758695125, 3553.7157027437743, 3731.768516389585, 3734.9439758403646, 3736.6263373662687, 3748.737588368815, 5381.385584324726, 5413.566914646819, 5436.565074794007, 5470.152126420371, 5490.752916118784, 4931.950680493185, 4951.752412379366, 4955.925661115086, 4957.479464656195, 4979.253112033188, 5648.632838865502, 5726.770929162829, 5780.1907732917425, 5798.82603521895, 5816.592838501307, 4106.1582375612925, 4114.691398145121, 4115.135821477494, 4134.400511925784, 4161.56303588122, 5780.71096445176, 5987.6108052976415, 5996.340402555716, 6044.1263208405535, 6115.296740874812, 4117.0, 4119.155573107506, 4129.245070844939, 4132.8140233689555, 4143.647789937889, 4026.416169655442, 4135.97932010338, 4152.335626299838, 4168.43726096973, 4184.686148538872, 4801.855944321676, 4815.903681926412, 4822.276658501253, 4848.224284114524, 4864.586510146606, 5455.509004189642, 5765.135229715493, 5812.715815564193, 5910.615809972338, 5916.822495325147, 1451.484722923368, 1459.8102246708072, 1469.1992863889207, 1472.6539263273123, 1480.4078368652624, 967.9467629280316, 968.9806203875883, 995.7560397702609, 1001.5893483671805, 1009.9597414662909, 5397.919031214535, 5582.860428489239, 5677.744501497443, 5712.800311934458, 5723.742431590588, 6009.819705408845, 6056.454919057306, 6098.939010609926, 6106.328303886569, 6108.816735497942, 5525.944740552623, 5663.584103974006, 5691.089425691869, 5699.572532060112, 5706.9429305707245, 3105.3013072058607, 3114.3304189599344, 3138.905832825019, 3143.339898621269, 3185.3151572412044, 5939.524838012949, 6038.0, 6047.667378294236, 6051.364606716232, 6073.939260607337, 5669.052092911746, 6061.939380606137, 6070.332263451017, 6090.208272924491, 6102.298235702862, 6014.556506438511, 6030.0, 6066.603691541816, 6152.062100438347, 6185.567010309235, 5558.694271815089, 5818.94181058201, 5875.618084824473, 5944.286685597756, 5956.910646340221, 5852.912206316823, 5880.323762767336, 5893.261487861006, 5907.877503274364, 5918.585699001029, 5757.169342432205, 6074.453299203093, 6117.3576774439825, 6177.752889884354, 6184.907226391518, 4040.535338436, 4106.2198182345255, 4112.157007813331, 4131.834726611022, 4132.91734165321, 5851.97590421666, 5873.883962047197, 5876.0, 5920.0, 5955.5235581154275, 5585.497305242548, 5721.22763426932, 5763.827085187451, 5803.303603567599, 5816.3892791258, 5679.37526872052, 5701.458361455655, 5719.914201287067, 5732.971335143297, 5745.850829834134, 5478.958997790407, 5505.807296744595, 5620.4098569649595, 5639.943600564106, 5668.178114173505, 5604.2154098425435, 5673.631213971079, 5827.825165245049, 5858.7070646468355, 5883.676397797991, 5642.830715078554, 5675.432456754292, 5693.402192769865, 5713.457221563945, 5771.1920331154515], "value": 4396.4694952340105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.1684297801352, 784.1844481738992, 788.9802754931129, 877.8814859993906, 900.315760022383, 13414.530491432803, 13966.23185724786, 14397.208153551577, 14499.130052196862, 14510.492132775355, 13353.796623557102, 13418.73162536751, 13430.66423339417, 13443.26062066586, 13449.462021519152, 705.8764716174675, 848.6266042941118, 874.54960695242, 876.5398165962889, 876.5836227791812, 849.70685113636, 859.5959898847532, 861.2162931732125, 864.1142828600703, 864.8140649760301, 898.6360523987795, 899.9055099214586, 900.0279697926256, 902.2736696958946, 904.3217586809892, 892.0588778838323, 893.8927328720563, 894.7315805258462, 896.0233345653269, 896.66375109334, 650.2392201124695, 652.0610321137547, 652.0870780906721, 654.3489228217906, 655.1483072006421, 14173.503927362595, 14240.928795355956, 14249.430022799075, 14322.85677143236, 14329.928350358286, 13851.099678520965, 14110.929445352707, 14176.645583860383, 14263.928680356636, 14350.928245358811, 11462.598809041727, 11621.941890290494, 11706.941465292704, 11739.178257521977, 11842.407879605986, 3831.770093794353, 3849.4610754494392, 3932.233214523169, 4036.9596304037173, 4065.7560546367313, 51637.22544161841, 51661.74169129168, 53375.199372009454, 53589.196162057604, 54336.184957225276, 11225.94387028076, 11265.774684506265, 11281.71795705114, 11294.096472282197, 11429.314241145392, 19537.609247814966, 19552.41342759691, 19567.0, 19580.510487237934, 20143.0, 8443.36674749384, 8503.914960850312, 8533.232009119085, 8621.353398495137, 8716.607752651145, 4890.095332363453, 4914.238293064581, 4985.152524070917, 5020.221865610836, 5022.121128802518, 3279.721223695965, 3367.7642565020706, 3372.1906742381652, 3382.255903701182, 3385.0, 596.5287422935919, 609.5702529716539, 655.1842955520408, 659.7427003468651, 662.5627086123136, 668.3784080804899, 709.9538529995534, 731.7621772923821, 731.9642705571663, 736.7716008037526, 8669.479831210148, 9062.093790621017, 9365.672201472917, 9433.812356615752, 9440.905590944003, 742.2503271695626, 742.6138408027796, 750.1748077115129, 750.7897788619196, 767.4972892755254, 4213.262679031157, 4281.935770963438, 4283.678724095706, 4314.331278651814, 4384.649228061748, 57763.711181443825, 58232.0, 58666.41333586695, 58668.11997820036, 58688.119678204865, 50871.49128508742, 51232.74383628058, 51534.0, 51961.220581691305, 53294.73352633289, 47836.5216347839, 47966.52033479621, 48517.757411213424, 49125.75437122863, 50044.0, 7970.242826931432, 8025.879611805711, 8093.312068474245, 8208.794780130545, 8332.833343333221, 31888.5216721754, 32257.99999999906, 32366.19084522906, 32843.83578082094, 33203.0, 38924.80537597294, 42058.0, 42517.14965700731, 42649.0, 43069.35395969126, 10832.24174307791, 11313.434328283389, 12073.27560346347, 12100.092493063232, 12424.75150497003, 12230.510779569073, 12288.815667764811, 12662.430190641628, 12947.5468358607, 13085.41115649817, 11547.653570392902, 11731.0, 11735.0, 11778.645455772696, 11790.469428875549, 11642.883571164519, 11778.646640600795, 11881.881181188077, 12089.637310880687, 12116.636500904988, 11833.171677982802, 11895.464704088165, 11983.400829958293, 11986.64040078799, 12075.154739168174, 9604.519774011133, 9676.612935482503, 10093.394396336244, 10226.744331391776, 10664.200184986003, 10075.34510256831, 10463.11063559606, 10478.161747060369, 10507.474626268504, 10554.841677374692], "value": 6694.987554093505, "unit": "score"}], "name": "dromaeo_css", "value": 7211.23080334238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 101.0, 111.0, 111.0, 111.0, 106.0, 110.0, 112.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 152.0, 211.0, 127.0, 163.0, 156.0, 129.0, 180.0, 134.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 165.0, 174.0, 162.0, 165.0, 163.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 168.0, 76.0, 76.0, 75.0, 75.0, 163.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 174.0, 92.0, 92.0, 92.0, 147.0, 93.0, 102.0, 145.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 65.0, 62.0, 62.0, 60.0, 60.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 83.0, 80.0, 79.0, 79.0, 85.0, 79.0, 139.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 131.0, 127.0, 124.0, 135.0, 137.0, 134.0, 146.0, 134.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 170.0, 172.0, 168.0, 172.0, 169.0, 165.0, 177.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 74.0, 64.0, 65.0, 66.0, 68.0, 68.0, 64.0, 64.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1567.6999999999998, "alertThreshold": 2.0}]} 08:25:52 INFO - Return code: 0 08:25:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:52 ERROR - # TBPL SUCCESS # 08:25:52 INFO - Running post-action listener: _resource_record_post_action 08:25:52 INFO - ##### 08:25:52 INFO - ##### Finished run-tests step (success) 08:25:52 INFO - ##### 08:25:52 INFO - Running post-run listener: _resource_record_post_run 08:25:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 537423872; Read time: 0; Write time: 464888 08:25:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244842496; Read time: 0; Write time: 226312 08:25:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292581376; Read time: 0; Write time: 238576 08:25:53 INFO - Running post-run listener: _upload_blobber_files 08:25:53 INFO - Blob upload gear active. 08:25:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:53 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 08:25:53 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'] 08:25:53 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 08:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:54 INFO - (blobuploader) - INFO - Done attempting. 08:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:55 INFO - (blobuploader) - INFO - Done attempting. 08:25:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:55 INFO - Return code: 0 08:25:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf245b78fb1a611948a880c8d87976d9d4f727b492432f398a4bbef028a3ea760e64744f4d02d804d516262edb90f233834beec08dd213055f2745bfc2dba6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0705cb85c58ba1520587eb77c9efaac198c98f4e1a16fab75ad180785eb997249152de2bdb6e0d03f95ad6c7b7c4a795da559b6925e12a3e136dc440cc7933be"} 08:25:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:55 INFO - Contents: 08:25:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf245b78fb1a611948a880c8d87976d9d4f727b492432f398a4bbef028a3ea760e64744f4d02d804d516262edb90f233834beec08dd213055f2745bfc2dba6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0705cb85c58ba1520587eb77c9efaac198c98f4e1a16fab75ad180785eb997249152de2bdb6e0d03f95ad6c7b7c4a795da559b6925e12a3e136dc440cc7933be"} 08:25:55 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:55 INFO - Copying logs to upload dir... 08:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.702061 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-09 08:25:55.263421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 08:25:55.266945) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 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/bf245b78fb1a611948a880c8d87976d9d4f727b492432f398a4bbef028a3ea760e64744f4d02d804d516262edb90f233834beec08dd213055f2745bfc2dba6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0705cb85c58ba1520587eb77c9efaac198c98f4e1a16fab75ad180785eb997249152de2bdb6e0d03f95ad6c7b7c4a795da559b6925e12a3e136dc440cc7933be"} build_url:https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/dmIxP--rRMmgMsLHi50E1Q/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/bf245b78fb1a611948a880c8d87976d9d4f727b492432f398a4bbef028a3ea760e64744f4d02d804d516262edb90f233834beec08dd213055f2745bfc2dba6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0705cb85c58ba1520587eb77c9efaac198c98f4e1a16fab75ad180785eb997249152de2bdb6e0d03f95ad6c7b7c4a795da559b6925e12a3e136dc440cc7933be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 08:25:55.291908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:25:55.292231) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462805913.140983-1178259506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 08:25:55.374272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 08:25:55.374590) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 08:25:55.374941) ========= ========= Total master_lag: 0.17 =========