builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1462957889.89 results: success (0) buildid: 20160510233027 builduid: 039e2fd0af134cf196cbb9226cf1cd95 revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:29.892504) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:29.893119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:29.893539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:29.903398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:29.903766) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 02:11:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.1M=0s 2016-05-11 02:11:32 (98.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:30.019361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:30.019776) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009562 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:30.071136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 02:11:30.071622) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 91714307a799b978b0a94911cd99ee75a1de0ac5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 91714307a799b978b0a94911cd99ee75a1de0ac5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 02:11:32,133 truncating revision to first 12 chars 2016-05-11 02:11:32,133 Setting DEBUG logging. 2016-05-11 02:11:32,133 attempt 1/10 2016-05-11 02:11:32,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/91714307a799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 02:11:34,193 unpacking tar archive at: fx-team-91714307a799/testing/mozharness/ program finished with exit code 0 elapsedTime=2.309324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 02:11:32.389611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:32.389931) ========= script_repo_revision: 91714307a799b978b0a94911cd99ee75a1de0ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:32.390323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:32.390636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:11:32.396464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-11 02:11:32.396748) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:11:34 INFO - MultiFileLogger online at 20160511 02:11:34 in /builds/slave/test 02:11:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:34 INFO - {'append_to_log': False, 02:11:34 INFO - 'base_work_dir': '/builds/slave/test', 02:11:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:34 INFO - 'branch': 'Fx-Team', 02:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:34 INFO - 'config_files': ('talos/linux_config.py',), 02:11:34 INFO - 'default_actions': ('clobber', 02:11:34 INFO - 'read-buildbot-config', 02:11:34 INFO - 'download-and-extract', 02:11:34 INFO - 'populate-webroot', 02:11:34 INFO - 'create-virtualenv', 02:11:34 INFO - 'install', 02:11:34 INFO - 'run-tests'), 02:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:34 INFO - 'download_minidump_stackwalk': True, 02:11:34 INFO - 'download_symbols': 'ondemand', 02:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:34 INFO - 'installer_path': 'installer.exe', 02:11:34 INFO - 'log_level': 'info', 02:11:34 INFO - 'log_name': 'talos', 02:11:34 INFO - 'log_to_console': True, 02:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:11:34 INFO - 'opt_config_files': (), 02:11:34 INFO - 'pip_index': False, 02:11:34 INFO - 'sps_profile': False, 02:11:34 INFO - 'sps_profile_interval': 0, 02:11:34 INFO - 'suite': 'dromaeojs', 02:11:34 INFO - 'system_bits': '32', 02:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:34 INFO - 'title': 'talos-linux64-ix-066', 02:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:34 INFO - 'use_talos_json': True, 02:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:34 INFO - 'work_dir': 'build'} 02:11:34 INFO - ##### 02:11:34 INFO - ##### Running clobber step. 02:11:34 INFO - ##### 02:11:34 INFO - Running pre-action listener: _resource_record_pre_action 02:11:34 INFO - Running main action method: clobber 02:11:34 INFO - rmtree: /builds/slave/test/build 02:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:11:35 INFO - Running post-action listener: _resource_record_post_action 02:11:35 INFO - ##### 02:11:35 INFO - ##### Finished clobber step (success) 02:11:35 INFO - ##### 02:11:35 INFO - ##### 02:11:35 INFO - ##### Running read-buildbot-config step. 02:11:35 INFO - ##### 02:11:35 INFO - Running pre-action listener: _resource_record_pre_action 02:11:35 INFO - Running main action method: read_buildbot_config 02:11:35 INFO - Using buildbot properties: 02:11:35 INFO - { 02:11:35 INFO - "project": "", 02:11:35 INFO - "product": "firefox", 02:11:35 INFO - "script_repo_revision": "production", 02:11:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:11:35 INFO - "repository": "", 02:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:11:35 INFO - "buildid": "20160510233027", 02:11:35 INFO - "pgo_build": "True", 02:11:35 INFO - "basedir": "/builds/slave/test", 02:11:35 INFO - "buildnumber": 74, 02:11:35 INFO - "slavename": "talos-linux64-ix-066", 02:11:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:11:35 INFO - "platform": "ubuntu64_hw", 02:11:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:11:35 INFO - "branch": "fx-team", 02:11:35 INFO - "repo_path": "integration/fx-team", 02:11:35 INFO - "revision": "91714307a799b978b0a94911cd99ee75a1de0ac5", 02:11:35 INFO - "stage_platform": "linux64-pgo", 02:11:35 INFO - "builduid": "039e2fd0af134cf196cbb9226cf1cd95", 02:11:35 INFO - "slavebuilddir": "test" 02:11:35 INFO - } 02:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:11:35 INFO - Running post-action listener: _resource_record_post_action 02:11:35 INFO - ##### 02:11:35 INFO - ##### Finished read-buildbot-config step (success) 02:11:35 INFO - ##### 02:11:35 INFO - ##### 02:11:35 INFO - ##### Running download-and-extract step. 02:11:35 INFO - ##### 02:11:35 INFO - Running pre-action listener: _resource_record_pre_action 02:11:35 INFO - Running main action method: download_and_extract 02:11:35 INFO - mkdir: /builds/slave/test/build/tests 02:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:35 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:11:43 INFO - Downloaded 1361 bytes. 02:11:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:11:43 INFO - Using the following test package requirements: 02:11:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:11:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:11:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'jsshell-linux-x86_64.zip'], 02:11:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:11:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:11:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:11:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:11:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:11:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:43 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:11:45 INFO - Downloaded 23902907 bytes. 02:11:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:11:46 INFO - Return code: 0 02:11:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:46 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:11:49 INFO - Downloaded 23902907 bytes. 02:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:11:50 INFO - Return code: 0 02:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:50 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:11:51 INFO - Downloaded 10840152 bytes. 02:11:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:11:52 INFO - Return code: 0 02:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:52 INFO - https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:11:53 INFO - Downloaded 58320439 bytes. 02:11:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:11:53 INFO - mkdir: /builds/slave/test/properties 02:11:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:53 INFO - Contents: 02:11:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:11:54 INFO - Running post-action listener: _resource_record_post_action 02:11:54 INFO - Running post-action listener: set_extra_try_arguments 02:11:54 INFO - ##### 02:11:54 INFO - ##### Finished download-and-extract step (success) 02:11:54 INFO - ##### 02:11:54 INFO - ##### 02:11:54 INFO - ##### Running populate-webroot step. 02:11:54 INFO - ##### 02:11:54 INFO - Running pre-action listener: _resource_record_pre_action 02:11:54 INFO - Running main action method: populate_webroot 02:11:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:54 INFO - '--tppagecycles', 02:11:54 INFO - '7'], 02:11:54 INFO - 'tests': ['tsvgm']}}, 02:11:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:11:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['damp', 'tps']}, 02:11:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'tests': ['damp', 'tps']}, 02:11:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['dromaeo_dom']}, 02:11:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['a11yr', 02:11:54 INFO - 'ts_paint', 02:11:54 INFO - 'tpaint', 02:11:54 INFO - 'sessionrestore', 02:11:54 INFO - 'sessionrestore_no_auto_restore', 02:11:54 INFO - 'tabpaint']}, 02:11:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['tsvgx', 02:11:54 INFO - 'tsvgr_opacity', 02:11:54 INFO - 'tart', 02:11:54 INFO - 'tscrollx', 02:11:54 INFO - 'cart']}, 02:11:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:54 INFO - 'tsvgr_opacity', 02:11:54 INFO - 'tart', 02:11:54 INFO - 'tscrollx', 02:11:54 INFO - 'cart']}, 02:11:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'talos_options': ['--disable-e10s'], 02:11:54 INFO - 'tests': ['tp5o']}, 02:11:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'tests': ['tp5o']}, 02:11:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'talos_options': ['--disable-e10s', 02:11:54 INFO - '--xperf_path', 02:11:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:54 INFO - 'tests': ['tp5n']}, 02:11:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:54 INFO - 'talos_options': ['--xperf_path', 02:11:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:54 INFO - 'tests': ['tp5n']}}, 02:11:54 INFO - 'talos.zip': {'path': '', 02:11:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:54 INFO - Running post-action listener: _resource_record_post_action 02:11:54 INFO - ##### 02:11:54 INFO - ##### Finished populate-webroot step (success) 02:11:54 INFO - ##### 02:11:54 INFO - ##### 02:11:54 INFO - ##### Running create-virtualenv step. 02:11:54 INFO - ##### 02:11:54 INFO - Running pre-action listener: _resource_record_pre_action 02:11:54 INFO - Running main action method: create_virtualenv 02:11:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:11:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:54 INFO - Using real prefix '/usr' 02:11:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:56 INFO - Installing pip.................done. 02:11:56 INFO - Return code: 0 02:11:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:56 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:11:56 INFO - Using env: {'DISPLAY': ':0', 02:11:56 INFO - 'HOME': '/home/cltbld', 02:11:56 INFO - 'LANG': 'en_US.UTF-8', 02:11:56 INFO - 'LANGUAGE': 'en_US:en', 02:11:56 INFO - 'LOGNAME': 'cltbld', 02:11:56 INFO - 'MAIL': '/var/mail/cltbld', 02:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:56 INFO - 'MOZ_NO_REMOTE': '1', 02:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:56 INFO - 'NO_EM_RESTART': '1', 02:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:56 INFO - 'PWD': '/builds/slave/test', 02:11:56 INFO - 'SHELL': '/bin/bash', 02:11:56 INFO - 'SHLVL': '1', 02:11:56 INFO - 'TERM': 'linux', 02:11:56 INFO - 'TMOUT': '86400', 02:11:56 INFO - 'USER': 'cltbld', 02:11:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:56 INFO - '_': '/tools/buildbot/bin/python'} 02:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:11:56 INFO - Cleaning up... 02:11:57 INFO - Return code: 0 02:11:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:57 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:11:57 INFO - Using env: {'DISPLAY': ':0', 02:11:57 INFO - 'HOME': '/home/cltbld', 02:11:57 INFO - 'LANG': 'en_US.UTF-8', 02:11:57 INFO - 'LANGUAGE': 'en_US:en', 02:11:57 INFO - 'LOGNAME': 'cltbld', 02:11:57 INFO - 'MAIL': '/var/mail/cltbld', 02:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:57 INFO - 'MOZ_NO_REMOTE': '1', 02:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:57 INFO - 'NO_EM_RESTART': '1', 02:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:57 INFO - 'PWD': '/builds/slave/test', 02:11:57 INFO - 'SHELL': '/bin/bash', 02:11:57 INFO - 'SHLVL': '1', 02:11:57 INFO - 'TERM': 'linux', 02:11:57 INFO - 'TMOUT': '86400', 02:11:57 INFO - 'USER': 'cltbld', 02:11:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:57 INFO - '_': '/tools/buildbot/bin/python'} 02:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:57 INFO - Downloading/unpacking psutil>=0.7.1 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:59 INFO - Installing collected packages: psutil 02:11:59 INFO - Running setup.py install for psutil 02:11:59 INFO - building 'psutil._psutil_linux' extension 02:11:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:11:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:11:59 INFO - building 'psutil._psutil_posix' extension 02:11:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:11:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:59 INFO - Successfully installed psutil 02:11:59 INFO - Cleaning up... 02:11:59 INFO - Return code: 0 02:11:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:59 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:11:59 INFO - Using env: {'DISPLAY': ':0', 02:11:59 INFO - 'HOME': '/home/cltbld', 02:11:59 INFO - 'LANG': 'en_US.UTF-8', 02:11:59 INFO - 'LANGUAGE': 'en_US:en', 02:11:59 INFO - 'LOGNAME': 'cltbld', 02:11:59 INFO - 'MAIL': '/var/mail/cltbld', 02:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:59 INFO - 'MOZ_NO_REMOTE': '1', 02:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:59 INFO - 'NO_EM_RESTART': '1', 02:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:59 INFO - 'PWD': '/builds/slave/test', 02:11:59 INFO - 'SHELL': '/bin/bash', 02:11:59 INFO - 'SHLVL': '1', 02:11:59 INFO - 'TERM': 'linux', 02:11:59 INFO - 'TMOUT': '86400', 02:11:59 INFO - 'USER': 'cltbld', 02:11:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:59 INFO - '_': '/tools/buildbot/bin/python'} 02:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:12:01 INFO - Installing collected packages: mozsystemmonitor 02:12:01 INFO - Running setup.py install for mozsystemmonitor 02:12:01 INFO - Successfully installed mozsystemmonitor 02:12:01 INFO - Cleaning up... 02:12:01 INFO - Return code: 0 02:12:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:01 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:12:01 INFO - Using env: {'DISPLAY': ':0', 02:12:01 INFO - 'HOME': '/home/cltbld', 02:12:01 INFO - 'LANG': 'en_US.UTF-8', 02:12:01 INFO - 'LANGUAGE': 'en_US:en', 02:12:01 INFO - 'LOGNAME': 'cltbld', 02:12:01 INFO - 'MAIL': '/var/mail/cltbld', 02:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:01 INFO - 'MOZ_NO_REMOTE': '1', 02:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:01 INFO - 'NO_EM_RESTART': '1', 02:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:01 INFO - 'PWD': '/builds/slave/test', 02:12:01 INFO - 'SHELL': '/bin/bash', 02:12:01 INFO - 'SHLVL': '1', 02:12:01 INFO - 'TERM': 'linux', 02:12:01 INFO - 'TMOUT': '86400', 02:12:01 INFO - 'USER': 'cltbld', 02:12:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:01 INFO - '_': '/tools/buildbot/bin/python'} 02:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:04 INFO - Downloading docopt-0.6.1.tar.gz 02:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:04 INFO - Running setup.py install for blobuploader 02:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:04 INFO - Running setup.py install for requests 02:12:04 INFO - Running setup.py install for docopt 02:12:04 INFO - Successfully installed blobuploader requests docopt 02:12:04 INFO - Cleaning up... 02:12:05 INFO - Return code: 0 02:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:05 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:12:05 INFO - Using env: {'DISPLAY': ':0', 02:12:05 INFO - 'HOME': '/home/cltbld', 02:12:05 INFO - 'LANG': 'en_US.UTF-8', 02:12:05 INFO - 'LANGUAGE': 'en_US:en', 02:12:05 INFO - 'LOGNAME': 'cltbld', 02:12:05 INFO - 'MAIL': '/var/mail/cltbld', 02:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:05 INFO - 'MOZ_NO_REMOTE': '1', 02:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:05 INFO - 'NO_EM_RESTART': '1', 02:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:05 INFO - 'PWD': '/builds/slave/test', 02:12:05 INFO - 'SHELL': '/bin/bash', 02:12:05 INFO - 'SHLVL': '1', 02:12:05 INFO - 'TERM': 'linux', 02:12:05 INFO - 'TMOUT': '86400', 02:12:05 INFO - 'USER': 'cltbld', 02:12:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:05 INFO - '_': '/tools/buildbot/bin/python'} 02:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:05 INFO - Running setup.py (path:/tmp/pip-9CWDvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:05 INFO - Running setup.py (path:/tmp/pip-j11d0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:05 INFO - Running setup.py (path:/tmp/pip-zxM8CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:05 INFO - Running setup.py (path:/tmp/pip-Rm76PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:05 INFO - Running setup.py (path:/tmp/pip-hdQ_I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:05 INFO - Running setup.py (path:/tmp/pip-6nrePn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:05 INFO - Running setup.py (path:/tmp/pip-O4UCIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:05 INFO - Running setup.py (path:/tmp/pip-wml1iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:05 INFO - Running setup.py (path:/tmp/pip-F2O6N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:05 INFO - Running setup.py (path:/tmp/pip-eH1rrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:05 INFO - Running setup.py (path:/tmp/pip-M7QskH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:05 INFO - Running setup.py (path:/tmp/pip-jnpMNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:05 INFO - Running setup.py (path:/tmp/pip-C8nz89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:05 INFO - Running setup.py (path:/tmp/pip-b3bZ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:06 INFO - Running setup.py (path:/tmp/pip-VvzOuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:06 INFO - Running setup.py (path:/tmp/pip-eCyOgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:06 INFO - Running setup.py (path:/tmp/pip-7KmYWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:06 INFO - Running setup.py install for manifestparser 02:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozcrash 02:12:06 INFO - Running setup.py install for mozdebug 02:12:06 INFO - Running setup.py install for mozdevice 02:12:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozfile 02:12:06 INFO - Running setup.py install for mozhttpd 02:12:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozinfo 02:12:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozInstall 02:12:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozleak 02:12:06 INFO - Running setup.py install for mozlog 02:12:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Running setup.py install for moznetwork 02:12:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Running setup.py install for mozprocess 02:12:07 INFO - Running setup.py install for mozprofile 02:12:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Running setup.py install for mozrunner 02:12:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Running setup.py install for mozscreenshot 02:12:07 INFO - Running setup.py install for moztest 02:12:07 INFO - Running setup.py install for mozversion 02:12:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:07 INFO - Cleaning up... 02:12:07 INFO - Return code: 0 02:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:07 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:12:07 INFO - Using env: {'DISPLAY': ':0', 02:12:07 INFO - 'HOME': '/home/cltbld', 02:12:07 INFO - 'LANG': 'en_US.UTF-8', 02:12:07 INFO - 'LANGUAGE': 'en_US:en', 02:12:07 INFO - 'LOGNAME': 'cltbld', 02:12:07 INFO - 'MAIL': '/var/mail/cltbld', 02:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:07 INFO - 'MOZ_NO_REMOTE': '1', 02:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:07 INFO - 'NO_EM_RESTART': '1', 02:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:07 INFO - 'PWD': '/builds/slave/test', 02:12:07 INFO - 'SHELL': '/bin/bash', 02:12:07 INFO - 'SHLVL': '1', 02:12:07 INFO - 'TERM': 'linux', 02:12:07 INFO - 'TMOUT': '86400', 02:12:07 INFO - 'USER': 'cltbld', 02:12:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:07 INFO - '_': '/tools/buildbot/bin/python'} 02:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:07 INFO - Running setup.py (path:/tmp/pip-Qm6M0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:08 INFO - Running setup.py (path:/tmp/pip-YHhH9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:08 INFO - Running setup.py (path:/tmp/pip-wWnr9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:08 INFO - Running setup.py (path:/tmp/pip-LdVjS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:08 INFO - Running setup.py (path:/tmp/pip-Q4jf1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:08 INFO - Running setup.py (path:/tmp/pip-naMMaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:08 INFO - Running setup.py (path:/tmp/pip-ZchJuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:08 INFO - Running setup.py (path:/tmp/pip-tGazhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:08 INFO - Running setup.py (path:/tmp/pip-eyJzjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:08 INFO - Running setup.py (path:/tmp/pip-SDrALI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:08 INFO - Running setup.py (path:/tmp/pip-JD780D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:08 INFO - Running setup.py (path:/tmp/pip-4Y6uz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:08 INFO - Running setup.py (path:/tmp/pip-lFENT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:08 INFO - Running setup.py (path:/tmp/pip-rErIUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:08 INFO - Running setup.py (path:/tmp/pip-8w9DV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:08 INFO - Running setup.py (path:/tmp/pip-dBogSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:08 INFO - Running setup.py (path:/tmp/pip-6_U2kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:12:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:10 INFO - Downloading blessings-1.6.tar.gz 02:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:10 INFO - Installing collected packages: blessings 02:12:10 INFO - Running setup.py install for blessings 02:12:11 INFO - Successfully installed blessings 02:12:11 INFO - Cleaning up... 02:12:11 INFO - Return code: 0 02:12:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:11 INFO - Reading from file tmpfile_stdout 02:12:11 INFO - Current package versions: 02:12:11 INFO - argparse == 1.2.1 02:12:11 INFO - blessings == 1.6 02:12:11 INFO - blobuploader == 1.2.4 02:12:11 INFO - docopt == 0.6.1 02:12:11 INFO - manifestparser == 1.1 02:12:11 INFO - mozInstall == 1.12 02:12:11 INFO - mozcrash == 0.17 02:12:11 INFO - mozdebug == 0.1 02:12:11 INFO - mozdevice == 0.48 02:12:11 INFO - mozfile == 1.2 02:12:11 INFO - mozhttpd == 0.7 02:12:11 INFO - mozinfo == 0.9 02:12:11 INFO - mozleak == 0.1 02:12:11 INFO - mozlog == 3.1 02:12:11 INFO - moznetwork == 0.27 02:12:11 INFO - mozprocess == 0.22 02:12:11 INFO - mozprofile == 0.28 02:12:11 INFO - mozrunner == 6.11 02:12:11 INFO - mozscreenshot == 0.1 02:12:11 INFO - mozsystemmonitor == 0.0 02:12:11 INFO - moztest == 0.7 02:12:11 INFO - mozversion == 1.4 02:12:11 INFO - psutil == 3.1.1 02:12:11 INFO - requests == 1.2.3 02:12:11 INFO - wsgiref == 0.1.2 02:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:12:11 INFO - Using env: {'DISPLAY': ':0', 02:12:11 INFO - 'HOME': '/home/cltbld', 02:12:11 INFO - 'LANG': 'en_US.UTF-8', 02:12:11 INFO - 'LANGUAGE': 'en_US:en', 02:12:11 INFO - 'LOGNAME': 'cltbld', 02:12:11 INFO - 'MAIL': '/var/mail/cltbld', 02:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:11 INFO - 'MOZ_NO_REMOTE': '1', 02:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:11 INFO - 'NO_EM_RESTART': '1', 02:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:11 INFO - 'PWD': '/builds/slave/test', 02:12:11 INFO - 'SHELL': '/bin/bash', 02:12:11 INFO - 'SHLVL': '1', 02:12:11 INFO - 'TERM': 'linux', 02:12:11 INFO - 'TMOUT': '86400', 02:12:11 INFO - 'USER': 'cltbld', 02:12:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:11 INFO - '_': '/tools/buildbot/bin/python'} 02:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:12:11 INFO - Cleaning up... 02:12:11 INFO - Return code: 0 02:12:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:12:11 INFO - Using env: {'DISPLAY': ':0', 02:12:11 INFO - 'HOME': '/home/cltbld', 02:12:11 INFO - 'LANG': 'en_US.UTF-8', 02:12:11 INFO - 'LANGUAGE': 'en_US:en', 02:12:11 INFO - 'LOGNAME': 'cltbld', 02:12:11 INFO - 'MAIL': '/var/mail/cltbld', 02:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:11 INFO - 'MOZ_NO_REMOTE': '1', 02:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:11 INFO - 'NO_EM_RESTART': '1', 02:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:11 INFO - 'PWD': '/builds/slave/test', 02:12:11 INFO - 'SHELL': '/bin/bash', 02:12:11 INFO - 'SHLVL': '1', 02:12:11 INFO - 'TERM': 'linux', 02:12:11 INFO - 'TMOUT': '86400', 02:12:11 INFO - 'USER': 'cltbld', 02:12:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:11 INFO - '_': '/tools/buildbot/bin/python'} 02:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:11 INFO - Downloading/unpacking jsonschema 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:13 INFO - Downloading/unpacking functools32 (from jsonschema) 02:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:13 INFO - warning: no files found matching '*.txt' 02:12:13 INFO - no previously-included directories found matching 'build' 02:12:13 INFO - no previously-included directories found matching 'dist' 02:12:13 INFO - no previously-included directories found matching '.git*' 02:12:13 INFO - Installing collected packages: jsonschema, functools32 02:12:13 INFO - Running setup.py install for functools32 02:12:13 INFO - warning: no files found matching '*.txt' 02:12:13 INFO - no previously-included directories found matching 'build' 02:12:13 INFO - no previously-included directories found matching 'dist' 02:12:13 INFO - no previously-included directories found matching '.git*' 02:12:13 INFO - Successfully installed jsonschema functools32 02:12:13 INFO - Cleaning up... 02:12:13 INFO - Return code: 0 02:12:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:13 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 0x7fd0fefd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:12:13 INFO - Using env: {'DISPLAY': ':0', 02:12:13 INFO - 'HOME': '/home/cltbld', 02:12:13 INFO - 'LANG': 'en_US.UTF-8', 02:12:13 INFO - 'LANGUAGE': 'en_US:en', 02:12:13 INFO - 'LOGNAME': 'cltbld', 02:12:13 INFO - 'MAIL': '/var/mail/cltbld', 02:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:13 INFO - 'MOZ_NO_REMOTE': '1', 02:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:13 INFO - 'NO_EM_RESTART': '1', 02:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:13 INFO - 'PWD': '/builds/slave/test', 02:12:13 INFO - 'SHELL': '/bin/bash', 02:12:13 INFO - 'SHLVL': '1', 02:12:13 INFO - 'TERM': 'linux', 02:12:14 INFO - 'TMOUT': '86400', 02:12:14 INFO - 'USER': 'cltbld', 02:12:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:14 INFO - '_': '/tools/buildbot/bin/python'} 02:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:14 INFO - Downloading/unpacking flake8 02:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:12:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:12:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:16 INFO - no previously-included directories found matching 'docs/_build' 02:12:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:12:16 INFO - Running setup.py install for pep8 02:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:16 INFO - no previously-included directories found matching 'docs/_build' 02:12:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:12:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:12:16 INFO - Cleaning up... 02:12:17 INFO - Return code: 0 02:12:17 INFO - Running post-action listener: _resource_record_post_action 02:12:17 INFO - Running post-action listener: _start_resource_monitoring 02:12:17 INFO - Starting resource monitoring. 02:12:17 INFO - ##### 02:12:17 INFO - ##### Finished create-virtualenv step (success) 02:12:17 INFO - ##### 02:12:17 INFO - ##### 02:12:17 INFO - ##### Running install step. 02:12:17 INFO - ##### 02:12:17 INFO - Running pre-action listener: _resource_record_pre_action 02:12:17 INFO - Running main action method: install 02:12:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:17 INFO - Reading from file tmpfile_stdout 02:12:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:17 INFO - Reading from file tmpfile_stdout 02:12:17 INFO - Output received: 02:12:17 INFO - Usage: mozinstall [options] installer 02:12:17 INFO - Options: 02:12:17 INFO - -h, --help show this help message and exit 02:12:17 INFO - -d DEST, --destination=DEST 02:12:17 INFO - Directory to install application into. [default: 02:12:17 INFO - "/builds/slave/test"] 02:12:17 INFO - --app=APP Application being installed. [default: firefox] 02:12:17 INFO - mkdir: /builds/slave/test/build/application 02:12:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:12:34 INFO - Reading from file tmpfile_stdout 02:12:34 INFO - Output received: 02:12:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:12:34 INFO - Running post-action listener: _resource_record_post_action 02:12:34 INFO - ##### 02:12:34 INFO - ##### Finished install step (success) 02:12:34 INFO - ##### 02:12:34 INFO - ##### 02:12:34 INFO - ##### Running run-tests step. 02:12:34 INFO - ##### 02:12:34 INFO - Running pre-action listener: _resource_record_pre_action 02:12:34 INFO - Running main action method: run_tests 02:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:34 INFO - Python 2.7.3 02:12:34 INFO - Return code: 0 02:12:34 INFO - grabbing minidump binary from tooltool 02:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d579c0>, '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 0x1d588c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d58d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:12:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:12:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:12:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:34 INFO - Return code: 0 02:12:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:12:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:12:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:12:34 INFO - Return code: 0 02:12:34 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:12:34 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:12:34 INFO - Using env: {'DISPLAY': ':0', 02:12:34 INFO - 'HOME': '/home/cltbld', 02:12:34 INFO - 'LANG': 'en_US.UTF-8', 02:12:34 INFO - 'LANGUAGE': 'en_US:en', 02:12:34 INFO - 'LOGNAME': 'cltbld', 02:12:34 INFO - 'MAIL': '/var/mail/cltbld', 02:12:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:34 INFO - 'MOZ_NO_REMOTE': '1', 02:12:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:34 INFO - 'NO_EM_RESTART': '1', 02:12:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:34 INFO - 'PWD': '/builds/slave/test', 02:12:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:34 INFO - 'SHELL': '/bin/bash', 02:12:34 INFO - 'SHLVL': '1', 02:12:34 INFO - 'TERM': 'linux', 02:12:34 INFO - 'TMOUT': '86400', 02:12:34 INFO - 'USER': 'cltbld', 02:12:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213', 02:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:34 INFO - '_': '/tools/buildbot/bin/python'} 02:12:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:12:35 INFO - mozversion application_buildid: 20160510233027 02:12:35 INFO - mozversion application_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 02:12:35 INFO - mozversion application_display_name: Nightly 02:12:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:35 INFO - mozversion application_name: Firefox 02:12:35 INFO - mozversion application_remotingname: firefox 02:12:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:12:35 INFO - mozversion application_vendor: Mozilla 02:12:35 INFO - mozversion application_version: 49.0a1 02:12:35 INFO - mozversion platform_buildid: 20160510233027 02:12:35 INFO - mozversion platform_changeset: 91714307a799b978b0a94911cd99ee75a1de0ac5 02:12:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:12:35 INFO - mozversion platform_version: 49.0a1 02:12:35 INFO - using testdate: 1462957955 02:12:35 INFO - actual date: 1462957955 02:12:35 INFO - starting webserver on 'localhost:48744' 02:12:35 INFO - SUITE-START | Running 2 tests 02:12:35 INFO - TEST-START | dromaeo_css 02:12:35 INFO - operating with platform_type : linux_ 02:12:35 INFO - Initialising browser for dromaeo_css test... 02:12:35 INFO - TEST-INFO | started process 994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuk2uH7/profile http://localhost:48744/getInfo.html) 02:12:39 INFO - PROCESS | 994 | __metrics Screen width/height:1600/1200 02:12:39 INFO - PROCESS | 994 | colorDepth:24 02:12:39 INFO - PROCESS | 994 | Browser inner width/height: 1024/697 02:12:39 INFO - PROCESS | 994 | __metrics 02:12:40 ERROR - PROCESS | 994 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:12:40 INFO - TEST-INFO | 994: exit 0 02:12:40 INFO - Browser initialized. 02:12:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:12:40 INFO - TEST-INFO | started process 1082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuk2uH7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:52 INFO - PROCESS | 1082 | RSS: Main: 151261184 02:12:52 INFO - PROCESS | 1082 | 02:13:43 INFO - PROCESS | 1082 | 1462958023362 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:15:51 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48744/tests/dromaeo/cssquery-ext.html) 02:15:52 INFO - PROCESS | 1082 | RSS: Main: 263020544 02:15:52 INFO - PROCESS | 1082 | 02:18:54 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-ext.html (next: http://localhost:48744/tests/dromaeo/cssquery-jquery.html) 02:18:54 INFO - PROCESS | 1082 | RSS: Main: 236134400 02:18:54 INFO - PROCESS | 1082 | 02:21:56 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48744/tests/dromaeo/cssquery-mootools.html) 02:21:57 INFO - PROCESS | 1082 | RSS: Main: 243269632 02:21:57 INFO - PROCESS | 1082 | 02:24:59 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48744/tests/dromaeo/cssquery-prototype.html) 02:24:59 INFO - PROCESS | 1082 | RSS: Main: 236343296 02:24:59 INFO - PROCESS | 1082 | 02:28:02 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48744/tests/dromaeo/cssquery-yui.html) 02:28:03 INFO - PROCESS | 1082 | RSS: Main: 211251200 02:28:03 INFO - PROCESS | 1082 | 02:31:05 INFO - PROCESS | 1082 | Cycle 1(1): loaded http://localhost:48744/tests/dromaeo/cssquery-yui.html (next: http://localhost:48744/tests/dromaeo/cssquery-dojo.html) 02:31:06 INFO - PROCESS | 1082 | RSS: Main: 306995200 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | __start_tp_report 02:31:06 INFO - PROCESS | 1082 | _x_x_mozilla_page_load 02:31:06 INFO - PROCESS | 1082 | _x_x_mozilla_page_load_details 02:31:06 INFO - PROCESS | 1082 | |i|pagename|runs| 02:31:06 INFO - PROCESS | 1082 | |0;dojo.html;3085.9228519287017;3103.0535686615585;3118.8284644344567;3146.2920842810386;3181.1410919051855;5120.718360490171;5170.172772356424;5202.791888324467;5324.62727609067;5327.493888080631;5228.320318358617;5242.842714718565;5248.8687782805355;5253.86865328366;5310.07073762092;4686.765661716918;4729.0541891621815;4842.927356089662;4859.902801943959;4878.07316609843;4640.744759038252;4814.8314808981695;4817.060673168733;4848.587870031051;4878.365812444377;4702.224133018048;4706.811727530895;4714.764261786897;4714.83498077569;4726.385569875929;4759.452662943737;4784.760761961888;4788.832390866303;4820.445648750404;4847.757612119415;4504.346869703907;4671.32265821454;4730.952690473086;4766.118268120409;4775.355327030841;5236.8690782730355;5249.553787928031;5256.973715131438;5261.4475480074425;5267.710275934822;5647.576431767634;5657.717114144276;5699.487046165824;5705.058665320259;5709.457601527848;5449.509544141007;5571.415001424833;5620.381758006616;5643;5761;5307.548858347045;5317.441668624816;5339.385970613391;5343.866403339947;5352.330958630171;5796.362400135981;5806.390329015477;5811.302643682785;5825.1844741736195;5860.501857342174;5391.541718953855;5449.427810079964;5475.6440831345835;5512.0905050667;5572.331320241516;5597.972010139923;5610.074337734228;5625.353084395265;5632.211490391349;5633.774649013993;5366.7853285868905;5541.722913854291;5604;5619.494245517923;5625.774969001276;5570.3315602127195;5597.104463285855;5634.352049514277;5675.829725108253;5679.5172410345585;4303.289957157097;4303.483581970184;4314.590113939171;4322.502912165141;4354.564543545684;3758.0229140423685;3821.808909554511;3865.8260378282484;3883.49514563105;3891.5135608048995;5254.4220135785035;5287.920681189786;5308.734563271898;5318.547923426475;5354.4645535446925;5644.604877658607;5662.943370566241;5673.290838645169;5678.574106941914;5692.914606280826;5125.308083408767;5277.050130976461;5292.761825717852;5301.045811753845;5311.654742441729;4584.541545845389;4871.050145221648;4931.3589233399425;4934.432540257844;4937.604991600663;5914.526837852962;5924.496417804448;5941.732622032019;5943.10853371989;5953.672548009815;5430.9185362218805;5642;5658.20785090096;5705.34388545306;5724.3130824300515;5850.882982340415;5895.852603684943;5896.49879760208;5899.941000589939;5915.645061296336;5625.746841392229;5631.774729010794;5632.718364081861;5632.774689012557;5645.266115404971;5491.039068162976;5638;5669.603127781016;5703.942960570507;5766.711664416678;5480.534154596904;5569.888602228014;5575.665460072409;5576.693281869374;5589.161625756006;5322.520973112439;5546.084895992116;5552.805651802168;5554.305711786027;5566.192902029264;5415.404305526467;5456.48163424474;5469.124940009579;5504.614676972574;5514.476124768141;5613.045782217115;5616.269884914935;5617.522510586482;5621.35354434229;5675.31896172462;5243;5267.157254839208;5434.755436005468;5493.560515158858;5509.724513774376 02:31:06 INFO - PROCESS | 1082 | |1;ext.html;552.30133880641;585.0492948957943;594.0762114911313;605.2192671453823;606.2906399512567;32292;35596.822015889884;35626.64373356269;35650;44123.558764412344;45153.32270015944;45506.317405238864;45629.31556026654;45629.543704562944;45695.77152114243;8743.38796284262;8906.688265910694;8908.242799362062;8918.241949434307;8930.37487375884;8710.912890871074;8818.691345802898;8825.073367296438;8830.955845220766;8834.690785822497;8860.778480538005;8889;8899.955500222522;8900.688475903346;8906.109389061106;8736.126387361277;8777.253933415635;8790.956045219766;8799.78000549985;8907.643694252221;8723.432976856484;8795.428297160664;8815.206631403205;8817.074207208216;8826;42385.78807105945;42630;42862.57137428617;42886;42933.35599966003;3633.909827051874;3760.699144068495;3781.9977705907954;3823.8279277432302;4356.215881141393;31899.52150717741;32203.7356850995;32588.808126456133;33127.17182070443;33824;4290.871273861789;4375.453068366454;4377.7592232427205;4405.713628614129;4532.27483602622;316867;318117;318864;319168.9999999977;319420;34488.31023379569;56754.621899152844;56829;57126;57196;37012.88961331164;37288.25423491515;37377.439338409946;37501.24997500035;37519;14421.711565768626;14526.564203073925;14558;14611.561653150422;14620.634484137769;12259.877401225873;12288.754224915452;12295.56965506203;12298.077644176543;12320.630381088582;8616.310695144373;8616.48301101936;8618.956905215433;8679.305655547541;8685.869711954325;3387.4918762185375;3413.8975830725117;3426.400379933502;3428.5542879425516;3430.365382404263;1033.8993982149939;1058.1746237934424;1081.081081081075;1150.4707834396104;1152.2395219155317;32376.028719138463;32444.675553244637;32899.835500822825;33254.83372583122;33303.3339333212;1109.839073334362;1187.3113594115393;1209.6431552691977;1228.2753175626424;1252.9115729726268;16968.236429360462;17221.7416738749;17401.390951316644;17557.217673820407;17644.76486645948;523197;526202;527557;529795;531765;58834;59638;59695.10457343143;59706.40293597095;59834.70082649646;1300.362822217107;1327.1439921250933;1343.0263059282138;1406.1633328169723;1428.4786053090754;30302.696973029986;33086.338273233916;33304.83347583246;33818.66181338253;34636.13409664779;51680.48319516907;52375.47624523706;52565;52790;53065.46934530605;436381;440395;440721;442730;443636;37368.25263494769;42779;43850.34224486699;44539;44997.55002449934;45445.77277113726;47858.76070619625;48012.66023732962;48426.273605895236;48817.755911220214;40493.59506404898;41292.38061429141;42281.78859105685;42285.788571056946;42766.57233427626;39877;42092.78953605212;43906.780466097465;44735.77632111819;45391;39857.40213896736;40361.192776143725;43631.56368436275;44007.339889901035;44157.116857663306;34861.65138348584;36820.44769328516;37119.44320835135;37223;37514.249715006095;28637;28926;29317.26706832261;29324.387158706475;29381.26546836346 02:31:06 INFO - PROCESS | 1082 | |2;jquery.html;404.7692815095396;407.458080752599;407.5639066199168;411.7694091308865;417.278108871652;12751.744965100692;17826.821731782693;17884.55288617785;19303.517412064706;19539.804601953994;14612.342444589993;16119.83880161198;17937.64124717505;18603.81396186041;19101.331453399132;5566.916496252559;5753.5684823638185;5754.856128596777;5765.855853603673;5801.216835727186;5704.572157088214;5717.228174196493;5739.799107031255;5750.281214848144;5753.309602847664;4075.144219713849;5719.14212868069;6018.307894592134;6339.302676705559;6351.26960399553;6312.968435157841;6380.553361264667;6412.166418365629;6474.935250647481;6488.643124628144;5347.946520534783;5518.448155184489;5542.86142846428;5563.471470210324;5577.2191893135;21009.264675736427;21165.470863228387;21219.46951326214;21989.23037693673;22022.88988555047;2305.124052859919;2448.135050310624;2499.350168956066;2577.136659219164;3032.9090127296217;11981.820272695917;13841.031127821057;13950.162990220619;14205.928970355082;14360.281985900663;1843.0416183584596;1845.6493266279365;1875.3717504635963;1878.445858471754;1981.9801801982085;78406;78593.21406785917;78734.60632696857;79049.60475197645;82206.58896705537;10253.58985640566;10285.794284114276;10305.948470257601;10333.638322658671;10404;14155.787663185061;14184.51062638408;14185.929070354583;14287;14288.785668214985;8112.107668156498;8253.83492330162;8268.173182681683;8355.080941096474;8374.581270936429;8038.995125609299;8071.23323284287;8094.473859199134;8163.346932245406;8268.421210515206;5720.399358067426;6045.78839740607;6514.511411644051;6553.91860343038;6674.699638516278;1895.2703209264257;1963.6170946665263;1963.9410817675493;1965.164804957887;1975;974.0648976982035;1038.4859494550094;1041.073444634276;1088.3089238333714;1100.8403781451805;17739.556511087067;18253.817461825478;18634.161462733937;18994.52513687169;19132.904335478514;1033.0031519583638;1059.8516207730925;1060.7719340341864;1072.4423299884018;1117.80997230471;10197.031282028196;10629.5216715248;10634.73413164677;10766.89233107659;10809.945950270197;456863;459101;459737;463601;478994;78997;80214.59892700499;81564;81674;82495;1056.3609016545033;1073.2272763610188;1073.4452004229884;1097.4403054442291;1099.9065079468176;16096.275667594751;16207.351705931631;16530.504084877473;16537.586560336087;16616.169191540615;35337.64662353344;35430.645693542734;35584.64415355813;35708.46437303494;36633;46239.53760462487;47094.76452617715;48986.51013489819;49474.50525494699;50181;7088.8303429933485;7511.924880751341;7780.961095194488;7913.248241417056;7921.722739704082;10982.505787239434;13407.597772066854;13563.186208827501;13584.86415135836;13618.591442256351;6215.192025036898;9179.495127768037;11488.138389620644;11608.374827524322;12278.754424911273;10672.57309707603;10885.945570272415;10994.34033957933;11420.48607812667;11453.656390308304;11782.99844513226;12145.967592754361;12205.572804951784;12296.139270250997;12314.815277770662;7581.203973582695;7677.961610191914;7716.305532502101;7748.263914928073;7764.858525874454;10522.684319470429;11639.709007274885;11877.109216808602;11899.643010709693;12008.099392545419 02:31:06 INFO - PROCESS | 1082 | |3;mootools.html;1350.291097173983;1550.0931954806442;1586.1593355521575;1767.6742443167625;1878.783939846917;8339.166083391658;8703.782405439859;8727.301815854724;9000.549972501381;9020.097990200977;8767.6054577544;8921.866172007425;8941.597628106734;8988.056254093308;9001.369904106716;1954.6383918974964;2256.334381357495;2319.2578374920076;2324.0471406723245;2367.337145599235;2335.8481698689616;2339.4268404240984;2341.379534423379;2344.777246161612;2348.4011577047913;2210.425289424745;2246.550689862026;2255.357223191391;2256.7404748453973;2258.706368172135;1938.621968716101;2250.4036430345973;2317.918872839451;2329.2429960262984;2343.121329501437;2331.6269396896587;2352.1649814315842;2358.9410264743346;2362.350353652742;2382.1305223593436;8585.01272353681;8633.309335253165;8651.134886511361;8687.26158276541;8692.695755648585;5130.948690513084;5337.946620533823;5381.246625472437;5402.054640437907;5413.729313534308;3491.5286436331025;3548.1484443733575;3581.6776490116013;3744.850205991757;3759.7368184227116;1146.8910453506903;1191.0947679763442;1195.2708847602955;1208.6857417071537;2005.6991451282279;11893.583724569598;12417.068719845958;12417.813732794015;12422.06834487408;12453.315067671274;4581.5647513486165;4794.706297119906;4797.976010119997;4842.6368022398465;4852.660313778072;10347;10464.529096190538;10487.423191724376;10518.894811051945;10519.368837869752;4583.862484125481;5376.731163441812;5423.322084739408;5435.7825686972865;5451.209574611659;4747;4921.3356196912955;4930.2851086592245;4973.676711013773;4983.875403114951;4042.8584999525465;4052.392141178788;4057.634812866856;4081.816318265626;4104.363823607346;1233.6114124050896;1274.833527322508;1276.9680757980939;1284.4926254129566;1297.1244410023196;868.7220089571276;999.5002498750624;1004.7588578741196;1005.5424781724298;1020.5407566594913;5549.2242482405245;5715.541438174919;5753.88492230153;5798.391168927286;5868.413158684183;450.74532888917656;455.1920341394052;459.0703824754898;459.09787268018505;464.81639752297656;3755.868544600926;3881.4565960765517;3895;3895.3183192941124;3975.980120099381;10136.493175341204;10331.276810623183;10412.427316497513;10516.631917882838;10592.788144237073;10244.692659220234;10300.639477618248;10396.376217426978;10396.376217426978;10412.739681507872;7540.736074237376;7606.771796846104;7925.41491701662;7959;7982.401319901031;5546.334439867081;5598.468145526169;5599.188117722989;5717.313922329347;5826.271716035496;9535.951045384863;9605.37565058269;9732.367396119229;9733.659321923982;9776.608935642495;9320.580573874056;9690.224782017563;9692.22462203008;10023.949880250551;10066.094051535105;6862.4853136014;7506.512076714996;7582.848343033219;7687.154413014452;7876.09424916142;8653.480791152551;8677.132286771272;8735.868961965449;8789.604467799092;8808.955955220183;7579.583122928292;7766.5728384939375;7791.104023037196;7860.646270917937;8065.112837587978;7708.152103268524;7754.651040703069;7781.338586220008;7785.260400261966;7991.920080799117;7105.680244389118;7127.607981561064;7130.073090498202;7169.749058782918;7175.174854891754;4994.600431965507;5146.6911985281;5269.78920843162;5279.736013199402;5355.357357117171;5209.71346575942;5220.1647736362;5319.816991118785;5404.351477822686;5568.860778480571 02:31:06 INFO - PROCESS | 1082 | |4;prototype.html;327.75090930892515;328.23521195614217;333.6996702967329;338.1934087202022;340.6389227418936;4852.660313778037;4957;5016.799328026879;5048.772805223769;5096.898062038762;4980.203167493201;5023.5981121510285;5060.41805192403;5063.9493605063935;5065.505675825631;3997.6601988830985;4013.3779264214095;4027.154297597508;4029.8388064477385;4044.373122166069;3754.530683664542;3770.435269363211;3933.409988501719;3998.280309544281;4001.599440195923;3925.6456522499693;3938.645521903028;3940.330143875548;3941.9014524636827;3957.663598594123;3888.747231429962;3918.8824335269846;3924.9803750981064;3942;3949.7630142191274;3486.3724529584665;3528;3534.8409321580334;3559.2703495783303;3585.551806024247;4708.340832283483;4863.221884498464;4867.9269810952865;4901.485344038896;4953.331300274489;4454.910901781978;4464.285714285698;4466.297889776671;4488.483824360208;4488.618467430272;4990.575801056914;5205.802665386982;5231.686098834082;5238.68567885928;5258.81594144207;3771.8868433947027;3785.6782173515285;3796.8040067378965;3798.2783271178387;3806.029462487048;5434.53267617741;5460.699661518575;5468.234447177399;5515.448455154453;5532.529734972532;3663.5603727552866;3850.133719912997;3883.8446462141196;3891.591382904754;3903.1803321302277;3914.4715463412645;3931.1548017176447;3953.683705303569;3964.920701585952;3965.306071437487;4457.665675074318;4481.126180394792;4505.166544189336;4506.707064040893;4520.909581808345;5203.791848326025;5317.511096892877;5356.785728570813;5360.517553420211;5378.892422151535;1282.4613662261872;1312.665270356053;1338.4445455136204;1355.6881917158912;1356.4506374918174;876.1413814461863;879.9956000219958;891.9331050171263;894.9529051010334;897.1611543207122;4450.931776373647;4454.21611492817;4497.347884556721;4509.526499717548;4525.886852828706;4668.649851261169;4683.391159149289;4706.388169537938;4709;4738.715677059387;4414.073044660593;4414.955850441519;4422.84520041797;4435.489918659331;4437.2234858899565;2382.9285121446383;2486.6643003194336;2512.7361627029263;2523.823332366717;2535.6069809179608;4741.83403580873;4772.993014400975;4788.880277993008;4805.567498925044;4814.253790662453;4674.223794957894;4675.784296082975;4742.928856067162;4755.358026666425;4755.622188905547;4519.88700282489;4734.91097047681;4785.234362501983;4786.994731106437;4820.39745031871;4638.9330453996445;4643.651726120487;4652.697574657636;4682.384577320819;4731.929021064756;4602.7008244464005;4663.207254766766;4663.766811659336;4678.269040455053;4734.313524538991;4740.720005598538;5160.742850454574;5570.805021824379;5585.776568937197;5616.550675945833;3860.9961410034157;3935.2326296371934;3950.980245098871;3962.2867883781196;3970.7617542947514;5226.764795584284;5421.945780542144;5453.772901097222;5473.781048758005;5480.616356854982;4961.328616823596;5259.317018554026;5280.339957505312;5301.151815709468;5306.204069389468;5265.420373887895;5274.182501712241;5283.762230699705;5285.43656326689;5292.179712144623;5044.899102018013;5176.249443830548;5176.275321454924;5179.47205574364;5208.973955130352;5246.632735708464;5297.973510132425;5332.5467335276935;5338.386085600206;5357;5147.5881929446305;5188.377394712658;5201.193814958688;5229.738513074255;5263.815766448156 02:31:06 INFO - PROCESS | 1082 | |5;yui.html;798.2895223251307;799.5522507395859;829.7344849648111;844.3329769482109;871.3987348729377;14347.497837575687;14392.49626263081;14515.201663908481;14593.489227877;14634.634134146652;13810.1713897166;13812.861871381283;13819.239941803196;13857.514986975459;13937.790933136012;676.2831398717375;789.2778108031144;797.952122872628;811.6144831205189;816.4040250617053;797.5254723439573;800.1998001998002;803.5138741061631;804.1074407407773;806.6289506826837;851.9701810436636;852.5864955496579;854.1415877043594;856.4475913036088;858.0175698824874;703.4407645921505;827.5655280977505;841.3479553346144;856.5117882806802;857.0914830279924;631.3686313686313;633.7845132654874;633.8668879535303;634.0425956805211;634.5621521150438;13553.254570998592;13556.389962451713;13560.321983900765;13583.796243056362;13641.386137623731;13166.21002739829;13450.93274533631;13503.12229705066;13650.453981840714;13689.931550342184;11684.182107252496;11937.104717146161;11958.701032474171;11976.036035143192;12170.75658486834;4272;4313.9137217255475;4327.935080973788;4403.471583409979;4408.669349798778;50480.242796358085;53192;53638.195427068626;53733.99999999961;53864.46135538634;9972.650957216463;10071.24465665078;10116.949415252877;10165.898341016644;10310.845337319946;17848.286068557372;17965.820341796414;18067.638647227246;18231.45305640833;18248.726269105973;7866.528008319519;7872.567008814455;7896.526208427398;7979.9202007979175;8101.716439924574;4398.934015989763;4744.098621261949;4808.735519546459;4878.292647566083;4915.975420122948;3330.167458135466;3423.845926933294;3428.9314213715584;3444.9311013779584;3447.6035255945385;604.0576700347384;618.6133666458463;628.8930881750114;631.2551189596229;637.7130291368902;627.9560430769893;738.6823665823747;742.3801126059693;758.8216769059267;780.9808200298552;9115.98908431769;9496.810063798823;9643.517824108767;9713.174380177623;9729.756756081013;710.2152121905324;710.4848984486206;719.9208087110413;729.5513259345464;743.5427212264526;4294.312909934395;4387.298032314814;4441.622462090694;4481.215787237221;4514.074614703978;58899.41100589025;61179.38820611826;61899.38100618936;61992.380076198664;62082.37917620856;53060.469395305554;53607.46392536024;53647.46352536503;54635.726821366436;55370.44629553734;50719.492805072216;50905.490945090816;51108.744456278226;52024.73987630037;52107.73946130321;8518.574071296534;8617.69838055665;8622.698205562776;8729.694460693845;8790.560471976503;30113.397732045676;32038.199045023128;32077.35845283128;33395.66604333925;33798.49302260419;42195.78902105593;42293.15413691648;43126.35310470283;43945.78027109972;45121;12275.386230688251;12482.625521234377;12541.372931353579;12722.363881805688;12967.935160324138;11813.232139910879;13116.799524681808;13854.515091971733;14370.784438233226;14884.404623814926;12780.488780448677;12920.22478651284;13219.339033048502;13258.668533286746;13580.52468163649;13175.93412032972;13190.188608203045;13804.93097534506;13898.58304250874;14287.285635718381;13195.472181113031;13255.536056237985;13484.86515134836;13686.110402823784;13776.793348099585;10880.129589632652;10924;10956;11278.605248816251;11301.491432885376;11020.614278500214;11254.482422941825;11439.885601144215;11463.197576169921;11621.593244236412 02:31:06 INFO - PROCESS | 1082 | __end_tp_report 02:31:06 INFO - PROCESS | 1082 | __start_cc_report 02:31:06 INFO - PROCESS | 1082 | _x_x_mozilla_cycle_collect,823 02:31:06 INFO - PROCESS | 1082 | __end_cc_report 02:31:06 INFO - PROCESS | 1082 | __startTimestamp1462959066039__endTimestamp 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | ------- Summary: start ------- 02:31:06 INFO - PROCESS | 1082 | Number of tests: 6 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#0] dojo.html Cycles:165 Average:5241.04 Median:5434.76 stddev:600.17 (11.0%) stddev-sans-first:577.70 02:31:06 INFO - PROCESS | 1082 | Values: 3085.9 3103.1 3118.8 3146.3 3181.1 5120.7 5170.2 5202.8 5324.6 5327.5 5228.3 5242.8 5248.9 5253.9 5310.1 4686.8 4729.1 4842.9 4859.9 4878.1 4640.7 4814.8 4817.1 4848.6 4878.4 4702.2 4706.8 4714.8 4714.8 4726.4 4759.5 4784.8 4788.8 4820.4 4847.8 4504.3 4671.3 4731.0 4766.1 4775.4 5236.9 5249.6 5257.0 5261.4 5267.7 5647.6 5657.7 5699.5 5705.1 5709.5 5449.5 5571.4 5620.4 5643.0 5761.0 5307.5 5317.4 5339.4 5343.9 5352.3 5796.4 5806.4 5811.3 5825.2 5860.5 5391.5 5449.4 5475.6 5512.1 5572.3 5598.0 5610.1 5625.4 5632.2 5633.8 5366.8 5541.7 5604.0 5619.5 5625.8 5570.3 5597.1 5634.4 5675.8 5679.5 4303.3 4303.5 4314.6 4322.5 4354.6 3758.0 3821.8 3865.8 3883.5 3891.5 5254.4 5287.9 5308.7 5318.5 5354.5 5644.6 5662.9 5673.3 5678.6 5692.9 5125.3 5277.1 5292.8 5301.0 5311.7 4584.5 4871.1 4931.4 4934.4 4937.6 5914.5 5924.5 5941.7 5943.1 5953.7 5430.9 5642.0 5658.2 5705.3 5724.3 5850.9 5895.9 5896.5 5899.9 5915.6 5625.7 5631.8 5632.7 5632.8 5645.3 5491.0 5638.0 5669.6 5703.9 5766.7 5480.5 5569.9 5575.7 5576.7 5589.2 5322.5 5546.1 5552.8 5554.3 5566.2 5415.4 5456.5 5469.1 5504.6 5514.5 5613.0 5616.3 5617.5 5621.4 5675.3 5243.0 5267.2 5434.8 5493.6 5509.7 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#1] ext.html Cycles:180 Average:58582.47 Median:42772.79 stddev:116104.55 (271.4%) stddev-sans-first:116348.50 02:31:06 INFO - PROCESS | 1082 | Values: 552.3 585.0 594.1 605.2 606.3 32292.0 35596.8 35626.6 35650.0 44123.6 45153.3 45506.3 45629.3 45629.5 45695.8 8743.4 8906.7 8908.2 8918.2 8930.4 8710.9 8818.7 8825.1 8831.0 8834.7 8860.8 8889.0 8900.0 8900.7 8906.1 8736.1 8777.3 8791.0 8799.8 8907.6 8723.4 8795.4 8815.2 8817.1 8826.0 42385.8 42630.0 42862.6 42886.0 42933.4 3633.9 3760.7 3782.0 3823.8 4356.2 31899.5 32203.7 32588.8 33127.2 33824.0 4290.9 4375.5 4377.8 4405.7 4532.3 316867.0 318117.0 318864.0 319169.0 319420.0 34488.3 56754.6 56829.0 57126.0 57196.0 37012.9 37288.3 37377.4 37501.2 37519.0 14421.7 14526.6 14558.0 14611.6 14620.6 12259.9 12288.8 12295.6 12298.1 12320.6 8616.3 8616.5 8619.0 8679.3 8685.9 3387.5 3413.9 3426.4 3428.6 3430.4 1033.9 1058.2 1081.1 1150.5 1152.2 32376.0 32444.7 32899.8 33254.8 33303.3 1109.8 1187.3 1209.6 1228.3 1252.9 16968.2 17221.7 17401.4 17557.2 17644.8 523197.0 526202.0 527557.0 529795.0 531765.0 58834.0 59638.0 59695.1 59706.4 59834.7 1300.4 1327.1 1343.0 1406.2 1428.5 30302.7 33086.3 33304.8 33818.7 34636.1 51680.5 52375.5 52565.0 52790.0 53065.5 436381.0 440395.0 440721.0 442730.0 443636.0 37368.3 42779.0 43850.3 44539.0 44997.6 45445.8 47858.8 48012.7 48426.3 48817.8 40493.6 41292.4 42281.8 42285.8 42766.6 39877.0 42092.8 43906.8 44735.8 45391.0 39857.4 40361.2 43631.6 44007.3 44157.1 34861.7 36820.4 37119.4 37223.0 37514.2 28637.0 28926.0 29317.3 29324.4 29381.3 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#2] jquery.html Cycles:180 Average:27314.29 Median:22006.06 stddev:76248.21 (346.5%) stddev-sans-first:76435.33 02:31:06 INFO - PROCESS | 1082 | Values: 404.8 407.5 407.6 411.8 417.3 12751.7 17826.8 17884.6 19303.5 19539.8 14612.3 16119.8 17937.6 18603.8 19101.3 5566.9 5753.6 5754.9 5765.9 5801.2 5704.6 5717.2 5739.8 5750.3 5753.3 4075.1 5719.1 6018.3 6339.3 6351.3 6313.0 6380.6 6412.2 6474.9 6488.6 5347.9 5518.4 5542.9 5563.5 5577.2 21009.3 21165.5 21219.5 21989.2 22022.9 2305.1 2448.1 2499.4 2577.1 3032.9 11981.8 13841.0 13950.2 14205.9 14360.3 1843.0 1845.6 1875.4 1878.4 1982.0 78406.0 78593.2 78734.6 79049.6 82206.6 10253.6 10285.8 10305.9 10333.6 10404.0 14155.8 14184.5 14185.9 14287.0 14288.8 8112.1 8253.8 8268.2 8355.1 8374.6 8039.0 8071.2 8094.5 8163.3 8268.4 5720.4 6045.8 6514.5 6553.9 6674.7 1895.3 1963.6 1963.9 1965.2 1975.0 974.1 1038.5 1041.1 1088.3 1100.8 17739.6 18253.8 18634.2 18994.5 19132.9 1033.0 1059.9 1060.8 1072.4 1117.8 10197.0 10629.5 10634.7 10766.9 10809.9 456863.0 459101.0 459737.0 463601.0 478994.0 78997.0 80214.6 81564.0 81674.0 82495.0 1056.4 1073.2 1073.4 1097.4 1099.9 16096.3 16207.4 16530.5 16537.6 16616.2 35337.6 35430.6 35584.6 35708.5 36633.0 46239.5 47094.8 48986.5 49474.5 50181.0 7088.8 7511.9 7781.0 7913.2 7921.7 10982.5 13407.6 13563.2 13584.9 13618.6 6215.2 9179.5 11488.1 11608.4 12278.8 10672.6 10885.9 10994.3 11420.5 11453.7 11783.0 12146.0 12205.6 12296.1 12314.8 7581.2 7678.0 7716.3 7748.3 7764.9 10522.7 11639.7 11877.1 11899.6 12008.1 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#3] mootools.html Cycles:180 Average:5750.23 Median:4847.65 stddev:3237.49 (66.8%) stddev-sans-first:3229.69 02:31:06 INFO - PROCESS | 1082 | Values: 1350.3 1550.1 1586.2 1767.7 1878.8 8339.2 8703.8 8727.3 9000.5 9020.1 8767.6 8921.9 8941.6 8988.1 9001.4 1954.6 2256.3 2319.3 2324.0 2367.3 2335.8 2339.4 2341.4 2344.8 2348.4 2210.4 2246.6 2255.4 2256.7 2258.7 1938.6 2250.4 2317.9 2329.2 2343.1 2331.6 2352.2 2358.9 2362.4 2382.1 8585.0 8633.3 8651.1 8687.3 8692.7 5130.9 5337.9 5381.2 5402.1 5413.7 3491.5 3548.1 3581.7 3744.9 3759.7 1146.9 1191.1 1195.3 1208.7 2005.7 11893.6 12417.1 12417.8 12422.1 12453.3 4581.6 4794.7 4798.0 4842.6 4852.7 10347.0 10464.5 10487.4 10518.9 10519.4 4583.9 5376.7 5423.3 5435.8 5451.2 4747.0 4921.3 4930.3 4973.7 4983.9 4042.9 4052.4 4057.6 4081.8 4104.4 1233.6 1274.8 1277.0 1284.5 1297.1 868.7 999.5 1004.8 1005.5 1020.5 5549.2 5715.5 5753.9 5798.4 5868.4 450.7 455.2 459.1 459.1 464.8 3755.9 3881.5 3895.0 3895.3 3976.0 10136.5 10331.3 10412.4 10516.6 10592.8 10244.7 10300.6 10396.4 10396.4 10412.7 7540.7 7606.8 7925.4 7959.0 7982.4 5546.3 5598.5 5599.2 5717.3 5826.3 9536.0 9605.4 9732.4 9733.7 9776.6 9320.6 9690.2 9692.2 10023.9 10066.1 6862.5 7506.5 7582.8 7687.2 7876.1 8653.5 8677.1 8735.9 8789.6 8809.0 7579.6 7766.6 7791.1 7860.6 8065.1 7708.2 7754.7 7781.3 7785.3 7991.9 7105.7 7127.6 7130.1 7169.7 7175.2 4994.6 5146.7 5269.8 5279.7 5355.4 5209.7 5220.2 5319.8 5404.4 5568.9 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#4] prototype.html Cycles:180 Average:4273.13 Median:4680.33 stddev:1227.27 (26.2%) stddev-sans-first:1194.45 02:31:06 INFO - PROCESS | 1082 | Values: 327.8 328.2 333.7 338.2 340.6 4852.7 4957.0 5016.8 5048.8 5096.9 4980.2 5023.6 5060.4 5063.9 5065.5 3997.7 4013.4 4027.2 4029.8 4044.4 3754.5 3770.4 3933.4 3998.3 4001.6 3925.6 3938.6 3940.3 3941.9 3957.7 3888.7 3918.9 3925.0 3942.0 3949.8 3486.4 3528.0 3534.8 3559.3 3585.6 4708.3 4863.2 4867.9 4901.5 4953.3 4454.9 4464.3 4466.3 4488.5 4488.6 4990.6 5205.8 5231.7 5238.7 5258.8 3771.9 3785.7 3796.8 3798.3 3806.0 5434.5 5460.7 5468.2 5515.4 5532.5 3663.6 3850.1 3883.8 3891.6 3903.2 3914.5 3931.2 3953.7 3964.9 3965.3 4457.7 4481.1 4505.2 4506.7 4520.9 5203.8 5317.5 5356.8 5360.5 5378.9 1282.5 1312.7 1338.4 1355.7 1356.5 876.1 880.0 891.9 895.0 897.2 4450.9 4454.2 4497.3 4509.5 4525.9 4668.6 4683.4 4706.4 4709.0 4738.7 4414.1 4415.0 4422.8 4435.5 4437.2 2382.9 2486.7 2512.7 2523.8 2535.6 4741.8 4773.0 4788.9 4805.6 4814.3 4674.2 4675.8 4742.9 4755.4 4755.6 4519.9 4734.9 4785.2 4787.0 4820.4 4638.9 4643.7 4652.7 4682.4 4731.9 4602.7 4663.2 4663.8 4678.3 4734.3 4740.7 5160.7 5570.8 5585.8 5616.6 3861.0 3935.2 3951.0 3962.3 3970.8 5226.8 5421.9 5453.8 5473.8 5480.6 4961.3 5259.3 5280.3 5301.2 5306.2 5265.4 5274.2 5283.8 5285.4 5292.2 5044.9 5176.2 5176.3 5179.5 5209.0 5246.6 5298.0 5332.5 5338.4 5357.0 5147.6 5188.4 5201.2 5229.7 5263.8 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - PROCESS | 1082 | [#5] yui.html Cycles:180 Average:14711.45 Median:4425.15 stddev:16744.72 (378.4%) stddev-sans-first:16759.10 02:31:06 INFO - PROCESS | 1082 | Values: 798.3 799.6 829.7 844.3 871.4 14347.5 14392.5 14515.2 14593.5 14634.6 13810.2 13812.9 13819.2 13857.5 13937.8 676.3 789.3 798.0 811.6 816.4 797.5 800.2 803.5 804.1 806.6 852.0 852.6 854.1 856.4 858.0 703.4 827.6 841.3 856.5 857.1 631.4 633.8 633.9 634.0 634.6 13553.3 13556.4 13560.3 13583.8 13641.4 13166.2 13450.9 13503.1 13650.5 13689.9 11684.2 11937.1 11958.7 11976.0 12170.8 4272.0 4313.9 4327.9 4403.5 4408.7 50480.2 53192.0 53638.2 53734.0 53864.5 9972.7 10071.2 10116.9 10165.9 10310.8 17848.3 17965.8 18067.6 18231.5 18248.7 7866.5 7872.6 7896.5 7979.9 8101.7 4398.9 4744.1 4808.7 4878.3 4916.0 3330.2 3423.8 3428.9 3444.9 3447.6 604.1 618.6 628.9 631.3 637.7 628.0 738.7 742.4 758.8 781.0 9116.0 9496.8 9643.5 9713.2 9729.8 710.2 710.5 719.9 729.6 743.5 4294.3 4387.3 4441.6 4481.2 4514.1 58899.4 61179.4 61899.4 61992.4 62082.4 53060.5 53607.5 53647.5 54635.7 55370.4 50719.5 50905.5 51108.7 52024.7 52107.7 8518.6 8617.7 8622.7 8729.7 8790.6 30113.4 32038.2 32077.4 33395.7 33798.5 42195.8 42293.2 43126.4 43945.8 45121.0 12275.4 12482.6 12541.4 12722.4 12967.9 11813.2 13116.8 13854.5 14370.8 14884.4 12780.5 12920.2 13219.3 13258.7 13580.5 13175.9 13190.2 13804.9 13898.6 14287.3 13195.5 13255.5 13484.9 13686.1 13776.8 10880.1 10924.0 10956.0 11278.6 11301.5 11020.6 11254.5 11439.9 11463.2 11621.6 02:31:06 INFO - PROCESS | 1082 | -------- Summary: end -------- 02:31:06 INFO - PROCESS | 1082 | 02:31:06 INFO - TEST-INFO | 1082: exit 0 02:31:06 INFO - TEST-OK | dromaeo_css | took 1111395ms 02:31:06 INFO - TEST-START | kraken 02:31:06 INFO - operating with platform_type : linux_ 02:31:06 INFO - Initialising browser for kraken test... 02:31:06 INFO - TEST-INFO | started process 1340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWO3ku/profile http://localhost:48744/getInfo.html) 02:31:10 INFO - PROCESS | 1340 | __metrics Screen width/height:1600/1200 02:31:10 INFO - PROCESS | 1340 | colorDepth:24 02:31:10 INFO - PROCESS | 1340 | Browser inner width/height: 1024/697 02:31:10 INFO - PROCESS | 1340 | __metrics 02:31:11 ERROR - PROCESS | 1340 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:31:12 INFO - TEST-INFO | 1340: exit 0 02:31:12 INFO - Browser initialized. 02:31:12 INFO - Running cycle 1/1 for kraken test... 02:31:12 INFO - TEST-INFO | started process 1422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWO3ku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:23 INFO - PROCESS | 1422 | RSS: Main: 151195648 02:31:23 INFO - PROCESS | 1422 | 02:31:26 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48744/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:27 INFO - PROCESS | 1422 | RSS: Main: 206794752 02:31:27 INFO - PROCESS | 1422 | 02:31:29 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48744/tests/kraken/driver.html?testName=audio-dft) 02:31:30 INFO - PROCESS | 1422 | RSS: Main: 196251648 02:31:30 INFO - PROCESS | 1422 | 02:31:33 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48744/tests/kraken/driver.html?testName=audio-fft) 02:31:34 INFO - PROCESS | 1422 | RSS: Main: 263421952 02:31:34 INFO - PROCESS | 1422 | 02:31:36 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48744/tests/kraken/driver.html?testName=audio-oscillator) 02:31:36 INFO - PROCESS | 1422 | RSS: Main: 173035520 02:31:36 INFO - PROCESS | 1422 | 02:31:39 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:31:39 INFO - PROCESS | 1422 | RSS: Main: 177971200 02:31:39 INFO - PROCESS | 1422 | 02:31:42 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48744/tests/kraken/driver.html?testName=imaging-darkroom) 02:31:43 INFO - PROCESS | 1422 | RSS: Main: 213159936 02:31:43 INFO - PROCESS | 1422 | 02:31:47 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48744/tests/kraken/driver.html?testName=imaging-desaturate) 02:31:47 INFO - PROCESS | 1422 | RSS: Main: 211365888 02:31:47 INFO - PROCESS | 1422 | 02:31:50 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48744/tests/kraken/driver.html?testName=json-parse-financial) 02:31:51 INFO - PROCESS | 1422 | RSS: Main: 212529152 02:31:51 INFO - PROCESS | 1422 | 02:31:52 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:31:53 INFO - PROCESS | 1422 | RSS: Main: 203055104 02:31:53 INFO - PROCESS | 1422 | 02:31:55 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:31:55 INFO - PROCESS | 1422 | RSS: Main: 205750272 02:31:55 INFO - PROCESS | 1422 | 02:31:57 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:58 INFO - PROCESS | 1422 | RSS: Main: 214597632 02:31:58 INFO - PROCESS | 1422 | 02:32:01 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:02 INFO - PROCESS | 1422 | RSS: Main: 221806592 02:32:02 INFO - PROCESS | 1422 | 02:32:04 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:05 INFO - PROCESS | 1422 | RSS: Main: 217677824 02:32:05 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | Cycle 1(1): loaded http://localhost:48744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48744/tests/kraken/driver.html?testName=ai-astar) 02:32:07 INFO - PROCESS | 1422 | RSS: Main: 262909952 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | __start_tp_report 02:32:07 INFO - PROCESS | 1422 | _x_x_mozilla_page_load 02:32:07 INFO - PROCESS | 1422 | _x_x_mozilla_page_load_details 02:32:07 INFO - PROCESS | 1422 | |i|pagename|runs| 02:32:07 INFO - PROCESS | 1422 | |0;ai-astar;114;108;114;113;111;112;113;112;113;114 02:32:07 INFO - PROCESS | 1422 | |1;audio-beat-detection;152;134;161;210;134;154;156;132;183;132 02:32:07 INFO - PROCESS | 1422 | |2;audio-dft;163;164;164;164;163;162;163;162;163;164 02:32:07 INFO - PROCESS | 1422 | |3;audio-fft;79;77;78;149;78;76;78;77;132;77 02:32:07 INFO - PROCESS | 1422 | |4;audio-oscillator;93;93;145;94;93;93;123;93;94;118 02:32:07 INFO - PROCESS | 1422 | |5;imaging-gaussian-blur;119;118;117;119;119;119;118;117;118;117 02:32:07 INFO - PROCESS | 1422 | |6;imaging-darkroom;149;148;148;148;149;148;148;148;147;149 02:32:07 INFO - PROCESS | 1422 | |7;imaging-desaturate;97;97;97;96;96;97;96;96;97;96 02:32:07 INFO - PROCESS | 1422 | |8;json-parse-financial;57;57;58;58;59;58;58;111;55;55 02:32:07 INFO - PROCESS | 1422 | |9;json-stringify-tinderbox;60;60;59;59;60;60;60;60;61;60 02:32:07 INFO - PROCESS | 1422 | |10;stanford-crypto-aes;86;84;82;81;86;85;83;83;84;82 02:32:07 INFO - PROCESS | 1422 | |11;stanford-crypto-ccm;150;140;136;137;141;131;131;132;204;132 02:32:07 INFO - PROCESS | 1422 | |12;stanford-crypto-pbkdf2;178;170;169;167;170;167;169;180;170;168 02:32:07 INFO - PROCESS | 1422 | |13;stanford-crypto-sha256-iterative;66;66;67;66;67;71;67;67;66;66 02:32:07 INFO - PROCESS | 1422 | __end_tp_report 02:32:07 INFO - PROCESS | 1422 | __start_cc_report 02:32:07 INFO - PROCESS | 1422 | _x_x_mozilla_cycle_collect,1711 02:32:07 INFO - PROCESS | 1422 | __end_cc_report 02:32:07 INFO - PROCESS | 1422 | __startTimestamp1462959127353__endTimestamp 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | ------- Summary: start ------- 02:32:07 INFO - PROCESS | 1422 | Number of tests: 14 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.84 (1.6%) stddev-sans-first:1.86 02:32:07 INFO - PROCESS | 1422 | Values: 114.0 108.0 114.0 113.0 111.0 112.0 113.0 112.0 113.0 114.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:155.00 stddev:25.38 (16.4%) stddev-sans-first:26.90 02:32:07 INFO - PROCESS | 1422 | Values: 152.0 134.0 161.0 210.0 134.0 154.0 156.0 132.0 183.0 132.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:32:07 INFO - PROCESS | 1422 | Values: 163.0 164.0 164.0 164.0 163.0 162.0 163.0 162.0 163.0 164.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#3] audio-fft Cycles:10 Average:90.10 Median:77.50 stddev:26.88 (34.7%) stddev-sans-first:28.20 02:32:07 INFO - PROCESS | 1422 | Values: 79.0 77.0 78.0 149.0 78.0 76.0 78.0 77.0 132.0 77.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:93.00 stddev:18.39 (19.8%) stddev-sans-first:19.08 02:32:07 INFO - PROCESS | 1422 | Values: 93.0 93.0 145.0 94.0 93.0 93.0 123.0 93.0 94.0 118.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 02:32:07 INFO - PROCESS | 1422 | Values: 119.0 118.0 117.0 119.0 119.0 119.0 118.0 117.0 118.0 117.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:32:07 INFO - PROCESS | 1422 | Values: 149.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 147.0 149.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:32:07 INFO - PROCESS | 1422 | Values: 97.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:58.00 stddev:17.06 (29.4%) stddev-sans-first:17.97 02:32:07 INFO - PROCESS | 1422 | Values: 57.0 57.0 58.0 58.0 59.0 58.0 58.0 111.0 55.0 55.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:32:07 INFO - PROCESS | 1422 | Values: 60.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 61.0 60.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.71 (2.0%) stddev-sans-first:1.58 02:32:07 INFO - PROCESS | 1422 | Values: 86.0 84.0 82.0 81.0 86.0 85.0 83.0 83.0 84.0 82.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:138.50 stddev:22.10 (16.0%) stddev-sans-first:23.31 02:32:07 INFO - PROCESS | 1422 | Values: 150.0 140.0 136.0 137.0 141.0 131.0 131.0 132.0 204.0 132.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:170.00 stddev:4.49 (2.6%) stddev-sans-first:3.94 02:32:07 INFO - PROCESS | 1422 | Values: 178.0 170.0 169.0 167.0 170.0 167.0 169.0 180.0 170.0 168.0 02:32:07 INFO - PROCESS | 1422 | 02:32:07 INFO - PROCESS | 1422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 02:32:07 INFO - PROCESS | 1422 | Values: 66.0 66.0 67.0 66.0 67.0 71.0 67.0 67.0 66.0 66.0 02:32:07 INFO - PROCESS | 1422 | -------- Summary: end -------- 02:32:07 INFO - PROCESS | 1422 | 02:32:08 INFO - TEST-INFO | 1422: exit 0 02:32:08 INFO - TEST-OK | kraken | took 61617ms 02:32:08 INFO - SUITE-END | took 1173s 02:32:08 INFO - Completed test suite (00:19:33) 02:32:08 INFO - javascript benchmark 02:32:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.9228519287017, 3103.0535686615585, 3118.8284644344567, 3146.2920842810386, 3181.1410919051855, 5120.718360490171, 5170.172772356424, 5202.791888324467, 5324.62727609067, 5327.493888080631, 5228.320318358617, 5242.842714718565, 5248.8687782805355, 5253.86865328366, 5310.07073762092, 4686.765661716918, 4729.0541891621815, 4842.927356089662, 4859.902801943959, 4878.07316609843, 4640.744759038252, 4814.8314808981695, 4817.060673168733, 4848.587870031051, 4878.365812444377, 4702.224133018048, 4706.811727530895, 4714.764261786897, 4714.83498077569, 4726.385569875929, 4759.452662943737, 4784.760761961888, 4788.832390866303, 4820.445648750404, 4847.757612119415, 4504.346869703907, 4671.32265821454, 4730.952690473086, 4766.118268120409, 4775.355327030841, 5236.8690782730355, 5249.553787928031, 5256.973715131438, 5261.4475480074425, 5267.710275934822, 5647.576431767634, 5657.717114144276, 5699.487046165824, 5705.058665320259, 5709.457601527848, 5449.509544141007, 5571.415001424833, 5620.381758006616, 5643.0, 5761.0, 5307.548858347045, 5317.441668624816, 5339.385970613391, 5343.866403339947, 5352.330958630171, 5796.362400135981, 5806.390329015477, 5811.302643682785, 5825.1844741736195, 5860.501857342174, 5391.541718953855, 5449.427810079964, 5475.6440831345835, 5512.0905050667, 5572.331320241516, 5597.972010139923, 5610.074337734228, 5625.353084395265, 5632.211490391349, 5633.774649013993, 5366.7853285868905, 5541.722913854291, 5604.0, 5619.494245517923, 5625.774969001276, 5570.3315602127195, 5597.104463285855, 5634.352049514277, 5675.829725108253, 5679.5172410345585, 4303.289957157097, 4303.483581970184, 4314.590113939171, 4322.502912165141, 4354.564543545684, 3758.0229140423685, 3821.808909554511, 3865.8260378282484, 3883.49514563105, 3891.5135608048995, 5254.4220135785035, 5287.920681189786, 5308.734563271898, 5318.547923426475, 5354.4645535446925, 5644.604877658607, 5662.943370566241, 5673.290838645169, 5678.574106941914, 5692.914606280826, 5125.308083408767, 5277.050130976461, 5292.761825717852, 5301.045811753845, 5311.654742441729, 4584.541545845389, 4871.050145221648, 4931.3589233399425, 4934.432540257844, 4937.604991600663, 5914.526837852962, 5924.496417804448, 5941.732622032019, 5943.10853371989, 5953.672548009815, 5430.9185362218805, 5642.0, 5658.20785090096, 5705.34388545306, 5724.3130824300515, 5850.882982340415, 5895.852603684943, 5896.49879760208, 5899.941000589939, 5915.645061296336, 5625.746841392229, 5631.774729010794, 5632.718364081861, 5632.774689012557, 5645.266115404971, 5491.039068162976, 5638.0, 5669.603127781016, 5703.942960570507, 5766.711664416678, 5480.534154596904, 5569.888602228014, 5575.665460072409, 5576.693281869374, 5589.161625756006, 5322.520973112439, 5546.084895992116, 5552.805651802168, 5554.305711786027, 5566.192902029264, 5415.404305526467, 5456.48163424474, 5469.124940009579, 5504.614676972574, 5514.476124768141, 5613.045782217115, 5616.269884914935, 5617.522510586482, 5621.35354434229, 5675.31896172462, 5243.0, 5267.157254839208, 5434.755436005468, 5493.560515158858, 5509.724513774376], "value": 5201.059004298925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.30133880641, 585.0492948957943, 594.0762114911313, 605.2192671453823, 606.2906399512567, 32292.0, 35596.822015889884, 35626.64373356269, 35650.0, 44123.558764412344, 45153.32270015944, 45506.317405238864, 45629.31556026654, 45629.543704562944, 45695.77152114243, 8743.38796284262, 8906.688265910694, 8908.242799362062, 8918.241949434307, 8930.37487375884, 8710.912890871074, 8818.691345802898, 8825.073367296438, 8830.955845220766, 8834.690785822497, 8860.778480538005, 8889.0, 8899.955500222522, 8900.688475903346, 8906.109389061106, 8736.126387361277, 8777.253933415635, 8790.956045219766, 8799.78000549985, 8907.643694252221, 8723.432976856484, 8795.428297160664, 8815.206631403205, 8817.074207208216, 8826.0, 42385.78807105945, 42630.0, 42862.57137428617, 42886.0, 42933.35599966003, 3633.909827051874, 3760.699144068495, 3781.9977705907954, 3823.8279277432302, 4356.215881141393, 31899.52150717741, 32203.7356850995, 32588.808126456133, 33127.17182070443, 33824.0, 4290.871273861789, 4375.453068366454, 4377.7592232427205, 4405.713628614129, 4532.27483602622, 316867.0, 318117.0, 318864.0, 319168.9999999977, 319420.0, 34488.31023379569, 56754.621899152844, 56829.0, 57126.0, 57196.0, 37012.88961331164, 37288.25423491515, 37377.439338409946, 37501.24997500035, 37519.0, 14421.711565768626, 14526.564203073925, 14558.0, 14611.561653150422, 14620.634484137769, 12259.877401225873, 12288.754224915452, 12295.56965506203, 12298.077644176543, 12320.630381088582, 8616.310695144373, 8616.48301101936, 8618.956905215433, 8679.305655547541, 8685.869711954325, 3387.4918762185375, 3413.8975830725117, 3426.400379933502, 3428.5542879425516, 3430.365382404263, 1033.8993982149939, 1058.1746237934424, 1081.081081081075, 1150.4707834396104, 1152.2395219155317, 32376.028719138463, 32444.675553244637, 32899.835500822825, 33254.83372583122, 33303.3339333212, 1109.839073334362, 1187.3113594115393, 1209.6431552691977, 1228.2753175626424, 1252.9115729726268, 16968.236429360462, 17221.7416738749, 17401.390951316644, 17557.217673820407, 17644.76486645948, 523197.0, 526202.0, 527557.0, 529795.0, 531765.0, 58834.0, 59638.0, 59695.10457343143, 59706.40293597095, 59834.70082649646, 1300.362822217107, 1327.1439921250933, 1343.0263059282138, 1406.1633328169723, 1428.4786053090754, 30302.696973029986, 33086.338273233916, 33304.83347583246, 33818.66181338253, 34636.13409664779, 51680.48319516907, 52375.47624523706, 52565.0, 52790.0, 53065.46934530605, 436381.0, 440395.0, 440721.0, 442730.0, 443636.0, 37368.25263494769, 42779.0, 43850.34224486699, 44539.0, 44997.55002449934, 45445.77277113726, 47858.76070619625, 48012.66023732962, 48426.273605895236, 48817.755911220214, 40493.59506404898, 41292.38061429141, 42281.78859105685, 42285.788571056946, 42766.57233427626, 39877.0, 42092.78953605212, 43906.780466097465, 44735.77632111819, 45391.0, 39857.40213896736, 40361.192776143725, 43631.56368436275, 44007.339889901035, 44157.116857663306, 34861.65138348584, 36820.44769328516, 37119.44320835135, 37223.0, 37514.249715006095, 28637.0, 28926.0, 29317.26706832261, 29324.387158706475, 29381.26546836346], "value": 19238.87289217333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.7692815095396, 407.458080752599, 407.5639066199168, 411.7694091308865, 417.278108871652, 12751.744965100692, 17826.821731782693, 17884.55288617785, 19303.517412064706, 19539.804601953994, 14612.342444589993, 16119.83880161198, 17937.64124717505, 18603.81396186041, 19101.331453399132, 5566.916496252559, 5753.5684823638185, 5754.856128596777, 5765.855853603673, 5801.216835727186, 5704.572157088214, 5717.228174196493, 5739.799107031255, 5750.281214848144, 5753.309602847664, 4075.144219713849, 5719.14212868069, 6018.307894592134, 6339.302676705559, 6351.26960399553, 6312.968435157841, 6380.553361264667, 6412.166418365629, 6474.935250647481, 6488.643124628144, 5347.946520534783, 5518.448155184489, 5542.86142846428, 5563.471470210324, 5577.2191893135, 21009.264675736427, 21165.470863228387, 21219.46951326214, 21989.23037693673, 22022.88988555047, 2305.124052859919, 2448.135050310624, 2499.350168956066, 2577.136659219164, 3032.9090127296217, 11981.820272695917, 13841.031127821057, 13950.162990220619, 14205.928970355082, 14360.281985900663, 1843.0416183584596, 1845.6493266279365, 1875.3717504635963, 1878.445858471754, 1981.9801801982085, 78406.0, 78593.21406785917, 78734.60632696857, 79049.60475197645, 82206.58896705537, 10253.58985640566, 10285.794284114276, 10305.948470257601, 10333.638322658671, 10404.0, 14155.787663185061, 14184.51062638408, 14185.929070354583, 14287.0, 14288.785668214985, 8112.107668156498, 8253.83492330162, 8268.173182681683, 8355.080941096474, 8374.581270936429, 8038.995125609299, 8071.23323284287, 8094.473859199134, 8163.346932245406, 8268.421210515206, 5720.399358067426, 6045.78839740607, 6514.511411644051, 6553.91860343038, 6674.699638516278, 1895.2703209264257, 1963.6170946665263, 1963.9410817675493, 1965.164804957887, 1975.0, 974.0648976982035, 1038.4859494550094, 1041.073444634276, 1088.3089238333714, 1100.8403781451805, 17739.556511087067, 18253.817461825478, 18634.161462733937, 18994.52513687169, 19132.904335478514, 1033.0031519583638, 1059.8516207730925, 1060.7719340341864, 1072.4423299884018, 1117.80997230471, 10197.031282028196, 10629.5216715248, 10634.73413164677, 10766.89233107659, 10809.945950270197, 456863.0, 459101.0, 459737.0, 463601.0, 478994.0, 78997.0, 80214.59892700499, 81564.0, 81674.0, 82495.0, 1056.3609016545033, 1073.2272763610188, 1073.4452004229884, 1097.4403054442291, 1099.9065079468176, 16096.275667594751, 16207.351705931631, 16530.504084877473, 16537.586560336087, 16616.169191540615, 35337.64662353344, 35430.645693542734, 35584.64415355813, 35708.46437303494, 36633.0, 46239.53760462487, 47094.76452617715, 48986.51013489819, 49474.50525494699, 50181.0, 7088.8303429933485, 7511.924880751341, 7780.961095194488, 7913.248241417056, 7921.722739704082, 10982.505787239434, 13407.597772066854, 13563.186208827501, 13584.86415135836, 13618.591442256351, 6215.192025036898, 9179.495127768037, 11488.138389620644, 11608.374827524322, 12278.754424911273, 10672.57309707603, 10885.945570272415, 10994.34033957933, 11420.48607812667, 11453.656390308304, 11782.99844513226, 12145.967592754361, 12205.572804951784, 12296.139270250997, 12314.815277770662, 7581.203973582695, 7677.961610191914, 7716.305532502101, 7748.263914928073, 7764.858525874454, 10522.684319470429, 11639.709007274885, 11877.109216808602, 11899.643010709693, 12008.099392545419], "value": 9109.16202416175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.291097173983, 1550.0931954806442, 1586.1593355521575, 1767.6742443167625, 1878.783939846917, 8339.166083391658, 8703.782405439859, 8727.301815854724, 9000.549972501381, 9020.097990200977, 8767.6054577544, 8921.866172007425, 8941.597628106734, 8988.056254093308, 9001.369904106716, 1954.6383918974964, 2256.334381357495, 2319.2578374920076, 2324.0471406723245, 2367.337145599235, 2335.8481698689616, 2339.4268404240984, 2341.379534423379, 2344.777246161612, 2348.4011577047913, 2210.425289424745, 2246.550689862026, 2255.357223191391, 2256.7404748453973, 2258.706368172135, 1938.621968716101, 2250.4036430345973, 2317.918872839451, 2329.2429960262984, 2343.121329501437, 2331.6269396896587, 2352.1649814315842, 2358.9410264743346, 2362.350353652742, 2382.1305223593436, 8585.01272353681, 8633.309335253165, 8651.134886511361, 8687.26158276541, 8692.695755648585, 5130.948690513084, 5337.946620533823, 5381.246625472437, 5402.054640437907, 5413.729313534308, 3491.5286436331025, 3548.1484443733575, 3581.6776490116013, 3744.850205991757, 3759.7368184227116, 1146.8910453506903, 1191.0947679763442, 1195.2708847602955, 1208.6857417071537, 2005.6991451282279, 11893.583724569598, 12417.068719845958, 12417.813732794015, 12422.06834487408, 12453.315067671274, 4581.5647513486165, 4794.706297119906, 4797.976010119997, 4842.6368022398465, 4852.660313778072, 10347.0, 10464.529096190538, 10487.423191724376, 10518.894811051945, 10519.368837869752, 4583.862484125481, 5376.731163441812, 5423.322084739408, 5435.7825686972865, 5451.209574611659, 4747.0, 4921.3356196912955, 4930.2851086592245, 4973.676711013773, 4983.875403114951, 4042.8584999525465, 4052.392141178788, 4057.634812866856, 4081.816318265626, 4104.363823607346, 1233.6114124050896, 1274.833527322508, 1276.9680757980939, 1284.4926254129566, 1297.1244410023196, 868.7220089571276, 999.5002498750624, 1004.7588578741196, 1005.5424781724298, 1020.5407566594913, 5549.2242482405245, 5715.541438174919, 5753.88492230153, 5798.391168927286, 5868.413158684183, 450.74532888917656, 455.1920341394052, 459.0703824754898, 459.09787268018505, 464.81639752297656, 3755.868544600926, 3881.4565960765517, 3895.0, 3895.3183192941124, 3975.980120099381, 10136.493175341204, 10331.276810623183, 10412.427316497513, 10516.631917882838, 10592.788144237073, 10244.692659220234, 10300.639477618248, 10396.376217426978, 10396.376217426978, 10412.739681507872, 7540.736074237376, 7606.771796846104, 7925.41491701662, 7959.0, 7982.401319901031, 5546.334439867081, 5598.468145526169, 5599.188117722989, 5717.313922329347, 5826.271716035496, 9535.951045384863, 9605.37565058269, 9732.367396119229, 9733.659321923982, 9776.608935642495, 9320.580573874056, 9690.224782017563, 9692.22462203008, 10023.949880250551, 10066.094051535105, 6862.4853136014, 7506.512076714996, 7582.848343033219, 7687.154413014452, 7876.09424916142, 8653.480791152551, 8677.132286771272, 8735.868961965449, 8789.604467799092, 8808.955955220183, 7579.583122928292, 7766.5728384939375, 7791.104023037196, 7860.646270917937, 8065.112837587978, 7708.152103268524, 7754.651040703069, 7781.338586220008, 7785.260400261966, 7991.920080799117, 7105.680244389118, 7127.607981561064, 7130.073090498202, 7169.749058782918, 7175.174854891754, 4994.600431965507, 5146.6911985281, 5269.78920843162, 5279.736013199402, 5355.357357117171, 5209.71346575942, 5220.1647736362, 5319.816991118785, 5404.351477822686, 5568.860778480571], "value": 4559.17680208282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.75090930892515, 328.23521195614217, 333.6996702967329, 338.1934087202022, 340.6389227418936, 4852.660313778037, 4957.0, 5016.799328026879, 5048.772805223769, 5096.898062038762, 4980.203167493201, 5023.5981121510285, 5060.41805192403, 5063.9493605063935, 5065.505675825631, 3997.6601988830985, 4013.3779264214095, 4027.154297597508, 4029.8388064477385, 4044.373122166069, 3754.530683664542, 3770.435269363211, 3933.409988501719, 3998.280309544281, 4001.599440195923, 3925.6456522499693, 3938.645521903028, 3940.330143875548, 3941.9014524636827, 3957.663598594123, 3888.747231429962, 3918.8824335269846, 3924.9803750981064, 3942.0, 3949.7630142191274, 3486.3724529584665, 3528.0, 3534.8409321580334, 3559.2703495783303, 3585.551806024247, 4708.340832283483, 4863.221884498464, 4867.9269810952865, 4901.485344038896, 4953.331300274489, 4454.910901781978, 4464.285714285698, 4466.297889776671, 4488.483824360208, 4488.618467430272, 4990.575801056914, 5205.802665386982, 5231.686098834082, 5238.68567885928, 5258.81594144207, 3771.8868433947027, 3785.6782173515285, 3796.8040067378965, 3798.2783271178387, 3806.029462487048, 5434.53267617741, 5460.699661518575, 5468.234447177399, 5515.448455154453, 5532.529734972532, 3663.5603727552866, 3850.133719912997, 3883.8446462141196, 3891.591382904754, 3903.1803321302277, 3914.4715463412645, 3931.1548017176447, 3953.683705303569, 3964.920701585952, 3965.306071437487, 4457.665675074318, 4481.126180394792, 4505.166544189336, 4506.707064040893, 4520.909581808345, 5203.791848326025, 5317.511096892877, 5356.785728570813, 5360.517553420211, 5378.892422151535, 1282.4613662261872, 1312.665270356053, 1338.4445455136204, 1355.6881917158912, 1356.4506374918174, 876.1413814461863, 879.9956000219958, 891.9331050171263, 894.9529051010334, 897.1611543207122, 4450.931776373647, 4454.21611492817, 4497.347884556721, 4509.526499717548, 4525.886852828706, 4668.649851261169, 4683.391159149289, 4706.388169537938, 4709.0, 4738.715677059387, 4414.073044660593, 4414.955850441519, 4422.84520041797, 4435.489918659331, 4437.2234858899565, 2382.9285121446383, 2486.6643003194336, 2512.7361627029263, 2523.823332366717, 2535.6069809179608, 4741.83403580873, 4772.993014400975, 4788.880277993008, 4805.567498925044, 4814.253790662453, 4674.223794957894, 4675.784296082975, 4742.928856067162, 4755.358026666425, 4755.622188905547, 4519.88700282489, 4734.91097047681, 4785.234362501983, 4786.994731106437, 4820.39745031871, 4638.9330453996445, 4643.651726120487, 4652.697574657636, 4682.384577320819, 4731.929021064756, 4602.7008244464005, 4663.207254766766, 4663.766811659336, 4678.269040455053, 4734.313524538991, 4740.720005598538, 5160.742850454574, 5570.805021824379, 5585.776568937197, 5616.550675945833, 3860.9961410034157, 3935.2326296371934, 3950.980245098871, 3962.2867883781196, 3970.7617542947514, 5226.764795584284, 5421.945780542144, 5453.772901097222, 5473.781048758005, 5480.616356854982, 4961.328616823596, 5259.317018554026, 5280.339957505312, 5301.151815709468, 5306.204069389468, 5265.420373887895, 5274.182501712241, 5283.762230699705, 5285.43656326689, 5292.179712144623, 5044.899102018013, 5176.249443830548, 5176.275321454924, 5179.47205574364, 5208.973955130352, 5246.632735708464, 5297.973510132425, 5332.5467335276935, 5338.386085600206, 5357.0, 5147.5881929446305, 5188.377394712658, 5201.193814958688, 5229.738513074255, 5263.815766448156], "value": 3891.133298818978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.2895223251307, 799.5522507395859, 829.7344849648111, 844.3329769482109, 871.3987348729377, 14347.497837575687, 14392.49626263081, 14515.201663908481, 14593.489227877, 14634.634134146652, 13810.1713897166, 13812.861871381283, 13819.239941803196, 13857.514986975459, 13937.790933136012, 676.2831398717375, 789.2778108031144, 797.952122872628, 811.6144831205189, 816.4040250617053, 797.5254723439573, 800.1998001998002, 803.5138741061631, 804.1074407407773, 806.6289506826837, 851.9701810436636, 852.5864955496579, 854.1415877043594, 856.4475913036088, 858.0175698824874, 703.4407645921505, 827.5655280977505, 841.3479553346144, 856.5117882806802, 857.0914830279924, 631.3686313686313, 633.7845132654874, 633.8668879535303, 634.0425956805211, 634.5621521150438, 13553.254570998592, 13556.389962451713, 13560.321983900765, 13583.796243056362, 13641.386137623731, 13166.21002739829, 13450.93274533631, 13503.12229705066, 13650.453981840714, 13689.931550342184, 11684.182107252496, 11937.104717146161, 11958.701032474171, 11976.036035143192, 12170.75658486834, 4272.0, 4313.9137217255475, 4327.935080973788, 4403.471583409979, 4408.669349798778, 50480.242796358085, 53192.0, 53638.195427068626, 53733.99999999961, 53864.46135538634, 9972.650957216463, 10071.24465665078, 10116.949415252877, 10165.898341016644, 10310.845337319946, 17848.286068557372, 17965.820341796414, 18067.638647227246, 18231.45305640833, 18248.726269105973, 7866.528008319519, 7872.567008814455, 7896.526208427398, 7979.9202007979175, 8101.716439924574, 4398.934015989763, 4744.098621261949, 4808.735519546459, 4878.292647566083, 4915.975420122948, 3330.167458135466, 3423.845926933294, 3428.9314213715584, 3444.9311013779584, 3447.6035255945385, 604.0576700347384, 618.6133666458463, 628.8930881750114, 631.2551189596229, 637.7130291368902, 627.9560430769893, 738.6823665823747, 742.3801126059693, 758.8216769059267, 780.9808200298552, 9115.98908431769, 9496.810063798823, 9643.517824108767, 9713.174380177623, 9729.756756081013, 710.2152121905324, 710.4848984486206, 719.9208087110413, 729.5513259345464, 743.5427212264526, 4294.312909934395, 4387.298032314814, 4441.622462090694, 4481.215787237221, 4514.074614703978, 58899.41100589025, 61179.38820611826, 61899.38100618936, 61992.380076198664, 62082.37917620856, 53060.469395305554, 53607.46392536024, 53647.46352536503, 54635.726821366436, 55370.44629553734, 50719.492805072216, 50905.490945090816, 51108.744456278226, 52024.73987630037, 52107.73946130321, 8518.574071296534, 8617.69838055665, 8622.698205562776, 8729.694460693845, 8790.560471976503, 30113.397732045676, 32038.199045023128, 32077.35845283128, 33395.66604333925, 33798.49302260419, 42195.78902105593, 42293.15413691648, 43126.35310470283, 43945.78027109972, 45121.0, 12275.386230688251, 12482.625521234377, 12541.372931353579, 12722.363881805688, 12967.935160324138, 11813.232139910879, 13116.799524681808, 13854.515091971733, 14370.784438233226, 14884.404623814926, 12780.488780448677, 12920.22478651284, 13219.339033048502, 13258.668533286746, 13580.52468163649, 13175.93412032972, 13190.188608203045, 13804.93097534506, 13898.58304250874, 14287.285635718381, 13195.472181113031, 13255.536056237985, 13484.86515134836, 13686.110402823784, 13776.793348099585, 10880.129589632652, 10924.0, 10956.0, 11278.605248816251, 11301.491432885376, 11020.614278500214, 11254.482422941825, 11439.885601144215, 11463.197576169921, 11621.593244236412], "value": 6776.279400107654, "unit": "score"}], "name": "dromaeo_css", "value": 6917.650487496651, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 113.0, 111.0, 112.0, 113.0, 112.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 161.0, 210.0, 134.0, 154.0, 156.0, 132.0, 183.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 164.0, 163.0, 162.0, 163.0, 162.0, 163.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 149.0, 78.0, 76.0, 78.0, 77.0, 132.0, 77.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 94.0, 93.0, 93.0, 123.0, 93.0, 94.0, 118.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 119.0, 119.0, 119.0, 118.0, 117.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 59.0, 58.0, 58.0, 111.0, 55.0, 55.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 81.0, 86.0, 85.0, 83.0, 83.0, 84.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 136.0, 137.0, 141.0, 131.0, 131.0, 132.0, 204.0, 132.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 169.0, 167.0, 170.0, 167.0, 169.0, 180.0, 170.0, 168.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 71.0, 67.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1574.4, "alertThreshold": 2.0}]} 02:32:08 INFO - Return code: 0 02:32:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:32:08 ERROR - # TBPL SUCCESS # 02:32:08 INFO - Running post-action listener: _resource_record_post_action 02:32:08 INFO - ##### 02:32:08 INFO - ##### Finished run-tests step (success) 02:32:08 INFO - ##### 02:32:08 INFO - Running post-run listener: _resource_record_post_run 02:32:09 INFO - Total resource usage - Wall time: 1191s; CPU: 26.0%; Read bytes: 0; Write bytes: 538963968; Read time: 0; Write time: 499684 02:32:09 INFO - install - Wall time: 17s; CPU: 27.0%; Read bytes: 0; Write bytes: 244215808; Read time: 0; Write time: 298168 02:32:09 INFO - run-tests - Wall time: 1175s; CPU: 26.0%; Read bytes: 0; Write bytes: 294150144; Read time: 0; Write time: 201516 02:32:09 INFO - Running post-run listener: _upload_blobber_files 02:32:09 INFO - Blob upload gear active. 02:32:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:32:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:32:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:10 INFO - (blobuploader) - INFO - Done attempting. 02:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:11 INFO - (blobuploader) - INFO - Done attempting. 02:32:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:32:11 INFO - Return code: 0 02:32:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:32:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:32:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab2dc4dea7f0bed8ba99c3bad4537857dd3da7739f1d91c987cfee18d7a79fc03339cf4655675eddc91bb8e1108f029d35fadfb081776dec025be6b3879001fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04463b81dcb904fc80d7565de52b48a2b85885b78bb3644e5f0d7c25e94b943da8c2eb31e0599b1faae2ee968d55c43845488847037662790e11b616258487f1"} 02:32:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:32:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:32:11 INFO - Contents: 02:32:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab2dc4dea7f0bed8ba99c3bad4537857dd3da7739f1d91c987cfee18d7a79fc03339cf4655675eddc91bb8e1108f029d35fadfb081776dec025be6b3879001fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04463b81dcb904fc80d7565de52b48a2b85885b78bb3644e5f0d7c25e94b943da8c2eb31e0599b1faae2ee968d55c43845488847037662790e11b616258487f1"} 02:32:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:32:11 INFO - Copying logs to upload dir... 02:32:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:32:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.192020 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-11 02:32:09.578562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:32:09.582016) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab2dc4dea7f0bed8ba99c3bad4537857dd3da7739f1d91c987cfee18d7a79fc03339cf4655675eddc91bb8e1108f029d35fadfb081776dec025be6b3879001fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04463b81dcb904fc80d7565de52b48a2b85885b78bb3644e5f0d7c25e94b943da8c2eb31e0599b1faae2ee968d55c43845488847037662790e11b616258487f1"} build_url:https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005402 build_url: 'https://queue.taskcluster.net/v1/task/Dbqsb0wGT5O-7_MXJv6txA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab2dc4dea7f0bed8ba99c3bad4537857dd3da7739f1d91c987cfee18d7a79fc03339cf4655675eddc91bb8e1108f029d35fadfb081776dec025be6b3879001fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04463b81dcb904fc80d7565de52b48a2b85885b78bb3644e5f0d7c25e94b943da8c2eb31e0599b1faae2ee968d55c43845488847037662790e11b616258487f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:32:09.596045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:32:09.596384) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462945748.325435-1004219213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002102 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:32:09.679434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:32:09.679763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:32:09.680061) ========= ========= Total master_lag: 0.14 =========