builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1465420136.86 results: success (0) buildid: 20160608113003 builduid: f603ab7aae8f4a92bb00709089d6c269 revision: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.857834) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.858344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.858643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.874220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.874639) ========= 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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 14:08:56-- 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% 46.7M=0s 2016-06-08 14:08:56 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.988088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:56.988429) ========= 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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.038987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.039359) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 --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 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 --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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 14:08:57,056 truncating revision to first 12 chars 2016-06-08 14:08:57,056 Setting DEBUG logging. 2016-06-08 14:08:57,056 attempt 1/10 2016-06-08 14:08:57,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ad4f6b5c34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 14:08:57,366 unpacking tar archive at: fx-team-62ad4f6b5c34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647741 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.702833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.703428) ========= script_repo_revision: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.704131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.704599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:57.717059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-08 14:08:57.717527) ========= /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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:57 INFO - MultiFileLogger online at 20160608 14:08:57 in /builds/slave/test 14:08:57 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 14:08:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:57 INFO - {'append_to_log': False, 14:08:57 INFO - 'base_work_dir': '/builds/slave/test', 14:08:57 INFO - 'blob_upload_branch': 'Fx-Team', 14:08:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:57 INFO - 'branch': 'Fx-Team', 14:08:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:57 INFO - 'config_files': ('talos/linux_config.py',), 14:08:57 INFO - 'default_actions': ('clobber', 14:08:57 INFO - 'read-buildbot-config', 14:08:57 INFO - 'download-and-extract', 14:08:57 INFO - 'populate-webroot', 14:08:57 INFO - 'create-virtualenv', 14:08:57 INFO - 'install', 14:08:57 INFO - 'run-tests'), 14:08:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:57 INFO - 'download_minidump_stackwalk': True, 14:08:57 INFO - 'download_symbols': 'ondemand', 14:08:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:57 INFO - 'installer_path': 'installer.exe', 14:08:57 INFO - 'log_level': 'info', 14:08:57 INFO - 'log_name': 'talos', 14:08:57 INFO - 'log_to_console': True, 14:08:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:57 INFO - 'opt_config_files': (), 14:08:57 INFO - 'pip_index': False, 14:08:57 INFO - 'sps_profile': False, 14:08:57 INFO - 'sps_profile_interval': 0, 14:08:57 INFO - 'suite': 'dromaeojs', 14:08:57 INFO - 'system_bits': '32', 14:08:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:57 INFO - 'title': 'talos-linux64-ix-031', 14:08:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:57 INFO - 'use_talos_json': True, 14:08:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:57 INFO - 'work_dir': 'build'} 14:08:57 INFO - ##### 14:08:57 INFO - ##### Running clobber step. 14:08:57 INFO - ##### 14:08:57 INFO - Running pre-action listener: _resource_record_pre_action 14:08:57 INFO - Running main action method: clobber 14:08:57 INFO - rmtree: /builds/slave/test/build 14:08:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:58 INFO - Running post-action listener: _resource_record_post_action 14:08:58 INFO - ##### 14:08:58 INFO - ##### Finished clobber step (success) 14:08:58 INFO - ##### 14:08:58 INFO - ##### 14:08:58 INFO - ##### Running read-buildbot-config step. 14:08:58 INFO - ##### 14:08:58 INFO - Running pre-action listener: _resource_record_pre_action 14:08:58 INFO - Running main action method: read_buildbot_config 14:08:58 INFO - Using buildbot properties: 14:08:58 INFO - { 14:08:58 INFO - "project": "", 14:08:58 INFO - "product": "firefox", 14:08:58 INFO - "script_repo_revision": "production", 14:08:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:08:58 INFO - "repository": "", 14:08:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:08:58 INFO - "buildid": "20160608113003", 14:08:58 INFO - "pgo_build": "True", 14:08:58 INFO - "basedir": "/builds/slave/test", 14:08:58 INFO - "buildnumber": 783, 14:08:58 INFO - "slavename": "talos-linux64-ix-031", 14:08:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:08:58 INFO - "platform": "ubuntu64_hw", 14:08:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:08:58 INFO - "branch": "fx-team", 14:08:58 INFO - "repo_path": "integration/fx-team", 14:08:58 INFO - "revision": "62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92", 14:08:58 INFO - "stage_platform": "linux64-pgo", 14:08:58 INFO - "builduid": "f603ab7aae8f4a92bb00709089d6c269", 14:08:58 INFO - "slavebuilddir": "test" 14:08:58 INFO - } 14:08:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:08:58 INFO - Running post-action listener: _resource_record_post_action 14:08:58 INFO - ##### 14:08:58 INFO - ##### Finished read-buildbot-config step (success) 14:08:58 INFO - ##### 14:08:58 INFO - ##### 14:08:58 INFO - ##### Running download-and-extract step. 14:08:58 INFO - ##### 14:08:58 INFO - Running pre-action listener: _resource_record_pre_action 14:08:58 INFO - Running main action method: download_and_extract 14:08:58 INFO - mkdir: /builds/slave/test/build/tests 14:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:58 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:09:05 INFO - Downloaded 1361 bytes. 14:09:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:09:05 INFO - Using the following test package requirements: 14:09:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:09:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:09:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'jsshell-linux-x86_64.zip'], 14:09:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:09:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:09:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:09:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:09:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:09:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:09: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')]} 14:09:05 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:09:09 INFO - Downloaded 24451000 bytes. 14:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:09:11 INFO - Return code: 0 14:09:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:09: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')]} 14:09:11 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:09:17 INFO - Downloaded 24451000 bytes. 14:09:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:09:19 INFO - Return code: 0 14:09:19 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')]} 14:09:19 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:09:19 INFO - Downloaded 10833369 bytes. 14:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:09:20 INFO - Return code: 0 14:09:20 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')]} 14:09:20 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:09:21 INFO - Downloaded 59327853 bytes. 14:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:21 INFO - mkdir: /builds/slave/test/properties 14:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:21 INFO - Contents: 14:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:22 INFO - Running post-action listener: _resource_record_post_action 14:09:22 INFO - Running post-action listener: set_extra_try_arguments 14:09:22 INFO - ##### 14:09:22 INFO - ##### Finished download-and-extract step (success) 14:09:22 INFO - ##### 14:09:22 INFO - ##### 14:09:22 INFO - ##### Running populate-webroot step. 14:09:22 INFO - ##### 14:09:22 INFO - Running pre-action listener: _resource_record_pre_action 14:09:22 INFO - Running main action method: populate_webroot 14:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:22 INFO - '--tppagecycles', 14:09:22 INFO - '7'], 14:09:22 INFO - 'tests': ['tsvgm']}}, 14:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['damp', 'tps']}, 14:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'tests': ['damp', 'tps']}, 14:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['dromaeo_dom']}, 14:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['a11yr', 14:09:22 INFO - 'ts_paint', 14:09:22 INFO - 'tpaint', 14:09:22 INFO - 'sessionrestore', 14:09:22 INFO - 'sessionrestore_no_auto_restore', 14:09:22 INFO - 'tabpaint']}, 14:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['tsvgx', 14:09:22 INFO - 'tsvgr_opacity', 14:09:22 INFO - 'tart', 14:09:22 INFO - 'tscrollx', 14:09:22 INFO - 'cart']}, 14:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:22 INFO - 'tsvgr_opacity', 14:09:22 INFO - 'tart', 14:09:22 INFO - 'tscrollx', 14:09:22 INFO - 'cart']}, 14:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'talos_options': ['--disable-e10s'], 14:09:22 INFO - 'tests': ['tp5o']}, 14:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'tests': ['tp5o']}, 14:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'talos_options': ['--disable-e10s', 14:09:22 INFO - '--xperf_path', 14:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:22 INFO - 'tests': ['tp5n']}, 14:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:22 INFO - 'talos_options': ['--xperf_path', 14:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:22 INFO - 'tests': ['tp5n']}}, 14:09:22 INFO - 'talos.zip': {'path': '', 14:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:22 INFO - Running post-action listener: _resource_record_post_action 14:09:22 INFO - ##### 14:09:22 INFO - ##### Finished populate-webroot step (success) 14:09:22 INFO - ##### 14:09:22 INFO - ##### 14:09:22 INFO - ##### Running create-virtualenv step. 14:09:22 INFO - ##### 14:09:22 INFO - Running pre-action listener: _resource_record_pre_action 14:09:22 INFO - Running main action method: create_virtualenv 14:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:22 INFO - Using real prefix '/usr' 14:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:24 INFO - Installing pip.................done. 14:09:24 INFO - Return code: 0 14:09:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:24 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')]} 14:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:24 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')]} 14:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:24 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:24 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 14:09:24 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 14:09:24 INFO - Using env: {'DISPLAY': ':0', 14:09:24 INFO - 'HOME': '/home/cltbld', 14:09:24 INFO - 'LANG': 'en_US.UTF-8', 14:09:24 INFO - 'LANGUAGE': 'en_US:en', 14:09:24 INFO - 'LOGNAME': 'cltbld', 14:09:24 INFO - 'MAIL': '/var/mail/cltbld', 14:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:24 INFO - 'MOZ_NO_REMOTE': '1', 14:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:24 INFO - 'NO_EM_RESTART': '1', 14:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:24 INFO - 'PWD': '/builds/slave/test', 14:09:24 INFO - 'SHELL': '/bin/bash', 14:09:24 INFO - 'SHLVL': '1', 14:09:24 INFO - 'TERM': 'linux', 14:09:24 INFO - 'TMOUT': '86400', 14:09:24 INFO - 'USER': 'cltbld', 14:09:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:24 INFO - '_': '/tools/buildbot/bin/python'} 14:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:09:25 INFO - Cleaning up... 14:09:25 INFO - Return code: 0 14:09:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09:25 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')]} 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:25 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')]} 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:25 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>=3.1.1'] in /builds/slave/test/build 14:09:25 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>=3.1.1 14:09:25 INFO - Using env: {'DISPLAY': ':0', 14:09:25 INFO - 'HOME': '/home/cltbld', 14:09:25 INFO - 'LANG': 'en_US.UTF-8', 14:09:25 INFO - 'LANGUAGE': 'en_US:en', 14:09:25 INFO - 'LOGNAME': 'cltbld', 14:09:25 INFO - 'MAIL': '/var/mail/cltbld', 14:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:25 INFO - 'MOZ_NO_REMOTE': '1', 14:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:25 INFO - 'NO_EM_RESTART': '1', 14:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:25 INFO - 'PWD': '/builds/slave/test', 14:09:25 INFO - 'SHELL': '/bin/bash', 14:09:25 INFO - 'SHLVL': '1', 14:09:25 INFO - 'TERM': 'linux', 14:09:25 INFO - 'TMOUT': '86400', 14:09:25 INFO - 'USER': 'cltbld', 14:09:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:25 INFO - '_': '/tools/buildbot/bin/python'} 14:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:25 INFO - Downloading/unpacking psutil>=3.1.1 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:27 INFO - Installing collected packages: psutil 14:09:27 INFO - Running setup.py install for psutil 14:09:27 INFO - building 'psutil._psutil_linux' extension 14:09:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:09:27 INFO - building 'psutil._psutil_posix' extension 14:09:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:27 INFO - Successfully installed psutil 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09:27 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')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:27 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.3'] in /builds/slave/test/build 14:09:27 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.3 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:28 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 14:09:28 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 14:09:28 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 14:09:28 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 14:09:28 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 14:09:28 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 14:09:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:29 INFO - Installing collected packages: mozsystemmonitor 14:09:29 INFO - Running setup.py install for mozsystemmonitor 14:09:30 INFO - Successfully installed mozsystemmonitor 14:09:30 INFO - Cleaning up... 14:09:30 INFO - Return code: 0 14:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:30 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')]} 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:30 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')]} 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:30 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==2.5.1'] in /builds/slave/test/build 14:09:30 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==2.5.1 14:09:30 INFO - Using env: {'DISPLAY': ':0', 14:09:30 INFO - 'HOME': '/home/cltbld', 14:09:30 INFO - 'LANG': 'en_US.UTF-8', 14:09:30 INFO - 'LANGUAGE': 'en_US:en', 14:09:30 INFO - 'LOGNAME': 'cltbld', 14:09:30 INFO - 'MAIL': '/var/mail/cltbld', 14:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:30 INFO - 'MOZ_NO_REMOTE': '1', 14:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:30 INFO - 'NO_EM_RESTART': '1', 14:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:30 INFO - 'PWD': '/builds/slave/test', 14:09:30 INFO - 'SHELL': '/bin/bash', 14:09:30 INFO - 'SHLVL': '1', 14:09:30 INFO - 'TERM': 'linux', 14:09:30 INFO - 'TMOUT': '86400', 14:09:30 INFO - 'USER': 'cltbld', 14:09:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:30 INFO - '_': '/tools/buildbot/bin/python'} 14:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:30 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 14:09:30 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 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:32 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 14:09:32 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 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:32 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:32 INFO - warning: no files found matching '*.txt' 14:09:32 INFO - no previously-included directories found matching 'build' 14:09:32 INFO - no previously-included directories found matching 'dist' 14:09:32 INFO - no previously-included directories found matching '.git*' 14:09:32 INFO - Installing collected packages: jsonschema, functools32 14:09:32 INFO - Running setup.py install for functools32 14:09:32 INFO - warning: no files found matching '*.txt' 14:09:32 INFO - no previously-included directories found matching 'build' 14:09:32 INFO - no previously-included directories found matching 'dist' 14:09:32 INFO - no previously-included directories found matching '.git*' 14:09:32 INFO - Successfully installed jsonschema functools32 14:09:32 INFO - Cleaning up... 14:09:32 INFO - Return code: 0 14:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:32 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')]} 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:32 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')]} 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:32 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:32 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 14:09:32 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 14:09:32 INFO - Using env: {'DISPLAY': ':0', 14:09:32 INFO - 'HOME': '/home/cltbld', 14:09:32 INFO - 'LANG': 'en_US.UTF-8', 14:09:32 INFO - 'LANGUAGE': 'en_US:en', 14:09:32 INFO - 'LOGNAME': 'cltbld', 14:09:32 INFO - 'MAIL': '/var/mail/cltbld', 14:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:32 INFO - 'MOZ_NO_REMOTE': '1', 14:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:32 INFO - 'NO_EM_RESTART': '1', 14:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:32 INFO - 'PWD': '/builds/slave/test', 14:09:32 INFO - 'SHELL': '/bin/bash', 14:09:32 INFO - 'SHLVL': '1', 14:09:32 INFO - 'TERM': 'linux', 14:09:32 INFO - 'TMOUT': '86400', 14:09:32 INFO - 'USER': 'cltbld', 14:09:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:32 INFO - '_': '/tools/buildbot/bin/python'} 14:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:32 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 14:09:32 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 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 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 14:09:35 INFO - Downloading docopt-0.6.1.tar.gz 14:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:35 INFO - Running setup.py install for blobuploader 14:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:35 INFO - Running setup.py install for requests 14:09:35 INFO - Running setup.py install for docopt 14:09:36 INFO - Successfully installed blobuploader requests docopt 14:09:36 INFO - Cleaning up... 14:09:36 INFO - Return code: 0 14:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:36 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')]} 14:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:36 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')]} 14:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:36 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:36 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 14:09:36 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 14:09:36 INFO - Using env: {'DISPLAY': ':0', 14:09:36 INFO - 'HOME': '/home/cltbld', 14:09:36 INFO - 'LANG': 'en_US.UTF-8', 14:09:36 INFO - 'LANGUAGE': 'en_US:en', 14:09:36 INFO - 'LOGNAME': 'cltbld', 14:09:36 INFO - 'MAIL': '/var/mail/cltbld', 14:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:36 INFO - 'MOZ_NO_REMOTE': '1', 14:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:36 INFO - 'NO_EM_RESTART': '1', 14:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:36 INFO - 'PWD': '/builds/slave/test', 14:09:36 INFO - 'SHELL': '/bin/bash', 14:09:36 INFO - 'SHLVL': '1', 14:09:36 INFO - 'TERM': 'linux', 14:09:36 INFO - 'TMOUT': '86400', 14:09:36 INFO - 'USER': 'cltbld', 14:09:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:36 INFO - '_': '/tools/buildbot/bin/python'} 14:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:36 INFO - Running setup.py (path:/tmp/pip-RLJSdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:36 INFO - Running setup.py (path:/tmp/pip-VhwcKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:36 INFO - Running setup.py (path:/tmp/pip-JKSwNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:36 INFO - Running setup.py (path:/tmp/pip-hJWH9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:36 INFO - Running setup.py (path:/tmp/pip-Kdt0Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:36 INFO - Running setup.py (path:/tmp/pip-qdKsyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:36 INFO - Running setup.py (path:/tmp/pip-R3NNaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:36 INFO - Running setup.py (path:/tmp/pip-kJqClz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:36 INFO - Running setup.py (path:/tmp/pip-aZMA55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:37 INFO - Running setup.py (path:/tmp/pip-Q9PRwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:37 INFO - Running setup.py (path:/tmp/pip-QbVEML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:37 INFO - Running setup.py (path:/tmp/pip-rfOJTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:37 INFO - Running setup.py (path:/tmp/pip-Mtn591-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:37 INFO - Running setup.py (path:/tmp/pip-13nsAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:37 INFO - Running setup.py (path:/tmp/pip-6GwvK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:37 INFO - Running setup.py (path:/tmp/pip-_E2zfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:37 INFO - Running setup.py (path:/tmp/pip-zCVrNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:37 INFO - Running setup.py install for manifestparser 14:09:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for mozcrash 14:09:37 INFO - Running setup.py install for mozdebug 14:09:37 INFO - Running setup.py install for mozdevice 14:09:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for mozfile 14:09:38 INFO - Running setup.py install for mozhttpd 14:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozinfo 14:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozInstall 14:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozleak 14:09:38 INFO - Running setup.py install for mozlog 14:09:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for moznetwork 14:09:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozprocess 14:09:38 INFO - Running setup.py install for mozprofile 14:09:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:38 INFO - Running setup.py install for mozrunner 14:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Running setup.py install for mozscreenshot 14:09:39 INFO - Running setup.py install for moztest 14:09:39 INFO - Running setup.py install for mozversion 14:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:39 INFO - Cleaning up... 14:09:39 INFO - Return code: 0 14:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:39 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:39 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 14:09:39 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 14:09:39 INFO - Using env: {'DISPLAY': ':0', 14:09:39 INFO - 'HOME': '/home/cltbld', 14:09:39 INFO - 'LANG': 'en_US.UTF-8', 14:09:39 INFO - 'LANGUAGE': 'en_US:en', 14:09:39 INFO - 'LOGNAME': 'cltbld', 14:09:39 INFO - 'MAIL': '/var/mail/cltbld', 14:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:39 INFO - 'MOZ_NO_REMOTE': '1', 14:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:39 INFO - 'NO_EM_RESTART': '1', 14:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:39 INFO - 'PWD': '/builds/slave/test', 14:09:39 INFO - 'SHELL': '/bin/bash', 14:09:39 INFO - 'SHLVL': '1', 14:09:39 INFO - 'TERM': 'linux', 14:09:39 INFO - 'TMOUT': '86400', 14:09:39 INFO - 'USER': 'cltbld', 14:09:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:39 INFO - '_': '/tools/buildbot/bin/python'} 14:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:39 INFO - Running setup.py (path:/tmp/pip-fZWHS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:39 INFO - Running setup.py (path:/tmp/pip-yfqTvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:39 INFO - Running setup.py (path:/tmp/pip-pBhYJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:39 INFO - Running setup.py (path:/tmp/pip-MSTWM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:39 INFO - Running setup.py (path:/tmp/pip-7PmPux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:39 INFO - Running setup.py (path:/tmp/pip-GIn4HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:40 INFO - Running setup.py (path:/tmp/pip-bhEPuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:40 INFO - Running setup.py (path:/tmp/pip-hAsU_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:40 INFO - Running setup.py (path:/tmp/pip-NIUi6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:40 INFO - Running setup.py (path:/tmp/pip-6CCrKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:40 INFO - Running setup.py (path:/tmp/pip-OQiN4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:40 INFO - Running setup.py (path:/tmp/pip-imWYcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:40 INFO - Running setup.py (path:/tmp/pip-Bm8eUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:40 INFO - Running setup.py (path:/tmp/pip-MBeBUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:40 INFO - Running setup.py (path:/tmp/pip-PNPUy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:40 INFO - Running setup.py (path:/tmp/pip-rHOglw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:40 INFO - Running setup.py (path:/tmp/pip-I6cpkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:42 INFO - Downloading blessings-1.6.tar.gz 14:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:42 INFO - Installing collected packages: blessings 14:09:42 INFO - Running setup.py install for blessings 14:09:42 INFO - Successfully installed blessings 14:09:42 INFO - Cleaning up... 14:09:42 INFO - Return code: 0 14:09:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:43 INFO - Reading from file tmpfile_stdout 14:09:43 INFO - Current package versions: 14:09:43 INFO - argparse == 1.2.1 14:09:43 INFO - blessings == 1.6 14:09:43 INFO - blobuploader == 1.2.4 14:09:43 INFO - docopt == 0.6.1 14:09:43 INFO - functools32 == 3.2.3-2 14:09:43 INFO - jsonschema == 2.5.1 14:09:43 INFO - manifestparser == 1.1 14:09:43 INFO - mozInstall == 1.12 14:09:43 INFO - mozcrash == 0.17 14:09:43 INFO - mozdebug == 0.1 14:09:43 INFO - mozdevice == 0.48 14:09:43 INFO - mozfile == 1.2 14:09:43 INFO - mozhttpd == 0.7 14:09:43 INFO - mozinfo == 0.9 14:09:43 INFO - mozleak == 0.1 14:09:43 INFO - mozlog == 3.2 14:09:43 INFO - moznetwork == 0.27 14:09:43 INFO - mozprocess == 0.22 14:09:43 INFO - mozprofile == 0.28 14:09:43 INFO - mozrunner == 6.11 14:09:43 INFO - mozscreenshot == 0.1 14:09:43 INFO - mozsystemmonitor == 0.3 14:09:43 INFO - moztest == 0.7 14:09:43 INFO - mozversion == 1.4 14:09:43 INFO - psutil == 3.1.1 14:09:43 INFO - requests == 1.2.3 14:09:43 INFO - wsgiref == 0.1.2 14:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:43 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'DISPLAY': ':0', 14:09:43 INFO - 'HOME': '/home/cltbld', 14:09:43 INFO - 'LANG': 'en_US.UTF-8', 14:09:43 INFO - 'LANGUAGE': 'en_US:en', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MAIL': '/var/mail/cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SHLVL': '1', 14:09:43 INFO - 'TERM': 'linux', 14:09:43 INFO - 'TMOUT': '86400', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - '_': '/tools/buildbot/bin/python'} 14:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 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)) 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:43 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'DISPLAY': ':0', 14:09:43 INFO - 'HOME': '/home/cltbld', 14:09:43 INFO - 'LANG': 'en_US.UTF-8', 14:09:43 INFO - 'LANGUAGE': 'en_US:en', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MAIL': '/var/mail/cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SHLVL': '1', 14:09:43 INFO - 'TERM': 'linux', 14:09:43 INFO - 'TMOUT': '86400', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - '_': '/tools/buildbot/bin/python'} 14:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:43 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 0x7fba3244cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, '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': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', '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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'DISPLAY': ':0', 14:09:43 INFO - 'HOME': '/home/cltbld', 14:09:43 INFO - 'LANG': 'en_US.UTF-8', 14:09:43 INFO - 'LANGUAGE': 'en_US:en', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MAIL': '/var/mail/cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SHLVL': '1', 14:09:43 INFO - 'TERM': 'linux', 14:09:43 INFO - 'TMOUT': '86400', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - '_': '/tools/buildbot/bin/python'} 14:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:43 INFO - Downloading/unpacking flake8 14:09:43 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 14:09:43 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 14:09:43 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 14:09:43 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 14:09:43 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 14:09:43 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 14:09:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:46 INFO - no previously-included directories found matching 'docs/_build' 14:09:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:46 INFO - Running setup.py install for pep8 14:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:46 INFO - no previously-included directories found matching 'docs/_build' 14:09:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:09:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:46 INFO - Cleaning up... 14:09:46 INFO - Return code: 0 14:09:46 INFO - Running post-action listener: _resource_record_post_action 14:09:46 INFO - Running post-action listener: _start_resource_monitoring 14:09:46 INFO - Starting resource monitoring. 14:09:46 INFO - ##### 14:09:46 INFO - ##### Finished create-virtualenv step (success) 14:09:46 INFO - ##### 14:09:46 INFO - ##### 14:09:46 INFO - ##### Running install step. 14:09:46 INFO - ##### 14:09:46 INFO - Running pre-action listener: _resource_record_pre_action 14:09:46 INFO - Running main action method: install 14:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:46 INFO - Reading from file tmpfile_stdout 14:09:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:47 INFO - Reading from file tmpfile_stdout 14:09:47 INFO - Output received: 14:09:47 INFO - Usage: mozinstall [options] installer 14:09:47 INFO - Options: 14:09:47 INFO - -h, --help show this help message and exit 14:09:47 INFO - -d DEST, --destination=DEST 14:09:47 INFO - Directory to install application into. [default: 14:09:47 INFO - "/builds/slave/test"] 14:09:47 INFO - --app=APP Application being installed. [default: firefox] 14:09:47 INFO - mkdir: /builds/slave/test/build/application 14:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:10:04 INFO - Reading from file tmpfile_stdout 14:10:04 INFO - Output received: 14:10:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:04 INFO - Running post-action listener: _resource_record_post_action 14:10:04 INFO - ##### 14:10:04 INFO - ##### Finished install step (success) 14:10:04 INFO - ##### 14:10:04 INFO - ##### 14:10:04 INFO - ##### Running run-tests step. 14:10:04 INFO - ##### 14:10:04 INFO - Running pre-action listener: _resource_record_pre_action 14:10:04 INFO - Running main action method: run_tests 14:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:04 INFO - Python 2.7.3 14:10:04 INFO - Return code: 0 14:10:04 INFO - grabbing minidump binary from tooltool 14:10:04 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')]} 14:10:04 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 0x29de1c0>, '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 0x29df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:04 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 14:10:04 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 14:10:04 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 14:10:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:04 INFO - Return code: 0 14:10:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:10:05 INFO - Return code: 0 14:10:05 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/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:10:05 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/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:05 INFO - 'PWD': '/builds/slave/test', 14:10:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:05 INFO - 'SHELL': '/bin/bash', 14:10:05 INFO - 'SHLVL': '1', 14:10:05 INFO - 'TERM': 'linux', 14:10:05 INFO - 'TMOUT': '86400', 14:10:05 INFO - 'USER': 'cltbld', 14:10:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428', 14:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:05 INFO - '_': '/tools/buildbot/bin/python'} 14:10:05 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/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:10:05 INFO - mozversion application_buildid: 20160608113003 14:10:05 INFO - mozversion application_changeset: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 14:10:05 INFO - mozversion application_display_name: Nightly 14:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:05 INFO - mozversion application_name: Firefox 14:10:05 INFO - mozversion application_remotingname: firefox 14:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:10:05 INFO - mozversion application_vendor: Mozilla 14:10:05 INFO - mozversion application_version: 50.0a1 14:10:05 INFO - mozversion platform_buildid: 20160608113003 14:10:05 INFO - mozversion platform_changeset: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 14:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:10:05 INFO - mozversion platform_version: 50.0a1 14:10:05 INFO - using testdate: 1465420205 14:10:05 INFO - actual date: 1465420205 14:10:05 INFO - starting webserver on 'localhost:35366' 14:10:05 INFO - SUITE-START | Running 2 tests 14:10:05 INFO - TEST-START | dromaeo_css 14:10:05 INFO - operating with platform_type : linux_ 14:10:05 INFO - Initialising browser for dromaeo_css test... 14:10:05 INFO - TEST-INFO | started process 20179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdQf4ic/profile http://localhost:35366/getInfo.html) 14:10:09 INFO - PROCESS | 20179 | __metrics Screen width/height:1600/1200 14:10:09 INFO - PROCESS | 20179 | colorDepth:24 14:10:09 INFO - PROCESS | 20179 | Browser inner width/height: 1024/697 14:10:09 INFO - PROCESS | 20179 | __metrics 14:10:10 ERROR - PROCESS | 20179 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:10:10 INFO - PROCESS | 20179 | console.error: PushService: 14:10:10 INFO - PROCESS | 20179 | stateChangeProcessEnqueue: Error transitioning state 14:10:10 INFO - PROCESS | 20179 | UnknownError 14:10:11 INFO - TEST-INFO | 20179: exit 0 14:10:11 INFO - Browser initialized. 14:10:11 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:11 INFO - TEST-INFO | started process 20260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdQf4ic/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:22 INFO - PROCESS | 20260 | RSS: Main: 156418048 14:10:22 INFO - PROCESS | 20260 | 14:11:13 INFO - PROCESS | 20260 | 1465420273711 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] 14:13:22 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35366/tests/dromaeo/cssquery-ext.html) 14:13:23 INFO - PROCESS | 20260 | RSS: Main: 259063808 14:13:23 INFO - PROCESS | 20260 | 14:16:25 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-ext.html (next: http://localhost:35366/tests/dromaeo/cssquery-jquery.html) 14:16:26 INFO - PROCESS | 20260 | RSS: Main: 250478592 14:16:26 INFO - PROCESS | 20260 | 14:19:28 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35366/tests/dromaeo/cssquery-mootools.html) 14:19:28 INFO - PROCESS | 20260 | RSS: Main: 240738304 14:19:28 INFO - PROCESS | 20260 | 14:22:30 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35366/tests/dromaeo/cssquery-prototype.html) 14:22:31 INFO - PROCESS | 20260 | RSS: Main: 239935488 14:22:31 INFO - PROCESS | 20260 | 14:25:34 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35366/tests/dromaeo/cssquery-yui.html) 14:25:34 INFO - PROCESS | 20260 | RSS: Main: 230051840 14:25:34 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | Cycle 1(1): loaded http://localhost:35366/tests/dromaeo/cssquery-yui.html (next: http://localhost:35366/tests/dromaeo/cssquery-dojo.html) 14:28:37 INFO - PROCESS | 20260 | RSS: Main: 300859392 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | __start_tp_report 14:28:37 INFO - PROCESS | 20260 | _x_x_mozilla_page_load 14:28:37 INFO - PROCESS | 20260 | _x_x_mozilla_page_load_details 14:28:37 INFO - PROCESS | 20260 | |i|pagename|runs| 14:28:37 INFO - PROCESS | 20260 | |0;dojo.html;3175.3173067790435;3186.0760379489943;3216.8069915805054;3235.854386552608;3259.6577359377266;5270.314859068325;5305.257263983036;5396.460353964601;5498.7800487980485;5533.861653458661;5372.194170874371;5379.784808607661;5418.729063546817;5455.645383050099;5488.69812160331;4815.205491093965;4908;4917.7541122943885;4927.3348098006845;5084.2373643953515;5013.298138260647;5051.79792808289;5066.316047333618;5079.212722028073;5122.078025955345;4824.083424149418;4841.49164337743;4844.854654360357;4929.334539837112;4961.702297862122;4907.484714105039;4918.3360246367;4928.8767780805765;4929.309896614477;4932.235503496964;4875.975620121877;4898.191798353268;4898.436679781835;4899.8775030624165;4905.705657660552;5249.501297376743;5250.343707036621;5297.258383826267;5329.493698098674;5331.600129990266;5851.356350801409;5889.9705501472645;5899.439553242435;5900.203472531196;5904.291485021782;5600.6079574429805;5684.2326285951285;5938.495227905633;5950.43470870271;5960.672163031031;5438.483344082306;5492.725363731797;5523.502884740353;5540.141278101901;5540.335159780852;6002.129691194839;6022.668753218528;6024.036154215304;6025.548083893638;6034.487068599218;5572.164175373727;5669.631473954262;5724.570657200727;5752.482276595127;5781.913271300934;5844.415558444121;5845;5854.151148083504;5906.586538942232;5910.202122713378;5806;5826.388229235869;5831.06702927538;5833.766649333979;5841.94158058414;5578.386377498472;5728.198052272685;5784.248047753765;5785.595008349375;5845.707714614252;4409.11817636474;4411.051623900877;4411.933820992687;4413.624841888475;4446.9777651111535;3911.3546264866545;3927.8821635350987;3933.350997085506;3973.2450834341385;3986.2226865761477;5397.136458166675;5412.458754124635;5442.374126975369;5499.340079190522;5501.642393244426;5837.153612726131;5838.7080645967535;5843.152742852262;5844.532437404998;5849.239598852122;5428.348598168245;5476.014317422822;5480.095784195563;5480.177973303957;5483.670979741229;4869.902601947942;4953.900921981613;4968.378952630921;4980.900381992412;4987.301777751118;5963.880722385528;5982.1325907744;5991.7902873399225;5996.490298324604;6001.339852616209;5720.771169153354;5834.474897259267;5845.590808643524;5848.53211743068;5848.941510584839;5878.970605146947;5959.344472108151;5973.133895585029;6005.579609427298;6025.186599809145;5751.281089863767;5766.682832444256;5781.335146458043;5787.160861674949;5795.710214489343;5744.253247077853;5791.449812267828;5886.470217680429;5888.528917686661;5900;5722.685252311163;5769.74036168365;5771.509421699203;5771.971140144273;5827.6794776286015;5660.688662123458;5711.628744131618;5722.74247658848;5728.369879313355;5743.4543718346695;5400.108982017923;5442.782288708408;5489.698066606375;5545.805896793593;5591.860203494945;5746.138079287973;5746.626469279484;5748.166515855094;5751.827445176651;5760.0783874579865;5511.4213007633625;5544.556435485232;5555.055640541037;5556.055470570093;5588.608797384144 14:28:37 INFO - PROCESS | 20260 | |1;ext.html;586.4165155670108;619.0806652121599;622.7228883146996;637.448606954984;644.3717375558828;31856.36287274253;34133.14667133323;34305.828470857676;34376.31247375054;44487.110257794906;43096.78451607745;43428.78285608567;43536.56463435365;43575;43578;8629.093945135748;8831.161039701217;8834.204921557059;8843.557822108902;8844.11558844117;8617.482951022926;8754.474731516098;8757.868631970525;8759.605817738217;8759.737207883774;8759.824803503927;8778.473291602493;8791.912080879174;8793.560321983876;8804.03155652881;8737.650493980233;8764.737057888273;8769.210771030606;8786.780330491756;8794.912050879473;8674.522901240429;8688.478691278544;8727.781805454852;8730.738077857675;8754.518501482416;37658;37773;37826.81086594577;37830.24339513222;37992;3546.3261980223933;3698.9815050924844;3699.9445008324897;3726.6087060858763;4108.50697916249;30693.693063069306;31087.533686994713;31282.21794455157;31349.37301253962;32280.192995175075;4249.298865687158;4334.13317336534;4357.193919124972;4471.150481408522;4473.977630111861;311699;312524.81113538746;312943;313251;313815;57050.714746426005;57240;57406.42593574095;57628.27115186551;57655.13517297244;61646.38353616496;61745.69127154336;61818;61824.38175618276;61843.690781546706;16935.830641693425;17163.056031918113;17234.396796112076;17237.39669111575;17249.655006900044;13013.739725205633;13156.144850584682;13157.276349800853;13166;13175.14361566495;17467.67939461651;19255.13351899168;19314.32399865998;19324.8067519323;19513.121909513822;6946.444284457231;7036.542624729376;7105.360517553445;7236.167840698282;7314.743983960536;844.9746507604782;939.6422169964472;1045.2369770067894;1100.4442756408123;1126.1778901402022;30626.38747225043;30800.38399232003;30847.537286940715;31302;31330.373392532023;1099.5052226497949;1099.59864649404;1162.604714397109;1210.2254557083297;1225.0077437275836;16328.428505002268;16569.6686066278;16659.666806663798;16784.916075419787;16893.577660558585;508486;513590;514126;515125;516257;53078.20382694263;54424.72787636037;54455.18317225245;54793.45206547963;54808.17787733187;1260.2060701757835;1340.75866344059;1377.5040985245303;1387.8265216847894;1389.9027068105338;30193.69806301909;31508.527372089895;31543.52684709777;31610.683893160774;32213.51679724853;48034.75982620064;48310.5168948306;48644.270335945694;48682.513174867796;48725;383413;387471;387523;388137;642059;26879.193624191306;27335.726642734113;27636.789056875805;28555;28571.42857142887;44487.77756111199;45885.31172032355;46637;46933.2960005607;46943.76528117474;38136.32955826266;38777.897768177914;39710;39754.40368394418;40285.39571906482;38004.429933551575;38548.42177367398;39478.40782388209;39982.400263995485;40105.79947100246;38976.2204755909;39715.602843972345;40011.199776003734;40079.59920400759;40141.387275145375;34003;34739.826300868335;34833;35438;35903.820480897426;26653.20040398791;26948;27004.86497567578;27209.741759395056;27706.307342316602 14:28:37 INFO - PROCESS | 20260 | |2;jquery.html;376.4522619588498;390.50991006287086;393.8641168796765;394.791488530037;412.1283485428318;17869;19119.808801911975;19418.805811941875;19426.708599371002;19448.611027779436;17358.56603584908;17887.195076221567;18175.54561135969;19035.333763318253;19037.428877133672;5474.452554744524;5522.585806064541;5677.716114194294;5702.515286200678;5863.1791549182935;5786.942130578704;5809.477147056764;5825.15535247391;5855.765769369242;5859.443352881491;5782.624129431594;5831.096180092092;5861.882762344771;5863.208466856983;5865.208196893429;5641.266635337401;5713.200151978747;5745.253117094751;5750.65496070233;5805.303363596375;5381.973090134525;5694.629849059798;5695.202671625976;5699.145128230799;5699.373068962411;13201.14192577489;13532.120412173275;14215.488517339805;22076;22356.88821555898;2287.1880482428833;2304.366299267698;2342.7891489766002;2421.982767237747;2606.713261541229;9549.665761698307;9959.65141220061;9992.45041522716;10117.494125293779;10350.689479315633;1900.268396667293;1955.8909454628345;1965.852561057912;2004.2183548416128;2014.2748610500207;67242.9913551302;74018.62990685066;75035.24964750337;75521.24478755252;76368.61815690942;10627.36235825853;10729.302595331279;10937.671869843918;11079.279846809932;11085.22403431752;15317.846821531642;15339.386424542894;15444.227788610524;15445.30496127677;15483.845161548466;7910.248526389983;8036.075851277061;8090.635921383434;8196.713115040944;8231.876521852177;7695;7703.114141873644;7737.193013740784;7797.805054873674;7813.374930005586;4648;4730.455997560324;4752.809887604526;4767.713937163712;4777.044591081728;1882.905854707259;1930.5656227348734;1958.177565422526;1963.6759934610916;1967.2819420911264;945.5886689290181;1032.7624646331385;1049.9947500262604;1106.1316866259947;1109.4619109731773;17977.280908763765;18134.183961721756;18939.810601893805;19066.2373505061;19218.13518391676;970.3304719743354;1019.4393083803878;1032.2877214721818;1041.1514615588271;1049.4123290957089;9991.150752186;10409.739756505996;10599.152067834555;10619.30974486656;10645.946770266099;467268;477641;483852;484820;485160;88797;89663.10336896547;90293;90606.54696726475;91742.54128729313;981.082687687015;989.3816364772017;1005.8943810899897;1008.0625018732502;1011.858339832424;16265.349386024427;16340.836591634406;16538.917305413397;16539.338426462808;16630.916845415697;38271.42592861054;38322.233555329294;39569.60430395659;40500.39249411202;41490.58509414867;57250.42749572451;57861.13208301963;59333.40666593279;59494;59999.10001349896;7728.4590078693955;8103.8379232413845;8150.062742784656;8182.713605023796;8294;8710.738677839676;11155.21913466082;11885.46515406826;11954.402279885797;12376.257424554195;10875.782484350111;10919.617813376493;11062;11176.161787866105;11381.772364552828;5509.201165831012;9833.655822046194;9880.407175569202;10823.188260880623;10848.077913377452;11010.669679909295;11033.393163375771;11196.384198868815;11208.49561769706;11386.373749443861;8230.794230144294;8407.579621019047;8524.360672949677;8746.344024198082;8789.692360767342;11013.559457621606;11052.834207487054;11095.334279943228;11108;11305.152113591677 14:28:37 INFO - PROCESS | 20260 | |3;mootools.html;1300.4343110746831;1457.854214578542;1476.5053707008149;1628.9104099274543;1772.8227177282274;8439.70461033864;8801.867971980417;8807.427517211378;8966.282697384193;8976.685815996441;8677.435966662162;8856.601452934618;8862.734117976472;8883.244924181452;8888.28893688505;2016.213676666094;2241.9103235870625;2304.9884750576225;2339.2397470822007;2367.95264094718;2365.7042869641296;2368.4789346343778;2370.063824789207;2376.66726658268;2377.7622237776172;2328.266596022256;2331.4754180309465;2363.420961864337;2365.432296248905;2367.95264094718;1989.273915021014;2202.647576387786;2234.5866014787316;2266.852654577447;2282.4978504729097;2293.289080385086;2306.411864974438;2326.581215381231;2328.9650655240184;2331.848429852071;8781.692640757607;8915.153060459246;8922.68770593026;8924.241439477652;8927.464352138828;5150.381954165487;5289.603279753996;5298.046351656739;5300.814471493518;5301.3373328333955;3185.601799775028;3272.443684573628;3315.088350703552;3327.600687917441;3356.882509112194;1143.4625725908809;1153.74040840811;1195.3545085653736;1217.2939694976892;1245.7882160032816;12334.19827711205;12369.257844529267;12370.19593726414;12377.566785162566;12398.690032749253;4563.589276965089;4579.107074120515;4648.907021859543;4648.930266046012;4737.242041273448;10593.788124237471;10599.205059620404;10608.469576521144;10628.521716522775;10629.5216715248;5081.415637201695;5109.4379618241965;5110.2590124431745;5114.64197506171;5358.517733404013;4267.359896015622;4722.929156062662;4858.65989380747;4865.513448655177;4945.653804233669;4042.346513611734;4055.5538890721996;4100.7334523255895;4121.196366708523;4150.667946564267;1281.7628738683372;1294.8510921244178;1308.941097650608;1327.183781974079;1342.02703040295;986.1223511075149;1000.3997601439079;1009.3187098708343;1013.3210748798323;1024.155072065549;5834.591578589543;6019.428154325332;6021.126936594169;6221.3778622138325;6259.530535209878;908.9183871193259;961.2598299309632;985.2659768472533;1010.6412223660642;1026.1175389165312;4046.615571520701;4187.874363769091;4210.157968406331;4252.55348188442;4264.402983582301;10729.89270107289;11106.722331941766;11191;11238.044766194966;11239.494222759831;11025.17311201647;11042.944785276022;11060.944695276472;11074.612388566522;11139.888601114048;8103.513789172668;8113.553754543556;8228.753137405887;8252.587370631445;8256.752297431087;6013.398660134127;6190.226221722285;6237.157983672146;6266.060090986389;6355.205599300088;10071;10272.691819245434;10416.531256093342;10521.894781052091;10559;10427.478626068818;10444;10631.255812093079;10757.300775449883;10759.193060520649;6839.213490448662;7281.781546553612;7374.926250737639;7465.440091993014;7507.962460187664;8813.118688131135;8816.735497935073;8862.911370886208;8865.734027978913;8903.910960890309;7757.26306000929;7994.280514753467;8045.718399856211;8089.635966381645;8092.757217283491;7469.887951680837;7569.924300757142;7675.270849269311;7756.806079848049;7937.761867143995;7076.0801095857205;7204.3155900189395;7303.817404564716;7305.634718263959;7316.743913962986;5145.3568303962;5241.895162096813;5282.683039017671;5374.48942350476;5382.165764306539;5280.973595132;5351.652142610717;5406.297181366397;5631.324241091095;5660.207570940154 14:28:37 INFO - PROCESS | 20260 | |4;prototype.html;326.15037826462066;332.1894577231555;333.8013881740364;338.66472192529403;339.2722610001546;5295.629305948585;5345.278387417693;5350.598705097119;5384.730763461831;5399.838004859851;5322;5333.253344531759;5361.303030606015;5374.193870919364;5382.354117505895;3865.4781604483455;3914.727713493112;3996.840126394948;4129.9174016519655;4136.420901073837;4169.874903752892;4184.644305234059;4188.6649068074485;4192.24539582875;4194.790260486979;4120.361343991686;4151.273527132755;4155.750654960697;4171.874843754677;4180.017695841475;4012.578679238667;4055.3308704063793;4156;4171.6036976487185;4195.713336231745;3647.963520364789;3655.3785856404475;3664.6623982246556;3685.281370132825;3701.130234394942;5063.493650634944;5112;5125.871853203663;5128.897422051538;5170.172772356443;4443.42235509385;4685.672002959795;4737.526247375269;4755.833545825914;4821.54195351441;5413.133898576249;5427.891442171134;5440.91838622421;5444.7822087116465;5474.671519708791;3963.2271707017144;4020.2361551305453;4039.394090886361;4041.2927737646087;4059.269331520325;5495.862603434946;5651.689157096358;5691.402402747734;5722.54219662426;5722.685252311121;3979.224051309967;4000.219957108336;4004.7797371144284;4009.4386785850006;4014.5146295870713;4009.358502639622;4043.2924238258774;4044.4944381952255;4050.817713202854;4051.9797401013398;4582.495925448198;4673.883152921137;4678.695884767547;4689.155951928686;4694.131585656664;5491.203775452537;5508.173773933942;5539.612227144142;5543.584231182596;5550.611457198038;1423.8291405031255;1449.724552335053;1451.883849292054;1458.9854101459061;1459.0151647637801;923.9676611318572;949.1362859797689;953.2564599612314;957.1098878043487;960.078324808178;4767.6424268179335;4863.562279394871;4875.854174269044;4914.829934692104;4928.250471082786;5044.663164261474;5060.342155519759;5070.518300761421;5080.983803239367;5172.405173405032;4513.42396669176;4776.4923415207295;4833;4915.606751459874;4931.5315045070665;2675.304420850593;2698.9190324290303;2708.6478757761365;2732.811227116211;2736.713744540063;5137.972405518911;5158.595327084182;5174.534291913746;5220.321358223407;5227.947720522822;4818.975905120522;5068.493150684902;5199.752059505767;5224.477552244821;5569.331680198321;5656;5849.444302791228;5851.561132915049;5854.795082172103;5881.411858814085;5683.77264909399;5683.886322273449;5696.629719068247;5698;5708.885822283448;5502.899420115913;5662.631928924607;5668.914966275427;5681.602287839812;5683.8863222736145;5808.215890854681;5845.41545845412;5850.6782126981725;5889.0283103287475;5892.499137573182;4172.269852775813;4174.666026717795;4176.60322269384;4180.937285940652;4182.519010313731;5461.317335333083;5665.546756259407;5671.206031155724;5691.601587888808;5752.252207213036;5513.614047016831;5514.443184146284;5555.333359996826;5578.804741834017;5595.664260144405;5385.488378604026;5535.394735526652;5541.612087153861;5561.691897862342;5591.944080559305;5434.184872269191;5437.184422336682;5446.809361672323;5461.235427040297;5466.234727138283;5550.8057217997175;5603.38362780102;5619.775208991595;5626.24045753818;5646.435356464321;5201.869953251047;5467.617266791286;5469.480399362054;5484.643498172606;5524.14375771756 14:28:37 INFO - PROCESS | 20260 | |5;yui.html;743.8252010777468;747.0922828763051;753.4349238071446;761.649641165064;781.3905153979898;14461.132332060084;14826.703465930676;14853.702925941489;15119.924400377982;15422.614434639125;14599.197044162567;14710.705785884276;14713.411463541472;14742.115473071623;14746.188959607218;647.7150053976259;768.4006474949548;782.1240210963729;789.7828097273239;801.0747586537558;786.9921300787005;795.2008231727107;797.3541431440523;797.401948538596;797.7088362747613;839.5760141128721;839.5844057191699;840.8444437779;840.9789755256106;841.1042240014395;683.1017212365723;813.7965508622874;831.600831600835;833.6540335760652;836.0970152235572;621.552482212806;622.1911515030488;622.3185611755121;622.3869488553771;622.4242575617536;14207.36066876993;14256;14267.072640278453;14278.714425711532;14279.357428915724;13973.580792576136;14117.858821411757;14169.362378692984;14246.826670921046;14343.067700599428;12723.911646146056;12930.224186548838;12995.350232488337;13136.540221092217;13189;4486.820527178941;4510.819567217307;4533.546645335473;4572.51988541205;4682.251047932389;72247.63876180637;72406.63796681036;72476.6376168121;72668;72675.63662181709;11029.117670586334;11077.556897724162;11300.434978251054;11578.826317605242;11584.320273560455;21194.576108477744;21239.150433982777;21275.680864787042;21280.574388512454;21319;7894.162033359832;7995.760127196193;8094.757157285291;8132.1867813218205;8199.139090395542;4441.20058389493;4535.206338890681;4537.228671125917;4559.52125026874;4569.611583015481;3323.4682450807754;3386.6444023377685;3404.540387047766;3405.1316914186723;3410.812405317731;510.54561440318145;612.185792895448;621.8880601491685;632.4181752787447;634.4195061518751;572.7279542217414;662.6918482905472;673.6059405247985;705.6894966214849;782.6008735544913;9347.158755711882;9526.237900968044;9538.713838584854;9592.712218633453;9615.855762163574;727.1238158019573;727.5125665803924;733.2777214443769;734.8824188129873;754.9396048316122;4302.913941721148;4520.412346394947;4595.149897269016;4701.200795864711;4820.8794780130775;119047.2142917857;124486;125340;125597;129820;108242;108504;108546;108711;108873;93870.53064734633;95021;95215.047849522;95974;97888.51055744819;8729.214370706666;8810.955945220489;8880.467171969702;9007.279417646703;9037.548122593975;52602.73698631483;53476.73261633667;53567.73216133894;53758.73120634372;55211;47249.52750472589;52313.47686523086;54351.72824135854;54609.81560737685;82656;12150.513979440724;12517.186382885084;12645.367731613567;12947.676308092374;13259.66850828737;14123.858761412665;14400.351984160528;14453.566393008226;14701.485448009269;14742.410303587736;14097;14357;14477.638059048608;14492.782608261095;14562.41750329975;13439.857612102689;13510.93244533771;13625.498007968128;13799.448022079005;13815.309234538434;12563.560275390317;12665.620031399072;12782.169159004636;12867.549635762703;13249.271290079138;10282.434466104436;10654.73363165927;10752.623658171926;11203.60787372438;11240.213185076966;11196.552137914392;11853.34806585646;11972.461239244081;12033.819492707442;12103.152779305365 14:28:37 INFO - PROCESS | 20260 | __end_tp_report 14:28:37 INFO - PROCESS | 20260 | __start_cc_report 14:28:37 INFO - PROCESS | 20260 | _x_x_mozilla_cycle_collect,887 14:28:37 INFO - PROCESS | 20260 | __end_cc_report 14:28:37 INFO - PROCESS | 20260 | __startTimestamp1465421317920__endTimestamp 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | ------- Summary: start ------- 14:28:37 INFO - PROCESS | 20260 | Number of tests: 6 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#0] dojo.html Cycles:165 Average:5399.13 Median:5556.06 stddev:616.02 (11.1%) stddev-sans-first:592.69 14:28:37 INFO - PROCESS | 20260 | Values: 3175.3 3186.1 3216.8 3235.9 3259.7 5270.3 5305.3 5396.5 5498.8 5533.9 5372.2 5379.8 5418.7 5455.6 5488.7 4815.2 4908.0 4917.8 4927.3 5084.2 5013.3 5051.8 5066.3 5079.2 5122.1 4824.1 4841.5 4844.9 4929.3 4961.7 4907.5 4918.3 4928.9 4929.3 4932.2 4876.0 4898.2 4898.4 4899.9 4905.7 5249.5 5250.3 5297.3 5329.5 5331.6 5851.4 5890.0 5899.4 5900.2 5904.3 5600.6 5684.2 5938.5 5950.4 5960.7 5438.5 5492.7 5523.5 5540.1 5540.3 6002.1 6022.7 6024.0 6025.5 6034.5 5572.2 5669.6 5724.6 5752.5 5781.9 5844.4 5845.0 5854.2 5906.6 5910.2 5806.0 5826.4 5831.1 5833.8 5841.9 5578.4 5728.2 5784.2 5785.6 5845.7 4409.1 4411.1 4411.9 4413.6 4447.0 3911.4 3927.9 3933.4 3973.2 3986.2 5397.1 5412.5 5442.4 5499.3 5501.6 5837.2 5838.7 5843.2 5844.5 5849.2 5428.3 5476.0 5480.1 5480.2 5483.7 4869.9 4953.9 4968.4 4980.9 4987.3 5963.9 5982.1 5991.8 5996.5 6001.3 5720.8 5834.5 5845.6 5848.5 5848.9 5879.0 5959.3 5973.1 6005.6 6025.2 5751.3 5766.7 5781.3 5787.2 5795.7 5744.3 5791.4 5886.5 5888.5 5900.0 5722.7 5769.7 5771.5 5772.0 5827.7 5660.7 5711.6 5722.7 5728.4 5743.5 5400.1 5442.8 5489.7 5545.8 5591.9 5746.1 5746.6 5748.2 5751.8 5760.1 5511.4 5544.6 5555.1 5556.1 5588.6 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#1] ext.html Cycles:180 Average:57788.80 Median:39594.20 stddev:115123.36 (290.8%) stddev-sans-first:115366.20 14:28:37 INFO - PROCESS | 20260 | Values: 586.4 619.1 622.7 637.4 644.4 31856.4 34133.1 34305.8 34376.3 44487.1 43096.8 43428.8 43536.6 43575.0 43578.0 8629.1 8831.2 8834.2 8843.6 8844.1 8617.5 8754.5 8757.9 8759.6 8759.7 8759.8 8778.5 8791.9 8793.6 8804.0 8737.7 8764.7 8769.2 8786.8 8794.9 8674.5 8688.5 8727.8 8730.7 8754.5 37658.0 37773.0 37826.8 37830.2 37992.0 3546.3 3699.0 3699.9 3726.6 4108.5 30693.7 31087.5 31282.2 31349.4 32280.2 4249.3 4334.1 4357.2 4471.2 4474.0 311699.0 312524.8 312943.0 313251.0 313815.0 57050.7 57240.0 57406.4 57628.3 57655.1 61646.4 61745.7 61818.0 61824.4 61843.7 16935.8 17163.1 17234.4 17237.4 17249.7 13013.7 13156.1 13157.3 13166.0 13175.1 17467.7 19255.1 19314.3 19324.8 19513.1 6946.4 7036.5 7105.4 7236.2 7314.7 845.0 939.6 1045.2 1100.4 1126.2 30626.4 30800.4 30847.5 31302.0 31330.4 1099.5 1099.6 1162.6 1210.2 1225.0 16328.4 16569.7 16659.7 16784.9 16893.6 508486.0 513590.0 514126.0 515125.0 516257.0 53078.2 54424.7 54455.2 54793.5 54808.2 1260.2 1340.8 1377.5 1387.8 1389.9 30193.7 31508.5 31543.5 31610.7 32213.5 48034.8 48310.5 48644.3 48682.5 48725.0 383413.0 387471.0 387523.0 388137.0 642059.0 26879.2 27335.7 27636.8 28555.0 28571.4 44487.8 45885.3 46637.0 46933.3 46943.8 38136.3 38777.9 39710.0 39754.4 40285.4 38004.4 38548.4 39478.4 39982.4 40105.8 38976.2 39715.6 40011.2 40079.6 40141.4 34003.0 34739.8 34833.0 35438.0 35903.8 26653.2 26948.0 27004.9 27209.7 27706.3 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#2] jquery.html Cycles:180 Average:27998.55 Median:19356.37 stddev:79072.56 (408.5%) stddev-sans-first:79267.17 14:28:37 INFO - PROCESS | 20260 | Values: 376.5 390.5 393.9 394.8 412.1 17869.0 19119.8 19418.8 19426.7 19448.6 17358.6 17887.2 18175.5 19035.3 19037.4 5474.5 5522.6 5677.7 5702.5 5863.2 5786.9 5809.5 5825.2 5855.8 5859.4 5782.6 5831.1 5861.9 5863.2 5865.2 5641.3 5713.2 5745.3 5750.7 5805.3 5382.0 5694.6 5695.2 5699.1 5699.4 13201.1 13532.1 14215.5 22076.0 22356.9 2287.2 2304.4 2342.8 2422.0 2606.7 9549.7 9959.7 9992.5 10117.5 10350.7 1900.3 1955.9 1965.9 2004.2 2014.3 67243.0 74018.6 75035.2 75521.2 76368.6 10627.4 10729.3 10937.7 11079.3 11085.2 15317.8 15339.4 15444.2 15445.3 15483.8 7910.2 8036.1 8090.6 8196.7 8231.9 7695.0 7703.1 7737.2 7797.8 7813.4 4648.0 4730.5 4752.8 4767.7 4777.0 1882.9 1930.6 1958.2 1963.7 1967.3 945.6 1032.8 1050.0 1106.1 1109.5 17977.3 18134.2 18939.8 19066.2 19218.1 970.3 1019.4 1032.3 1041.2 1049.4 9991.2 10409.7 10599.2 10619.3 10645.9 467268.0 477641.0 483852.0 484820.0 485160.0 88797.0 89663.1 90293.0 90606.5 91742.5 981.1 989.4 1005.9 1008.1 1011.9 16265.3 16340.8 16538.9 16539.3 16630.9 38271.4 38322.2 39569.6 40500.4 41490.6 57250.4 57861.1 59333.4 59494.0 59999.1 7728.5 8103.8 8150.1 8182.7 8294.0 8710.7 11155.2 11885.5 11954.4 12376.3 10875.8 10919.6 11062.0 11176.2 11381.8 5509.2 9833.7 9880.4 10823.2 10848.1 11010.7 11033.4 11196.4 11208.5 11386.4 8230.8 8407.6 8524.4 8746.3 8789.7 11013.6 11052.8 11095.3 11108.0 11305.2 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#3] mootools.html Cycles:180 Average:5883.73 Median:4265.88 stddev:3361.93 (78.8%) stddev-sans-first:3353.71 14:28:37 INFO - PROCESS | 20260 | Values: 1300.4 1457.9 1476.5 1628.9 1772.8 8439.7 8801.9 8807.4 8966.3 8976.7 8677.4 8856.6 8862.7 8883.2 8888.3 2016.2 2241.9 2305.0 2339.2 2368.0 2365.7 2368.5 2370.1 2376.7 2377.8 2328.3 2331.5 2363.4 2365.4 2368.0 1989.3 2202.6 2234.6 2266.9 2282.5 2293.3 2306.4 2326.6 2329.0 2331.8 8781.7 8915.2 8922.7 8924.2 8927.5 5150.4 5289.6 5298.0 5300.8 5301.3 3185.6 3272.4 3315.1 3327.6 3356.9 1143.5 1153.7 1195.4 1217.3 1245.8 12334.2 12369.3 12370.2 12377.6 12398.7 4563.6 4579.1 4648.9 4648.9 4737.2 10593.8 10599.2 10608.5 10628.5 10629.5 5081.4 5109.4 5110.3 5114.6 5358.5 4267.4 4722.9 4858.7 4865.5 4945.7 4042.3 4055.6 4100.7 4121.2 4150.7 1281.8 1294.9 1308.9 1327.2 1342.0 986.1 1000.4 1009.3 1013.3 1024.2 5834.6 6019.4 6021.1 6221.4 6259.5 908.9 961.3 985.3 1010.6 1026.1 4046.6 4187.9 4210.2 4252.6 4264.4 10729.9 11106.7 11191.0 11238.0 11239.5 11025.2 11042.9 11060.9 11074.6 11139.9 8103.5 8113.6 8228.8 8252.6 8256.8 6013.4 6190.2 6237.2 6266.1 6355.2 10071.0 10272.7 10416.5 10521.9 10559.0 10427.5 10444.0 10631.3 10757.3 10759.2 6839.2 7281.8 7374.9 7465.4 7508.0 8813.1 8816.7 8862.9 8865.7 8903.9 7757.3 7994.3 8045.7 8089.6 8092.8 7469.9 7569.9 7675.3 7756.8 7937.8 7076.1 7204.3 7303.8 7305.6 7316.7 5145.4 5241.9 5282.7 5374.5 5382.2 5281.0 5351.7 5406.3 5631.3 5660.2 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#4] prototype.html Cycles:180 Average:4582.29 Median:5148.28 stddev:1336.53 (26.0%) stddev-sans-first:1301.54 14:28:37 INFO - PROCESS | 20260 | Values: 326.2 332.2 333.8 338.7 339.3 5295.6 5345.3 5350.6 5384.7 5399.8 5322.0 5333.3 5361.3 5374.2 5382.4 3865.5 3914.7 3996.8 4129.9 4136.4 4169.9 4184.6 4188.7 4192.2 4194.8 4120.4 4151.3 4155.8 4171.9 4180.0 4012.6 4055.3 4156.0 4171.6 4195.7 3648.0 3655.4 3664.7 3685.3 3701.1 5063.5 5112.0 5125.9 5128.9 5170.2 4443.4 4685.7 4737.5 4755.8 4821.5 5413.1 5427.9 5440.9 5444.8 5474.7 3963.2 4020.2 4039.4 4041.3 4059.3 5495.9 5651.7 5691.4 5722.5 5722.7 3979.2 4000.2 4004.8 4009.4 4014.5 4009.4 4043.3 4044.5 4050.8 4052.0 4582.5 4673.9 4678.7 4689.2 4694.1 5491.2 5508.2 5539.6 5543.6 5550.6 1423.8 1449.7 1451.9 1459.0 1459.0 924.0 949.1 953.3 957.1 960.1 4767.6 4863.6 4875.9 4914.8 4928.3 5044.7 5060.3 5070.5 5081.0 5172.4 4513.4 4776.5 4833.0 4915.6 4931.5 2675.3 2698.9 2708.6 2732.8 2736.7 5138.0 5158.6 5174.5 5220.3 5227.9 4819.0 5068.5 5199.8 5224.5 5569.3 5656.0 5849.4 5851.6 5854.8 5881.4 5683.8 5683.9 5696.6 5698.0 5708.9 5502.9 5662.6 5668.9 5681.6 5683.9 5808.2 5845.4 5850.7 5889.0 5892.5 4172.3 4174.7 4176.6 4180.9 4182.5 5461.3 5665.5 5671.2 5691.6 5752.3 5513.6 5514.4 5555.3 5578.8 5595.7 5385.5 5535.4 5541.6 5561.7 5591.9 5434.2 5437.2 5446.8 5461.2 5466.2 5550.8 5603.4 5619.8 5626.2 5646.4 5201.9 5467.6 5469.5 5484.6 5524.1 14:28:37 INFO - PROCESS | 20260 | 14:28:37 INFO - PROCESS | 20260 | [#5] yui.html Cycles:180 Average:21054.38 Median:4534.38 stddev:31425.34 (693.0%) stddev-sans-first:31476.50 14:28:37 INFO - PROCESS | 20260 | Values: 743.8 747.1 753.4 761.6 781.4 14461.1 14826.7 14853.7 15119.9 15422.6 14599.2 14710.7 14713.4 14742.1 14746.2 647.7 768.4 782.1 789.8 801.1 787.0 795.2 797.4 797.4 797.7 839.6 839.6 840.8 841.0 841.1 683.1 813.8 831.6 833.7 836.1 621.6 622.2 622.3 622.4 622.4 14207.4 14256.0 14267.1 14278.7 14279.4 13973.6 14117.9 14169.4 14246.8 14343.1 12723.9 12930.2 12995.4 13136.5 13189.0 4486.8 4510.8 4533.5 4572.5 4682.3 72247.6 72406.6 72476.6 72668.0 72675.6 11029.1 11077.6 11300.4 11578.8 11584.3 21194.6 21239.2 21275.7 21280.6 21319.0 7894.2 7995.8 8094.8 8132.2 8199.1 4441.2 4535.2 4537.2 4559.5 4569.6 3323.5 3386.6 3404.5 3405.1 3410.8 510.5 612.2 621.9 632.4 634.4 572.7 662.7 673.6 705.7 782.6 9347.2 9526.2 9538.7 9592.7 9615.9 727.1 727.5 733.3 734.9 754.9 4302.9 4520.4 4595.1 4701.2 4820.9 119047.2 124486.0 125340.0 125597.0 129820.0 108242.0 108504.0 108546.0 108711.0 108873.0 93870.5 95021.0 95215.0 95974.0 97888.5 8729.2 8811.0 8880.5 9007.3 9037.5 52602.7 53476.7 53567.7 53758.7 55211.0 47249.5 52313.5 54351.7 54609.8 82656.0 12150.5 12517.2 12645.4 12947.7 13259.7 14123.9 14400.4 14453.6 14701.5 14742.4 14097.0 14357.0 14477.6 14492.8 14562.4 13439.9 13510.9 13625.5 13799.4 13815.3 12563.6 12665.6 12782.2 12867.5 13249.3 10282.4 10654.7 10752.6 11203.6 11240.2 11196.6 11853.3 11972.5 12033.8 12103.2 14:28:37 INFO - PROCESS | 20260 | -------- Summary: end -------- 14:28:37 INFO - PROCESS | 20260 | 14:28:38 INFO - TEST-INFO | 20260: exit 0 14:28:38 INFO - TEST-OK | dromaeo_css | took 1113233ms 14:28:38 INFO - TEST-START | kraken 14:28:38 INFO - operating with platform_type : linux_ 14:28:38 INFO - Initialising browser for kraken test... 14:28:38 INFO - TEST-INFO | started process 20441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcita_T/profile http://localhost:35366/getInfo.html) 14:28:42 INFO - PROCESS | 20441 | __metrics Screen width/height:1600/1200 14:28:42 INFO - PROCESS | 20441 | colorDepth:24 14:28:42 INFO - PROCESS | 20441 | Browser inner width/height: 1024/697 14:28:42 INFO - PROCESS | 20441 | __metrics 14:28:43 ERROR - PROCESS | 20441 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:28:43 INFO - PROCESS | 20441 | console.error: PushService: 14:28:43 INFO - PROCESS | 20441 | stateChangeProcessEnqueue: Error transitioning state 14:28:43 INFO - PROCESS | 20441 | UnknownError 14:28:44 INFO - TEST-INFO | 20441: exit 0 14:28:44 INFO - Browser initialized. 14:28:44 INFO - Running cycle 1/1 for kraken test... 14:28:44 INFO - TEST-INFO | started process 20523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcita_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:55 INFO - PROCESS | 20523 | RSS: Main: 156672000 14:28:55 INFO - PROCESS | 20523 | 14:28:58 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35366/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:59 INFO - PROCESS | 20523 | RSS: Main: 214663168 14:28:59 INFO - PROCESS | 20523 | 14:29:02 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35366/tests/kraken/driver.html?testName=audio-dft) 14:29:02 INFO - PROCESS | 20523 | RSS: Main: 201383936 14:29:02 INFO - PROCESS | 20523 | 14:29:05 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35366/tests/kraken/driver.html?testName=audio-fft) 14:29:06 INFO - PROCESS | 20523 | RSS: Main: 268214272 14:29:06 INFO - PROCESS | 20523 | 14:29:08 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35366/tests/kraken/driver.html?testName=audio-oscillator) 14:29:09 INFO - PROCESS | 20523 | RSS: Main: 178638848 14:29:09 INFO - PROCESS | 20523 | 14:29:11 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:11 INFO - PROCESS | 20523 | RSS: Main: 183640064 14:29:11 INFO - PROCESS | 20523 | 14:29:14 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35366/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:15 INFO - PROCESS | 20523 | RSS: Main: 218103808 14:29:15 INFO - PROCESS | 20523 | 14:29:18 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35366/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:19 INFO - PROCESS | 20523 | RSS: Main: 220643328 14:29:19 INFO - PROCESS | 20523 | 14:29:22 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35366/tests/kraken/driver.html?testName=json-parse-financial) 14:29:22 INFO - PROCESS | 20523 | RSS: Main: 220434432 14:29:22 INFO - PROCESS | 20523 | 14:29:24 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:24 INFO - PROCESS | 20523 | RSS: Main: 207060992 14:29:24 INFO - PROCESS | 20523 | 14:29:26 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:27 INFO - PROCESS | 20523 | RSS: Main: 209948672 14:29:27 INFO - PROCESS | 20523 | 14:29:29 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:29 INFO - PROCESS | 20523 | RSS: Main: 217145344 14:29:29 INFO - PROCESS | 20523 | 14:29:32 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:33 INFO - PROCESS | 20523 | RSS: Main: 222220288 14:29:33 INFO - PROCESS | 20523 | 14:29:35 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:36 INFO - PROCESS | 20523 | RSS: Main: 221872128 14:29:36 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:35366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35366/tests/kraken/driver.html?testName=ai-astar) 14:29:38 INFO - PROCESS | 20523 | RSS: Main: 264822784 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | __start_tp_report 14:29:38 INFO - PROCESS | 20523 | _x_x_mozilla_page_load 14:29:38 INFO - PROCESS | 20523 | _x_x_mozilla_page_load_details 14:29:38 INFO - PROCESS | 20523 | |i|pagename|runs| 14:29:38 INFO - PROCESS | 20523 | |0;ai-astar;110;104;111;114;110;114;110;109;110;109 14:29:38 INFO - PROCESS | 20523 | |1;audio-beat-detection;156;123;128;189;124;132;157;124;181;124 14:29:38 INFO - PROCESS | 20523 | |2;audio-dft;161;161;161;159;161;162;163;161;160;161 14:29:38 INFO - PROCESS | 20523 | |3;audio-fft;74;75;74;136;76;75;74;74;109;75 14:29:38 INFO - PROCESS | 20523 | |4;audio-oscillator;85;85;108;85;84;86;122;84;84;121 14:29:38 INFO - PROCESS | 20523 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;117 14:29:38 INFO - PROCESS | 20523 | |6;imaging-darkroom;146;146;147;146;145;146;145;146;145;146 14:29:38 INFO - PROCESS | 20523 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;94 14:29:38 INFO - PROCESS | 20523 | |8;json-parse-financial;54;52;53;52;52;52;53;52;52;53 14:29:38 INFO - PROCESS | 20523 | |9;json-stringify-tinderbox;61;62;61;62;61;62;63;62;64;62 14:29:38 INFO - PROCESS | 20523 | |10;stanford-crypto-aes;79;79;78;84;79;80;80;80;113;80 14:29:38 INFO - PROCESS | 20523 | |11;stanford-crypto-ccm;121;122;119;121;125;121;118;120;123;121 14:29:38 INFO - PROCESS | 20523 | |12;stanford-crypto-pbkdf2;165;159;160;160;161;161;163;164;158;159 14:29:38 INFO - PROCESS | 20523 | |13;stanford-crypto-sha256-iterative;63;64;62;63;63;63;63;62;62;61 14:29:38 INFO - PROCESS | 20523 | __end_tp_report 14:29:38 INFO - PROCESS | 20523 | __start_cc_report 14:29:38 INFO - PROCESS | 20523 | _x_x_mozilla_cycle_collect,1603 14:29:38 INFO - PROCESS | 20523 | __end_cc_report 14:29:38 INFO - PROCESS | 20523 | __startTimestamp1465421378308__endTimestamp 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | ------- Summary: start ------- 14:29:38 INFO - PROCESS | 20523 | Number of tests: 14 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:2.81 (2.6%) stddev-sans-first:2.98 14:29:38 INFO - PROCESS | 20523 | Values: 110.0 104.0 111.0 114.0 110.0 114.0 110.0 109.0 110.0 109.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:144.00 stddev:25.27 (17.5%) stddev-sans-first:26.42 14:29:38 INFO - PROCESS | 20523 | Values: 156.0 123.0 128.0 189.0 124.0 132.0 157.0 124.0 181.0 124.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 14:29:38 INFO - PROCESS | 20523 | Values: 161.0 161.0 161.0 159.0 161.0 162.0 163.0 161.0 160.0 161.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#3] audio-fft Cycles:10 Average:84.20 Median:74.50 stddev:21.18 (28.4%) stddev-sans-first:22.14 14:29:38 INFO - PROCESS | 20523 | Values: 74.0 75.0 74.0 136.0 76.0 75.0 74.0 74.0 109.0 75.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.50 stddev:16.04 (19.0%) stddev-sans-first:16.64 14:29:38 INFO - PROCESS | 20523 | Values: 85.0 85.0 108.0 85.0 84.0 86.0 122.0 84.0 84.0 121.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:29:38 INFO - PROCESS | 20523 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:29:38 INFO - PROCESS | 20523 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:29:38 INFO - PROCESS | 20523 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:0.71 (1.3%) stddev-sans-first:0.50 14:29:38 INFO - PROCESS | 20523 | Values: 54.0 52.0 53.0 52.0 52.0 52.0 53.0 52.0 52.0 53.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 14:29:38 INFO - PROCESS | 20523 | Values: 61.0 62.0 61.0 62.0 61.0 62.0 63.0 62.0 64.0 62.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.00 stddev:10.59 (13.2%) stddev-sans-first:11.12 14:29:38 INFO - PROCESS | 20523 | Values: 79.0 79.0 78.0 84.0 79.0 80.0 80.0 80.0 113.0 80.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:1.97 (1.6%) stddev-sans-first:2.09 14:29:38 INFO - PROCESS | 20523 | Values: 121.0 122.0 119.0 121.0 125.0 121.0 118.0 120.0 123.0 121.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:2.31 (1.4%) stddev-sans-first:1.94 14:29:38 INFO - PROCESS | 20523 | Values: 165.0 159.0 160.0 160.0 161.0 161.0 163.0 164.0 158.0 159.0 14:29:38 INFO - PROCESS | 20523 | 14:29:38 INFO - PROCESS | 20523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:29:38 INFO - PROCESS | 20523 | Values: 63.0 64.0 62.0 63.0 63.0 63.0 63.0 62.0 62.0 61.0 14:29:38 INFO - PROCESS | 20523 | -------- Summary: end -------- 14:29:38 INFO - PROCESS | 20523 | 14:29:39 INFO - TEST-INFO | 20523: exit 0 14:29:39 INFO - TEST-OK | kraken | took 60632ms 14:29:39 INFO - SUITE-END | took 1173s 14:29:39 INFO - Completed test suite (00:19:34) 14:29:39 INFO - javascript benchmark 14:29:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.3173067790435, 3186.0760379489943, 3216.8069915805054, 3235.854386552608, 3259.6577359377266, 5270.314859068325, 5305.257263983036, 5396.460353964601, 5498.7800487980485, 5533.861653458661, 5372.194170874371, 5379.784808607661, 5418.729063546817, 5455.645383050099, 5488.69812160331, 4815.205491093965, 4908.0, 4917.7541122943885, 4927.3348098006845, 5084.2373643953515, 5013.298138260647, 5051.79792808289, 5066.316047333618, 5079.212722028073, 5122.078025955345, 4824.083424149418, 4841.49164337743, 4844.854654360357, 4929.334539837112, 4961.702297862122, 4907.484714105039, 4918.3360246367, 4928.8767780805765, 4929.309896614477, 4932.235503496964, 4875.975620121877, 4898.191798353268, 4898.436679781835, 4899.8775030624165, 4905.705657660552, 5249.501297376743, 5250.343707036621, 5297.258383826267, 5329.493698098674, 5331.600129990266, 5851.356350801409, 5889.9705501472645, 5899.439553242435, 5900.203472531196, 5904.291485021782, 5600.6079574429805, 5684.2326285951285, 5938.495227905633, 5950.43470870271, 5960.672163031031, 5438.483344082306, 5492.725363731797, 5523.502884740353, 5540.141278101901, 5540.335159780852, 6002.129691194839, 6022.668753218528, 6024.036154215304, 6025.548083893638, 6034.487068599218, 5572.164175373727, 5669.631473954262, 5724.570657200727, 5752.482276595127, 5781.913271300934, 5844.415558444121, 5845.0, 5854.151148083504, 5906.586538942232, 5910.202122713378, 5806.0, 5826.388229235869, 5831.06702927538, 5833.766649333979, 5841.94158058414, 5578.386377498472, 5728.198052272685, 5784.248047753765, 5785.595008349375, 5845.707714614252, 4409.11817636474, 4411.051623900877, 4411.933820992687, 4413.624841888475, 4446.9777651111535, 3911.3546264866545, 3927.8821635350987, 3933.350997085506, 3973.2450834341385, 3986.2226865761477, 5397.136458166675, 5412.458754124635, 5442.374126975369, 5499.340079190522, 5501.642393244426, 5837.153612726131, 5838.7080645967535, 5843.152742852262, 5844.532437404998, 5849.239598852122, 5428.348598168245, 5476.014317422822, 5480.095784195563, 5480.177973303957, 5483.670979741229, 4869.902601947942, 4953.900921981613, 4968.378952630921, 4980.900381992412, 4987.301777751118, 5963.880722385528, 5982.1325907744, 5991.7902873399225, 5996.490298324604, 6001.339852616209, 5720.771169153354, 5834.474897259267, 5845.590808643524, 5848.53211743068, 5848.941510584839, 5878.970605146947, 5959.344472108151, 5973.133895585029, 6005.579609427298, 6025.186599809145, 5751.281089863767, 5766.682832444256, 5781.335146458043, 5787.160861674949, 5795.710214489343, 5744.253247077853, 5791.449812267828, 5886.470217680429, 5888.528917686661, 5900.0, 5722.685252311163, 5769.74036168365, 5771.509421699203, 5771.971140144273, 5827.6794776286015, 5660.688662123458, 5711.628744131618, 5722.74247658848, 5728.369879313355, 5743.4543718346695, 5400.108982017923, 5442.782288708408, 5489.698066606375, 5545.805896793593, 5591.860203494945, 5746.138079287973, 5746.626469279484, 5748.166515855094, 5751.827445176651, 5760.0783874579865, 5511.4213007633625, 5544.556435485232, 5555.055640541037, 5556.055470570093, 5588.608797384144], "value": 5357.921828234166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4165155670108, 619.0806652121599, 622.7228883146996, 637.448606954984, 644.3717375558828, 31856.36287274253, 34133.14667133323, 34305.828470857676, 34376.31247375054, 44487.110257794906, 43096.78451607745, 43428.78285608567, 43536.56463435365, 43575.0, 43578.0, 8629.093945135748, 8831.161039701217, 8834.204921557059, 8843.557822108902, 8844.11558844117, 8617.482951022926, 8754.474731516098, 8757.868631970525, 8759.605817738217, 8759.737207883774, 8759.824803503927, 8778.473291602493, 8791.912080879174, 8793.560321983876, 8804.03155652881, 8737.650493980233, 8764.737057888273, 8769.210771030606, 8786.780330491756, 8794.912050879473, 8674.522901240429, 8688.478691278544, 8727.781805454852, 8730.738077857675, 8754.518501482416, 37658.0, 37773.0, 37826.81086594577, 37830.24339513222, 37992.0, 3546.3261980223933, 3698.9815050924844, 3699.9445008324897, 3726.6087060858763, 4108.50697916249, 30693.693063069306, 31087.533686994713, 31282.21794455157, 31349.37301253962, 32280.192995175075, 4249.298865687158, 4334.13317336534, 4357.193919124972, 4471.150481408522, 4473.977630111861, 311699.0, 312524.81113538746, 312943.0, 313251.0, 313815.0, 57050.714746426005, 57240.0, 57406.42593574095, 57628.27115186551, 57655.13517297244, 61646.38353616496, 61745.69127154336, 61818.0, 61824.38175618276, 61843.690781546706, 16935.830641693425, 17163.056031918113, 17234.396796112076, 17237.39669111575, 17249.655006900044, 13013.739725205633, 13156.144850584682, 13157.276349800853, 13166.0, 13175.14361566495, 17467.67939461651, 19255.13351899168, 19314.32399865998, 19324.8067519323, 19513.121909513822, 6946.444284457231, 7036.542624729376, 7105.360517553445, 7236.167840698282, 7314.743983960536, 844.9746507604782, 939.6422169964472, 1045.2369770067894, 1100.4442756408123, 1126.1778901402022, 30626.38747225043, 30800.38399232003, 30847.537286940715, 31302.0, 31330.373392532023, 1099.5052226497949, 1099.59864649404, 1162.604714397109, 1210.2254557083297, 1225.0077437275836, 16328.428505002268, 16569.6686066278, 16659.666806663798, 16784.916075419787, 16893.577660558585, 508486.0, 513590.0, 514126.0, 515125.0, 516257.0, 53078.20382694263, 54424.72787636037, 54455.18317225245, 54793.45206547963, 54808.17787733187, 1260.2060701757835, 1340.75866344059, 1377.5040985245303, 1387.8265216847894, 1389.9027068105338, 30193.69806301909, 31508.527372089895, 31543.52684709777, 31610.683893160774, 32213.51679724853, 48034.75982620064, 48310.5168948306, 48644.270335945694, 48682.513174867796, 48725.0, 383413.0, 387471.0, 387523.0, 388137.0, 642059.0, 26879.193624191306, 27335.726642734113, 27636.789056875805, 28555.0, 28571.42857142887, 44487.77756111199, 45885.31172032355, 46637.0, 46933.2960005607, 46943.76528117474, 38136.32955826266, 38777.897768177914, 39710.0, 39754.40368394418, 40285.39571906482, 38004.429933551575, 38548.42177367398, 39478.40782388209, 39982.400263995485, 40105.79947100246, 38976.2204755909, 39715.602843972345, 40011.199776003734, 40079.59920400759, 40141.387275145375, 34003.0, 34739.826300868335, 34833.0, 35438.0, 35903.820480897426, 26653.20040398791, 26948.0, 27004.86497567578, 27209.741759395056, 27706.307342316602], "value": 19666.320379812616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4522619588498, 390.50991006287086, 393.8641168796765, 394.791488530037, 412.1283485428318, 17869.0, 19119.808801911975, 19418.805811941875, 19426.708599371002, 19448.611027779436, 17358.56603584908, 17887.195076221567, 18175.54561135969, 19035.333763318253, 19037.428877133672, 5474.452554744524, 5522.585806064541, 5677.716114194294, 5702.515286200678, 5863.1791549182935, 5786.942130578704, 5809.477147056764, 5825.15535247391, 5855.765769369242, 5859.443352881491, 5782.624129431594, 5831.096180092092, 5861.882762344771, 5863.208466856983, 5865.208196893429, 5641.266635337401, 5713.200151978747, 5745.253117094751, 5750.65496070233, 5805.303363596375, 5381.973090134525, 5694.629849059798, 5695.202671625976, 5699.145128230799, 5699.373068962411, 13201.14192577489, 13532.120412173275, 14215.488517339805, 22076.0, 22356.88821555898, 2287.1880482428833, 2304.366299267698, 2342.7891489766002, 2421.982767237747, 2606.713261541229, 9549.665761698307, 9959.65141220061, 9992.45041522716, 10117.494125293779, 10350.689479315633, 1900.268396667293, 1955.8909454628345, 1965.852561057912, 2004.2183548416128, 2014.2748610500207, 67242.9913551302, 74018.62990685066, 75035.24964750337, 75521.24478755252, 76368.61815690942, 10627.36235825853, 10729.302595331279, 10937.671869843918, 11079.279846809932, 11085.22403431752, 15317.846821531642, 15339.386424542894, 15444.227788610524, 15445.30496127677, 15483.845161548466, 7910.248526389983, 8036.075851277061, 8090.635921383434, 8196.713115040944, 8231.876521852177, 7695.0, 7703.114141873644, 7737.193013740784, 7797.805054873674, 7813.374930005586, 4648.0, 4730.455997560324, 4752.809887604526, 4767.713937163712, 4777.044591081728, 1882.905854707259, 1930.5656227348734, 1958.177565422526, 1963.6759934610916, 1967.2819420911264, 945.5886689290181, 1032.7624646331385, 1049.9947500262604, 1106.1316866259947, 1109.4619109731773, 17977.280908763765, 18134.183961721756, 18939.810601893805, 19066.2373505061, 19218.13518391676, 970.3304719743354, 1019.4393083803878, 1032.2877214721818, 1041.1514615588271, 1049.4123290957089, 9991.150752186, 10409.739756505996, 10599.152067834555, 10619.30974486656, 10645.946770266099, 467268.0, 477641.0, 483852.0, 484820.0, 485160.0, 88797.0, 89663.10336896547, 90293.0, 90606.54696726475, 91742.54128729313, 981.082687687015, 989.3816364772017, 1005.8943810899897, 1008.0625018732502, 1011.858339832424, 16265.349386024427, 16340.836591634406, 16538.917305413397, 16539.338426462808, 16630.916845415697, 38271.42592861054, 38322.233555329294, 39569.60430395659, 40500.39249411202, 41490.58509414867, 57250.42749572451, 57861.13208301963, 59333.40666593279, 59494.0, 59999.10001349896, 7728.4590078693955, 8103.8379232413845, 8150.062742784656, 8182.713605023796, 8294.0, 8710.738677839676, 11155.21913466082, 11885.46515406826, 11954.402279885797, 12376.257424554195, 10875.782484350111, 10919.617813376493, 11062.0, 11176.161787866105, 11381.772364552828, 5509.201165831012, 9833.655822046194, 9880.407175569202, 10823.188260880623, 10848.077913377452, 11010.669679909295, 11033.393163375771, 11196.384198868815, 11208.49561769706, 11386.373749443861, 8230.794230144294, 8407.579621019047, 8524.360672949677, 8746.344024198082, 8789.692360767342, 11013.559457621606, 11052.834207487054, 11095.334279943228, 11108.0, 11305.152113591677], "value": 8930.145053532415, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.4343110746831, 1457.854214578542, 1476.5053707008149, 1628.9104099274543, 1772.8227177282274, 8439.70461033864, 8801.867971980417, 8807.427517211378, 8966.282697384193, 8976.685815996441, 8677.435966662162, 8856.601452934618, 8862.734117976472, 8883.244924181452, 8888.28893688505, 2016.213676666094, 2241.9103235870625, 2304.9884750576225, 2339.2397470822007, 2367.95264094718, 2365.7042869641296, 2368.4789346343778, 2370.063824789207, 2376.66726658268, 2377.7622237776172, 2328.266596022256, 2331.4754180309465, 2363.420961864337, 2365.432296248905, 2367.95264094718, 1989.273915021014, 2202.647576387786, 2234.5866014787316, 2266.852654577447, 2282.4978504729097, 2293.289080385086, 2306.411864974438, 2326.581215381231, 2328.9650655240184, 2331.848429852071, 8781.692640757607, 8915.153060459246, 8922.68770593026, 8924.241439477652, 8927.464352138828, 5150.381954165487, 5289.603279753996, 5298.046351656739, 5300.814471493518, 5301.3373328333955, 3185.601799775028, 3272.443684573628, 3315.088350703552, 3327.600687917441, 3356.882509112194, 1143.4625725908809, 1153.74040840811, 1195.3545085653736, 1217.2939694976892, 1245.7882160032816, 12334.19827711205, 12369.257844529267, 12370.19593726414, 12377.566785162566, 12398.690032749253, 4563.589276965089, 4579.107074120515, 4648.907021859543, 4648.930266046012, 4737.242041273448, 10593.788124237471, 10599.205059620404, 10608.469576521144, 10628.521716522775, 10629.5216715248, 5081.415637201695, 5109.4379618241965, 5110.2590124431745, 5114.64197506171, 5358.517733404013, 4267.359896015622, 4722.929156062662, 4858.65989380747, 4865.513448655177, 4945.653804233669, 4042.346513611734, 4055.5538890721996, 4100.7334523255895, 4121.196366708523, 4150.667946564267, 1281.7628738683372, 1294.8510921244178, 1308.941097650608, 1327.183781974079, 1342.02703040295, 986.1223511075149, 1000.3997601439079, 1009.3187098708343, 1013.3210748798323, 1024.155072065549, 5834.591578589543, 6019.428154325332, 6021.126936594169, 6221.3778622138325, 6259.530535209878, 908.9183871193259, 961.2598299309632, 985.2659768472533, 1010.6412223660642, 1026.1175389165312, 4046.615571520701, 4187.874363769091, 4210.157968406331, 4252.55348188442, 4264.402983582301, 10729.89270107289, 11106.722331941766, 11191.0, 11238.044766194966, 11239.494222759831, 11025.17311201647, 11042.944785276022, 11060.944695276472, 11074.612388566522, 11139.888601114048, 8103.513789172668, 8113.553754543556, 8228.753137405887, 8252.587370631445, 8256.752297431087, 6013.398660134127, 6190.226221722285, 6237.157983672146, 6266.060090986389, 6355.205599300088, 10071.0, 10272.691819245434, 10416.531256093342, 10521.894781052091, 10559.0, 10427.478626068818, 10444.0, 10631.255812093079, 10757.300775449883, 10759.193060520649, 6839.213490448662, 7281.781546553612, 7374.926250737639, 7465.440091993014, 7507.962460187664, 8813.118688131135, 8816.735497935073, 8862.911370886208, 8865.734027978913, 8903.910960890309, 7757.26306000929, 7994.280514753467, 8045.718399856211, 8089.635966381645, 8092.757217283491, 7469.887951680837, 7569.924300757142, 7675.270849269311, 7756.806079848049, 7937.761867143995, 7076.0801095857205, 7204.3155900189395, 7303.817404564716, 7305.634718263959, 7316.743913962986, 5145.3568303962, 5241.895162096813, 5282.683039017671, 5374.48942350476, 5382.165764306539, 5280.973595132, 5351.652142610717, 5406.297181366397, 5631.324241091095, 5660.207570940154], "value": 4701.996696777513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.15037826462066, 332.1894577231555, 333.8013881740364, 338.66472192529403, 339.2722610001546, 5295.629305948585, 5345.278387417693, 5350.598705097119, 5384.730763461831, 5399.838004859851, 5322.0, 5333.253344531759, 5361.303030606015, 5374.193870919364, 5382.354117505895, 3865.4781604483455, 3914.727713493112, 3996.840126394948, 4129.9174016519655, 4136.420901073837, 4169.874903752892, 4184.644305234059, 4188.6649068074485, 4192.24539582875, 4194.790260486979, 4120.361343991686, 4151.273527132755, 4155.750654960697, 4171.874843754677, 4180.017695841475, 4012.578679238667, 4055.3308704063793, 4156.0, 4171.6036976487185, 4195.713336231745, 3647.963520364789, 3655.3785856404475, 3664.6623982246556, 3685.281370132825, 3701.130234394942, 5063.493650634944, 5112.0, 5125.871853203663, 5128.897422051538, 5170.172772356443, 4443.42235509385, 4685.672002959795, 4737.526247375269, 4755.833545825914, 4821.54195351441, 5413.133898576249, 5427.891442171134, 5440.91838622421, 5444.7822087116465, 5474.671519708791, 3963.2271707017144, 4020.2361551305453, 4039.394090886361, 4041.2927737646087, 4059.269331520325, 5495.862603434946, 5651.689157096358, 5691.402402747734, 5722.54219662426, 5722.685252311121, 3979.224051309967, 4000.219957108336, 4004.7797371144284, 4009.4386785850006, 4014.5146295870713, 4009.358502639622, 4043.2924238258774, 4044.4944381952255, 4050.817713202854, 4051.9797401013398, 4582.495925448198, 4673.883152921137, 4678.695884767547, 4689.155951928686, 4694.131585656664, 5491.203775452537, 5508.173773933942, 5539.612227144142, 5543.584231182596, 5550.611457198038, 1423.8291405031255, 1449.724552335053, 1451.883849292054, 1458.9854101459061, 1459.0151647637801, 923.9676611318572, 949.1362859797689, 953.2564599612314, 957.1098878043487, 960.078324808178, 4767.6424268179335, 4863.562279394871, 4875.854174269044, 4914.829934692104, 4928.250471082786, 5044.663164261474, 5060.342155519759, 5070.518300761421, 5080.983803239367, 5172.405173405032, 4513.42396669176, 4776.4923415207295, 4833.0, 4915.606751459874, 4931.5315045070665, 2675.304420850593, 2698.9190324290303, 2708.6478757761365, 2732.811227116211, 2736.713744540063, 5137.972405518911, 5158.595327084182, 5174.534291913746, 5220.321358223407, 5227.947720522822, 4818.975905120522, 5068.493150684902, 5199.752059505767, 5224.477552244821, 5569.331680198321, 5656.0, 5849.444302791228, 5851.561132915049, 5854.795082172103, 5881.411858814085, 5683.77264909399, 5683.886322273449, 5696.629719068247, 5698.0, 5708.885822283448, 5502.899420115913, 5662.631928924607, 5668.914966275427, 5681.602287839812, 5683.8863222736145, 5808.215890854681, 5845.41545845412, 5850.6782126981725, 5889.0283103287475, 5892.499137573182, 4172.269852775813, 4174.666026717795, 4176.60322269384, 4180.937285940652, 4182.519010313731, 5461.317335333083, 5665.546756259407, 5671.206031155724, 5691.601587888808, 5752.252207213036, 5513.614047016831, 5514.443184146284, 5555.333359996826, 5578.804741834017, 5595.664260144405, 5385.488378604026, 5535.394735526652, 5541.612087153861, 5561.691897862342, 5591.944080559305, 5434.184872269191, 5437.184422336682, 5446.809361672323, 5461.235427040297, 5466.234727138283, 5550.8057217997175, 5603.38362780102, 5619.775208991595, 5626.24045753818, 5646.435356464321, 5201.869953251047, 5467.617266791286, 5469.480399362054, 5484.643498172606, 5524.14375771756], "value": 4161.145768407168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.8252010777468, 747.0922828763051, 753.4349238071446, 761.649641165064, 781.3905153979898, 14461.132332060084, 14826.703465930676, 14853.702925941489, 15119.924400377982, 15422.614434639125, 14599.197044162567, 14710.705785884276, 14713.411463541472, 14742.115473071623, 14746.188959607218, 647.7150053976259, 768.4006474949548, 782.1240210963729, 789.7828097273239, 801.0747586537558, 786.9921300787005, 795.2008231727107, 797.3541431440523, 797.401948538596, 797.7088362747613, 839.5760141128721, 839.5844057191699, 840.8444437779, 840.9789755256106, 841.1042240014395, 683.1017212365723, 813.7965508622874, 831.600831600835, 833.6540335760652, 836.0970152235572, 621.552482212806, 622.1911515030488, 622.3185611755121, 622.3869488553771, 622.4242575617536, 14207.36066876993, 14256.0, 14267.072640278453, 14278.714425711532, 14279.357428915724, 13973.580792576136, 14117.858821411757, 14169.362378692984, 14246.826670921046, 14343.067700599428, 12723.911646146056, 12930.224186548838, 12995.350232488337, 13136.540221092217, 13189.0, 4486.820527178941, 4510.819567217307, 4533.546645335473, 4572.51988541205, 4682.251047932389, 72247.63876180637, 72406.63796681036, 72476.6376168121, 72668.0, 72675.63662181709, 11029.117670586334, 11077.556897724162, 11300.434978251054, 11578.826317605242, 11584.320273560455, 21194.576108477744, 21239.150433982777, 21275.680864787042, 21280.574388512454, 21319.0, 7894.162033359832, 7995.760127196193, 8094.757157285291, 8132.1867813218205, 8199.139090395542, 4441.20058389493, 4535.206338890681, 4537.228671125917, 4559.52125026874, 4569.611583015481, 3323.4682450807754, 3386.6444023377685, 3404.540387047766, 3405.1316914186723, 3410.812405317731, 510.54561440318145, 612.185792895448, 621.8880601491685, 632.4181752787447, 634.4195061518751, 572.7279542217414, 662.6918482905472, 673.6059405247985, 705.6894966214849, 782.6008735544913, 9347.158755711882, 9526.237900968044, 9538.713838584854, 9592.712218633453, 9615.855762163574, 727.1238158019573, 727.5125665803924, 733.2777214443769, 734.8824188129873, 754.9396048316122, 4302.913941721148, 4520.412346394947, 4595.149897269016, 4701.200795864711, 4820.8794780130775, 119047.2142917857, 124486.0, 125340.0, 125597.0, 129820.0, 108242.0, 108504.0, 108546.0, 108711.0, 108873.0, 93870.53064734633, 95021.0, 95215.047849522, 95974.0, 97888.51055744819, 8729.214370706666, 8810.955945220489, 8880.467171969702, 9007.279417646703, 9037.548122593975, 52602.73698631483, 53476.73261633667, 53567.73216133894, 53758.73120634372, 55211.0, 47249.52750472589, 52313.47686523086, 54351.72824135854, 54609.81560737685, 82656.0, 12150.513979440724, 12517.186382885084, 12645.367731613567, 12947.676308092374, 13259.66850828737, 14123.858761412665, 14400.351984160528, 14453.566393008226, 14701.485448009269, 14742.410303587736, 14097.0, 14357.0, 14477.638059048608, 14492.782608261095, 14562.41750329975, 13439.857612102689, 13510.93244533771, 13625.498007968128, 13799.448022079005, 13815.309234538434, 12563.560275390317, 12665.620031399072, 12782.169159004636, 12867.549635762703, 13249.271290079138, 10282.434466104436, 10654.73363165927, 10752.623658171926, 11203.60787372438, 11240.213185076966, 11196.552137914392, 11853.34806585646, 11972.461239244081, 12033.819492707442, 12103.152779305365], "value": 7493.047279045041, "unit": "score"}], "name": "dromaeo_css", "value": 7188.351060316465, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 114.0, 110.0, 114.0, 110.0, 109.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 128.0, 189.0, 124.0, 132.0, 157.0, 124.0, 181.0, 124.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 163.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 136.0, 76.0, 75.0, 74.0, 74.0, 109.0, 75.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 108.0, 85.0, 84.0, 86.0, 122.0, 84.0, 84.0, 121.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 52.0, 52.0, 53.0, 52.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 64.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 84.0, 79.0, 80.0, 80.0, 80.0, 113.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 119.0, 121.0, 125.0, 121.0, 118.0, 120.0, 123.0, 121.0], "value": 121.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 160.0, 160.0, 161.0, 161.0, 163.0, 164.0, 158.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1493.4999999999998, "alertThreshold": 2.0}]} 14:29:39 INFO - Return code: 0 14:29:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:39 ERROR - # TBPL SUCCESS # 14:29:39 INFO - Running post-action listener: _resource_record_post_action 14:29:39 INFO - ##### 14:29:39 INFO - ##### Finished run-tests step (success) 14:29:39 INFO - ##### 14:29:39 INFO - Running post-run listener: _resource_record_post_run 14:29:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 549720064; Read time: 444; Write time: 744116 14:29:39 INFO - TinderboxPrint: CPU usage
13.1% 14:29:39 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 444 14:29:39 INFO - TinderboxPrint: I/O write bytes / time
549,720,064 / 744,116 14:29:39 INFO - TinderboxPrint: CPU idle
8,261.6 (86.8%) 14:29:39 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 14:29:39 INFO - TinderboxPrint: Swap in / out
0 / 0 14:29:39 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 254820352; Read time: 224; Write time: 429708 14:29:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294899712; Read time: 220; Write time: 314408 14:29:40 INFO - Running post-run listener: _upload_blobber_files 14:29:40 INFO - Blob upload gear active. 14:29:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:40 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 14:29:40 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'] 14:29:40 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 14:29:40 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:45 INFO - (blobuploader) - INFO - Done attempting. 14:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:45 INFO - (blobuploader) - INFO - Done attempting. 14:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:29:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:46 INFO - (blobuploader) - INFO - Done attempting. 14:29:46 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:46 INFO - Return code: 0 14:29:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82329e0b160e830b1bb9c670eeea795f5addca23626eaa19c805e5614ecfd7a8ad685130ec2e31743fc3e109d39a27cf4b77f31f2720dddd06616e1bcc440e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05268725d72b3d48a79487f1ba2e09e70afa83b9c27cd77906329089fa9f3cab7ab9f6ab1bf19ca141f1588e3947e5d4c48d07049ccec5a33513185b52541d3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e121e186b80e46f2000f9ca25ad80ed41ddcf11fd431fabeff1965ce07a352c4f9d93973b289a1ee4bc73dc1d0791421de721c14842b76c2df1b8dc55c709c8"} 14:29:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:46 INFO - Contents: 14:29:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82329e0b160e830b1bb9c670eeea795f5addca23626eaa19c805e5614ecfd7a8ad685130ec2e31743fc3e109d39a27cf4b77f31f2720dddd06616e1bcc440e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05268725d72b3d48a79487f1ba2e09e70afa83b9c27cd77906329089fa9f3cab7ab9f6ab1bf19ca141f1588e3947e5d4c48d07049ccec5a33513185b52541d3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e121e186b80e46f2000f9ca25ad80ed41ddcf11fd431fabeff1965ce07a352c4f9d93973b289a1ee4bc73dc1d0791421de721c14842b76c2df1b8dc55c709c8"} 14:29:46 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:46 INFO - Copying logs to upload dir... 14:29:46 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.069329 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-08 14:29:46.815842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:46.819841) ========= 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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 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/f82329e0b160e830b1bb9c670eeea795f5addca23626eaa19c805e5614ecfd7a8ad685130ec2e31743fc3e109d39a27cf4b77f31f2720dddd06616e1bcc440e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05268725d72b3d48a79487f1ba2e09e70afa83b9c27cd77906329089fa9f3cab7ab9f6ab1bf19ca141f1588e3947e5d4c48d07049ccec5a33513185b52541d3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e121e186b80e46f2000f9ca25ad80ed41ddcf11fd431fabeff1965ce07a352c4f9d93973b289a1ee4bc73dc1d0791421de721c14842b76c2df1b8dc55c709c8"} build_url:https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82329e0b160e830b1bb9c670eeea795f5addca23626eaa19c805e5614ecfd7a8ad685130ec2e31743fc3e109d39a27cf4b77f31f2720dddd06616e1bcc440e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05268725d72b3d48a79487f1ba2e09e70afa83b9c27cd77906329089fa9f3cab7ab9f6ab1bf19ca141f1588e3947e5d4c48d07049ccec5a33513185b52541d3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e121e186b80e46f2000f9ca25ad80ed41ddcf11fd431fabeff1965ce07a352c4f9d93973b289a1ee4bc73dc1d0791421de721c14842b76c2df1b8dc55c709c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:46.845633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:46.846018) ========= 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=db0483c52d987ecb441a263b000001ad-1465420086.198811-246761428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:46.931641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 14:29:46.932014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 14:29:46.932378) ========= ========= Total master_lag: 0.19 =========