builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1465917685.43 results: success (0) buildid: 20160614053033 builduid: fa9b71cac7904fd4b7e42bf559cb37a1 revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.429272) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.429728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.430051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.486954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.487274) ========= 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=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 08:21:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2016-06-14 08:21:26 (34.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145125 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.655954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.656279) ========= 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=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014105 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.707800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:25.708233) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 08:21:26,999 truncating revision to first 12 chars 2016-06-14 08:21:26,999 Setting DEBUG logging. 2016-06-14 08:21:26,999 attempt 1/10 2016-06-14 08:21:26,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5003caf3aa25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 08:21:27,513 unpacking tar archive at: fx-team-5003caf3aa25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:26.577857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:26.578227) ========= script_repo_revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:26.578714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:26.579023) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 08:21:26.589682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-14 08:21:26.589991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:27 INFO - MultiFileLogger online at 20160614 08:21:27 in /builds/slave/test 08:21:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:21:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:27 INFO - {'append_to_log': False, 08:21:27 INFO - 'base_work_dir': '/builds/slave/test', 08:21:27 INFO - 'blob_upload_branch': 'Fx-Team', 08:21:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:27 INFO - 'branch': 'Fx-Team', 08:21:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:27 INFO - 'config_files': ('talos/linux_config.py',), 08:21:27 INFO - 'default_actions': ('clobber', 08:21:27 INFO - 'read-buildbot-config', 08:21:27 INFO - 'download-and-extract', 08:21:27 INFO - 'populate-webroot', 08:21:27 INFO - 'create-virtualenv', 08:21:27 INFO - 'install', 08:21:27 INFO - 'run-tests'), 08:21:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:27 INFO - 'download_minidump_stackwalk': True, 08:21:27 INFO - 'download_symbols': 'ondemand', 08:21:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:27 INFO - 'installer_path': 'installer.exe', 08:21:27 INFO - 'log_level': 'info', 08:21:27 INFO - 'log_name': 'talos', 08:21:27 INFO - 'log_to_console': True, 08:21:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:27 INFO - 'opt_config_files': (), 08:21:27 INFO - 'pip_index': False, 08:21:27 INFO - 'sps_profile': False, 08:21:27 INFO - 'sps_profile_interval': 0, 08:21:27 INFO - 'suite': 'dromaeojs-e10s', 08:21:27 INFO - 'system_bits': '32', 08:21:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:27 INFO - 'title': 'talos-linux64-ix-063', 08:21:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:27 INFO - 'use_talos_json': True, 08:21:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:27 INFO - 'work_dir': 'build'} 08:21:27 INFO - ##### 08:21:27 INFO - ##### Running clobber step. 08:21:27 INFO - ##### 08:21:27 INFO - Running pre-action listener: _resource_record_pre_action 08:21:27 INFO - Running main action method: clobber 08:21:27 INFO - rmtree: /builds/slave/test/build 08:21:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - ##### 08:21:28 INFO - ##### Finished clobber step (success) 08:21:28 INFO - ##### 08:21:28 INFO - ##### 08:21:28 INFO - ##### Running read-buildbot-config step. 08:21:28 INFO - ##### 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: read_buildbot_config 08:21:28 INFO - Using buildbot properties: 08:21:28 INFO - { 08:21:28 INFO - "project": "", 08:21:28 INFO - "product": "firefox", 08:21:28 INFO - "script_repo_revision": "production", 08:21:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:21:28 INFO - "repository": "", 08:21:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:21:28 INFO - "buildid": "20160614053033", 08:21:28 INFO - "pgo_build": "True", 08:21:28 INFO - "basedir": "/builds/slave/test", 08:21:28 INFO - "buildnumber": 469, 08:21:28 INFO - "slavename": "talos-linux64-ix-063", 08:21:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:21:28 INFO - "platform": "ubuntu64_hw", 08:21:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:21:28 INFO - "branch": "fx-team", 08:21:28 INFO - "repo_path": "integration/fx-team", 08:21:28 INFO - "revision": "5003caf3aa25dad509e53c68d2ee39de58fe5ec5", 08:21:28 INFO - "stage_platform": "linux64-pgo", 08:21:28 INFO - "builduid": "fa9b71cac7904fd4b7e42bf559cb37a1", 08:21:28 INFO - "slavebuilddir": "test" 08:21:28 INFO - } 08:21:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - ##### 08:21:28 INFO - ##### Finished read-buildbot-config step (success) 08:21:28 INFO - ##### 08:21:28 INFO - ##### 08:21:28 INFO - ##### Running download-and-extract step. 08:21:28 INFO - ##### 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: download_and_extract 08:21:28 INFO - mkdir: /builds/slave/test/build/tests 08:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:28 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:34 INFO - Downloaded 1361 bytes. 08:21:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:34 INFO - Using the following test package requirements: 08:21:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'jsshell-linux-x86_64.zip'], 08:21:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:34 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:36 INFO - Downloaded 24219727 bytes. 08:21:36 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'] 08:21:36 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 08:21:37 INFO - Return code: 0 08:21:37 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 08:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:37 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:39 INFO - Downloaded 24219727 bytes. 08:21:39 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'] 08:21:39 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 08:21:41 INFO - Return code: 0 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:45 INFO - Downloaded 14405384 bytes. 08:21:45 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'] 08:21:45 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 08:21:46 INFO - Return code: 0 08:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:46 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:21:47 INFO - Downloaded 59341232 bytes. 08:21:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:47 INFO - mkdir: /builds/slave/test/properties 08:21:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:47 INFO - Contents: 08:21:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:48 INFO - Running post-action listener: _resource_record_post_action 08:21:48 INFO - Running post-action listener: set_extra_try_arguments 08:21:48 INFO - ##### 08:21:48 INFO - ##### Finished download-and-extract step (success) 08:21:48 INFO - ##### 08:21:48 INFO - ##### 08:21:48 INFO - ##### Running populate-webroot step. 08:21:48 INFO - ##### 08:21:48 INFO - Running pre-action listener: _resource_record_pre_action 08:21:48 INFO - Running main action method: populate_webroot 08:21:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:48 INFO - '--tppagecycles', 08:21:48 INFO - '7'], 08:21:48 INFO - 'tests': ['tsvgm']}}, 08:21:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['damp', 'tps']}, 08:21:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['damp', 'tps']}, 08:21:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['dromaeo_dom']}, 08:21:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['basic_compositor_video']}, 08:21:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tsvgx', 08:21:48 INFO - 'tsvgr_opacity', 08:21:48 INFO - 'tart', 08:21:48 INFO - 'tscrollx', 08:21:48 INFO - 'cart']}, 08:21:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:48 INFO - 'tsvgr_opacity', 08:21:48 INFO - 'tart', 08:21:48 INFO - 'tscrollx', 08:21:48 INFO - 'cart']}, 08:21:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tp5o']}, 08:21:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['tp5o']}, 08:21:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s', 08:21:48 INFO - '--xperf_path', 08:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:48 INFO - 'tests': ['tp5n']}, 08:21:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--xperf_path', 08:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:48 INFO - 'tests': ['tp5n']}}, 08:21:48 INFO - 'talos.zip': {'path': '', 08:21:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:48 INFO - Running post-action listener: _resource_record_post_action 08:21:48 INFO - ##### 08:21:48 INFO - ##### Finished populate-webroot step (success) 08:21:48 INFO - ##### 08:21:48 INFO - ##### 08:21:48 INFO - ##### Running create-virtualenv step. 08:21:48 INFO - ##### 08:21:48 INFO - Running pre-action listener: _resource_record_pre_action 08:21:48 INFO - Running main action method: create_virtualenv 08:21:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:21:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:48 INFO - Using real prefix '/usr' 08:21:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:50 INFO - Installing pip.................done. 08:21:50 INFO - Return code: 0 08:21:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:50 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:50 INFO - Using env: {'DISPLAY': ':0', 08:21:50 INFO - 'HOME': '/home/cltbld', 08:21:50 INFO - 'LANG': 'en_US.UTF-8', 08:21:50 INFO - 'LANGUAGE': 'en_US:en', 08:21:50 INFO - 'LOGNAME': 'cltbld', 08:21:50 INFO - 'MAIL': '/var/mail/cltbld', 08:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:50 INFO - 'MOZ_NO_REMOTE': '1', 08:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:50 INFO - 'NO_EM_RESTART': '1', 08:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:50 INFO - 'PWD': '/builds/slave/test', 08:21:50 INFO - 'SHELL': '/bin/bash', 08:21:50 INFO - 'SHLVL': '1', 08:21:50 INFO - 'TERM': 'linux', 08:21:50 INFO - 'TMOUT': '86400', 08:21:50 INFO - 'USER': 'cltbld', 08:21:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:50 INFO - '_': '/tools/buildbot/bin/python'} 08:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:21:51 INFO - Cleaning up... 08:21:51 INFO - Return code: 0 08:21:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:51 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 08:21:51 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 08:21:51 INFO - Using env: {'DISPLAY': ':0', 08:21:51 INFO - 'HOME': '/home/cltbld', 08:21:51 INFO - 'LANG': 'en_US.UTF-8', 08:21:51 INFO - 'LANGUAGE': 'en_US:en', 08:21:51 INFO - 'LOGNAME': 'cltbld', 08:21:51 INFO - 'MAIL': '/var/mail/cltbld', 08:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:51 INFO - 'MOZ_NO_REMOTE': '1', 08:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:51 INFO - 'NO_EM_RESTART': '1', 08:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:51 INFO - 'PWD': '/builds/slave/test', 08:21:51 INFO - 'SHELL': '/bin/bash', 08:21:51 INFO - 'SHLVL': '1', 08:21:51 INFO - 'TERM': 'linux', 08:21:51 INFO - 'TMOUT': '86400', 08:21:51 INFO - 'USER': 'cltbld', 08:21:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:51 INFO - '_': '/tools/buildbot/bin/python'} 08:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:51 INFO - Downloading/unpacking psutil>=3.1.1 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:53 INFO - Installing collected packages: psutil 08:21:53 INFO - Running setup.py install for psutil 08:21:53 INFO - building 'psutil._psutil_linux' extension 08:21:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:21:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:21:53 INFO - building 'psutil._psutil_posix' extension 08:21:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:21:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:21:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:53 INFO - Successfully installed psutil 08:21:53 INFO - Cleaning up... 08:21:53 INFO - Return code: 0 08:21:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:53 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:53 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 08:21:53 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 08:21:53 INFO - Using env: {'DISPLAY': ':0', 08:21:53 INFO - 'HOME': '/home/cltbld', 08:21:53 INFO - 'LANG': 'en_US.UTF-8', 08:21:53 INFO - 'LANGUAGE': 'en_US:en', 08:21:53 INFO - 'LOGNAME': 'cltbld', 08:21:53 INFO - 'MAIL': '/var/mail/cltbld', 08:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:53 INFO - 'MOZ_NO_REMOTE': '1', 08:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:53 INFO - 'NO_EM_RESTART': '1', 08:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:53 INFO - 'PWD': '/builds/slave/test', 08:21:53 INFO - 'SHELL': '/bin/bash', 08:21:53 INFO - 'SHLVL': '1', 08:21:53 INFO - 'TERM': 'linux', 08:21:53 INFO - 'TMOUT': '86400', 08:21:53 INFO - 'USER': 'cltbld', 08:21:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:53 INFO - '_': '/tools/buildbot/bin/python'} 08:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:56 INFO - Installing collected packages: mozsystemmonitor 08:21:56 INFO - Running setup.py install for mozsystemmonitor 08:21:56 INFO - Successfully installed mozsystemmonitor 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:58 INFO - warning: no files found matching '*.txt' 08:21:58 INFO - no previously-included directories found matching 'build' 08:21:58 INFO - no previously-included directories found matching 'dist' 08:21:58 INFO - no previously-included directories found matching '.git*' 08:21:58 INFO - Installing collected packages: jsonschema, functools32 08:21:58 INFO - Running setup.py install for functools32 08:21:58 INFO - warning: no files found matching '*.txt' 08:21:58 INFO - no previously-included directories found matching 'build' 08:21:58 INFO - no previously-included directories found matching 'dist' 08:21:58 INFO - no previously-included directories found matching '.git*' 08:21:58 INFO - Successfully installed jsonschema functools32 08:21:58 INFO - Cleaning up... 08:21:58 INFO - Return code: 0 08:21:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:58 INFO - Using env: {'DISPLAY': ':0', 08:21:58 INFO - 'HOME': '/home/cltbld', 08:21:58 INFO - 'LANG': 'en_US.UTF-8', 08:21:58 INFO - 'LANGUAGE': 'en_US:en', 08:21:58 INFO - 'LOGNAME': 'cltbld', 08:21:58 INFO - 'MAIL': '/var/mail/cltbld', 08:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:58 INFO - 'MOZ_NO_REMOTE': '1', 08:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:58 INFO - 'NO_EM_RESTART': '1', 08:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:58 INFO - 'PWD': '/builds/slave/test', 08:21:58 INFO - 'SHELL': '/bin/bash', 08:21:58 INFO - 'SHLVL': '1', 08:21:58 INFO - 'TERM': 'linux', 08:21:58 INFO - 'TMOUT': '86400', 08:21:58 INFO - 'USER': 'cltbld', 08:21:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:58 INFO - '_': '/tools/buildbot/bin/python'} 08:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:01 INFO - Downloading docopt-0.6.1.tar.gz 08:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:01 INFO - Running setup.py install for blobuploader 08:22:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:01 INFO - Running setup.py install for requests 08:22:02 INFO - Running setup.py install for docopt 08:22:02 INFO - Successfully installed blobuploader requests docopt 08:22:02 INFO - Cleaning up... 08:22:02 INFO - Return code: 0 08:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:02 INFO - Using env: {'DISPLAY': ':0', 08:22:02 INFO - 'HOME': '/home/cltbld', 08:22:02 INFO - 'LANG': 'en_US.UTF-8', 08:22:02 INFO - 'LANGUAGE': 'en_US:en', 08:22:02 INFO - 'LOGNAME': 'cltbld', 08:22:02 INFO - 'MAIL': '/var/mail/cltbld', 08:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:02 INFO - 'MOZ_NO_REMOTE': '1', 08:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:02 INFO - 'NO_EM_RESTART': '1', 08:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:02 INFO - 'PWD': '/builds/slave/test', 08:22:02 INFO - 'SHELL': '/bin/bash', 08:22:02 INFO - 'SHLVL': '1', 08:22:02 INFO - 'TERM': 'linux', 08:22:02 INFO - 'TMOUT': '86400', 08:22:02 INFO - 'USER': 'cltbld', 08:22:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:02 INFO - '_': '/tools/buildbot/bin/python'} 08:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:02 INFO - Running setup.py (path:/tmp/pip-NJE75t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:02 INFO - Running setup.py (path:/tmp/pip-fUnm9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:02 INFO - Running setup.py (path:/tmp/pip-S95U2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:02 INFO - Running setup.py (path:/tmp/pip-YjMJXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:02 INFO - Running setup.py (path:/tmp/pip-t7193o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:02 INFO - Running setup.py (path:/tmp/pip-aBh16l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:02 INFO - Running setup.py (path:/tmp/pip-CLVBug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:02 INFO - Running setup.py (path:/tmp/pip-lDslXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:02 INFO - Running setup.py (path:/tmp/pip-gkCA9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:03 INFO - Running setup.py (path:/tmp/pip-Yx8_im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:03 INFO - Running setup.py (path:/tmp/pip-88kcTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:03 INFO - Running setup.py (path:/tmp/pip-G14yNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:03 INFO - Running setup.py (path:/tmp/pip-UBRraq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:03 INFO - Running setup.py (path:/tmp/pip-55ZgKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:03 INFO - Running setup.py (path:/tmp/pip-HKUc_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:03 INFO - Running setup.py (path:/tmp/pip-tDTtKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:03 INFO - Running setup.py (path:/tmp/pip-IxhOO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:03 INFO - Running setup.py install for manifestparser 08:22:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:03 INFO - Running setup.py install for mozcrash 08:22:03 INFO - Running setup.py install for mozdebug 08:22:03 INFO - Running setup.py install for mozdevice 08:22:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozfile 08:22:04 INFO - Running setup.py install for mozhttpd 08:22:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozinfo 08:22:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozInstall 08:22:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozleak 08:22:04 INFO - Running setup.py install for mozlog 08:22:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for moznetwork 08:22:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozprocess 08:22:04 INFO - Running setup.py install for mozprofile 08:22:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:04 INFO - Running setup.py install for mozrunner 08:22:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:05 INFO - Running setup.py install for mozscreenshot 08:22:05 INFO - Running setup.py install for moztest 08:22:05 INFO - Running setup.py install for mozversion 08:22:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:05 INFO - Cleaning up... 08:22:05 INFO - Return code: 0 08:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:05 INFO - Using env: {'DISPLAY': ':0', 08:22:05 INFO - 'HOME': '/home/cltbld', 08:22:05 INFO - 'LANG': 'en_US.UTF-8', 08:22:05 INFO - 'LANGUAGE': 'en_US:en', 08:22:05 INFO - 'LOGNAME': 'cltbld', 08:22:05 INFO - 'MAIL': '/var/mail/cltbld', 08:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:05 INFO - 'MOZ_NO_REMOTE': '1', 08:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:05 INFO - 'NO_EM_RESTART': '1', 08:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:05 INFO - 'PWD': '/builds/slave/test', 08:22:05 INFO - 'SHELL': '/bin/bash', 08:22:05 INFO - 'SHLVL': '1', 08:22:05 INFO - 'TERM': 'linux', 08:22:05 INFO - 'TMOUT': '86400', 08:22:05 INFO - 'USER': 'cltbld', 08:22:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:05 INFO - '_': '/tools/buildbot/bin/python'} 08:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:05 INFO - Running setup.py (path:/tmp/pip-BMyYaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:05 INFO - Running setup.py (path:/tmp/pip-cGD6tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:05 INFO - Running setup.py (path:/tmp/pip-UdrXK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:05 INFO - Running setup.py (path:/tmp/pip-wIpJGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:05 INFO - Running setup.py (path:/tmp/pip-ziNMfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:05 INFO - Running setup.py (path:/tmp/pip-BHCnUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:06 INFO - Running setup.py (path:/tmp/pip-pQH0Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:06 INFO - Running setup.py (path:/tmp/pip-t7w4Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:06 INFO - Running setup.py (path:/tmp/pip-ONLsPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:06 INFO - Running setup.py (path:/tmp/pip-eC5tc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:06 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)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:06 INFO - Running setup.py (path:/tmp/pip-p65KFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:06 INFO - Running setup.py (path:/tmp/pip-eVbOzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:06 INFO - Running setup.py (path:/tmp/pip-JiJGQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:06 INFO - Running setup.py (path:/tmp/pip-Id5Qhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:06 INFO - Running setup.py (path:/tmp/pip-aEhypd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:06 INFO - Running setup.py (path:/tmp/pip-T4XiHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:07 INFO - Running setup.py (path:/tmp/pip-2X2UcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:09 INFO - Downloading blessings-1.6.tar.gz 08:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:09 INFO - Installing collected packages: blessings 08:22:09 INFO - Running setup.py install for blessings 08:22:09 INFO - Successfully installed blessings 08:22:09 INFO - Cleaning up... 08:22:09 INFO - Return code: 0 08:22:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:09 INFO - Reading from file tmpfile_stdout 08:22:09 INFO - Current package versions: 08:22:09 INFO - argparse == 1.2.1 08:22:09 INFO - blessings == 1.6 08:22:09 INFO - blobuploader == 1.2.4 08:22:09 INFO - docopt == 0.6.1 08:22:09 INFO - functools32 == 3.2.3-2 08:22:09 INFO - jsonschema == 2.5.1 08:22:09 INFO - manifestparser == 1.1 08:22:09 INFO - mozInstall == 1.12 08:22:09 INFO - mozcrash == 0.17 08:22:09 INFO - mozdebug == 0.1 08:22:09 INFO - mozdevice == 0.48 08:22:09 INFO - mozfile == 1.2 08:22:09 INFO - mozhttpd == 0.7 08:22:09 INFO - mozinfo == 0.9 08:22:09 INFO - mozleak == 0.1 08:22:09 INFO - mozlog == 3.2 08:22:09 INFO - moznetwork == 0.27 08:22:09 INFO - mozprocess == 0.22 08:22:09 INFO - mozprofile == 0.28 08:22:09 INFO - mozrunner == 6.11 08:22:09 INFO - mozscreenshot == 0.1 08:22:09 INFO - mozsystemmonitor == 0.3 08:22:09 INFO - moztest == 0.7 08:22:09 INFO - mozversion == 1.4 08:22:09 INFO - psutil == 3.1.1 08:22:09 INFO - requests == 1.2.3 08:22:09 INFO - wsgiref == 0.1.2 08:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:09 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 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:09 INFO - Using env: {'DISPLAY': ':0', 08:22:09 INFO - 'HOME': '/home/cltbld', 08:22:09 INFO - 'LANG': 'en_US.UTF-8', 08:22:09 INFO - 'LANGUAGE': 'en_US:en', 08:22:09 INFO - 'LOGNAME': 'cltbld', 08:22:09 INFO - 'MAIL': '/var/mail/cltbld', 08:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:09 INFO - 'MOZ_NO_REMOTE': '1', 08:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:09 INFO - 'NO_EM_RESTART': '1', 08:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:09 INFO - 'PWD': '/builds/slave/test', 08:22:09 INFO - 'SHELL': '/bin/bash', 08:22:09 INFO - 'SHLVL': '1', 08:22:09 INFO - 'TERM': 'linux', 08:22:09 INFO - 'TMOUT': '86400', 08:22:09 INFO - 'USER': 'cltbld', 08:22:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:09 INFO - '_': '/tools/buildbot/bin/python'} 08:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:10 INFO - Cleaning up... 08:22:10 INFO - Return code: 0 08:22:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:22:10 INFO - Using env: {'DISPLAY': ':0', 08:22:10 INFO - 'HOME': '/home/cltbld', 08:22:10 INFO - 'LANG': 'en_US.UTF-8', 08:22:10 INFO - 'LANGUAGE': 'en_US:en', 08:22:10 INFO - 'LOGNAME': 'cltbld', 08:22:10 INFO - 'MAIL': '/var/mail/cltbld', 08:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:10 INFO - 'MOZ_NO_REMOTE': '1', 08:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:10 INFO - 'NO_EM_RESTART': '1', 08:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:10 INFO - 'PWD': '/builds/slave/test', 08:22:10 INFO - 'SHELL': '/bin/bash', 08:22:10 INFO - 'SHLVL': '1', 08:22:10 INFO - 'TERM': 'linux', 08:22:10 INFO - 'TMOUT': '86400', 08:22:10 INFO - 'USER': 'cltbld', 08:22:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:10 INFO - '_': '/tools/buildbot/bin/python'} 08:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:10 INFO - Cleaning up... 08:22:10 INFO - Return code: 0 08:22:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd173725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2663190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, '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': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:22:10 INFO - Using env: {'DISPLAY': ':0', 08:22:10 INFO - 'HOME': '/home/cltbld', 08:22:10 INFO - 'LANG': 'en_US.UTF-8', 08:22:10 INFO - 'LANGUAGE': 'en_US:en', 08:22:10 INFO - 'LOGNAME': 'cltbld', 08:22:10 INFO - 'MAIL': '/var/mail/cltbld', 08:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:10 INFO - 'MOZ_NO_REMOTE': '1', 08:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:10 INFO - 'NO_EM_RESTART': '1', 08:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:10 INFO - 'PWD': '/builds/slave/test', 08:22:10 INFO - 'SHELL': '/bin/bash', 08:22:10 INFO - 'SHLVL': '1', 08:22:10 INFO - 'TERM': 'linux', 08:22:10 INFO - 'TMOUT': '86400', 08:22:10 INFO - 'USER': 'cltbld', 08:22:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:10 INFO - '_': '/tools/buildbot/bin/python'} 08:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:10 INFO - Downloading/unpacking flake8 08:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:22:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:22:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:13 INFO - no previously-included directories found matching 'docs/_build' 08:22:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:22:13 INFO - Running setup.py install for pep8 08:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:14 INFO - no previously-included directories found matching 'docs/_build' 08:22:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:22:14 INFO - Cleaning up... 08:22:16 INFO - Return code: 0 08:22:16 INFO - Running post-action listener: _resource_record_post_action 08:22:16 INFO - Running post-action listener: _start_resource_monitoring 08:22:16 INFO - Starting resource monitoring. 08:22:16 INFO - ##### 08:22:16 INFO - ##### Finished create-virtualenv step (success) 08:22:16 INFO - ##### 08:22:16 INFO - ##### 08:22:16 INFO - ##### Running install step. 08:22:16 INFO - ##### 08:22:16 INFO - Running pre-action listener: _resource_record_pre_action 08:22:16 INFO - Running main action method: install 08:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:16 INFO - Reading from file tmpfile_stdout 08:22:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:16 INFO - Reading from file tmpfile_stdout 08:22:16 INFO - Output received: 08:22:16 INFO - Usage: mozinstall [options] installer 08:22:16 INFO - Options: 08:22:16 INFO - -h, --help show this help message and exit 08:22:16 INFO - -d DEST, --destination=DEST 08:22:16 INFO - Directory to install application into. [default: 08:22:16 INFO - "/builds/slave/test"] 08:22:16 INFO - --app=APP Application being installed. [default: firefox] 08:22:16 INFO - mkdir: /builds/slave/test/build/application 08:22:16 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'] 08:22:16 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 08:22:37 INFO - Reading from file tmpfile_stdout 08:22:37 INFO - Output received: 08:22:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:37 INFO - Running post-action listener: _resource_record_post_action 08:22:37 INFO - ##### 08:22:37 INFO - ##### Finished install step (success) 08:22:37 INFO - ##### 08:22:37 INFO - ##### 08:22:37 INFO - ##### Running run-tests step. 08:22:37 INFO - ##### 08:22:37 INFO - Running pre-action listener: _resource_record_pre_action 08:22:37 INFO - Running main action method: run_tests 08:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:37 INFO - Python 2.7.3 08:22:37 INFO - Return code: 0 08:22:37 INFO - grabbing minidump binary from tooltool 08:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:37 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 0x26f5110>, '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 0x2661230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26616c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:22:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:22:37 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 08:22:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:38 INFO - Return code: 0 08:22:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:38 INFO - Return code: 0 08:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:22:38 INFO - Using env: {'DISPLAY': ':0', 08:22:38 INFO - 'HOME': '/home/cltbld', 08:22:38 INFO - 'LANG': 'en_US.UTF-8', 08:22:38 INFO - 'LANGUAGE': 'en_US:en', 08:22:38 INFO - 'LOGNAME': 'cltbld', 08:22:38 INFO - 'MAIL': '/var/mail/cltbld', 08:22:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:38 INFO - 'MOZ_NO_REMOTE': '1', 08:22:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:38 INFO - 'NO_EM_RESTART': '1', 08:22:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:38 INFO - 'PWD': '/builds/slave/test', 08:22:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:38 INFO - 'SHELL': '/bin/bash', 08:22:38 INFO - 'SHLVL': '1', 08:22:38 INFO - 'TERM': 'linux', 08:22:38 INFO - 'TMOUT': '86400', 08:22:38 INFO - 'USER': 'cltbld', 08:22:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145', 08:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:38 INFO - '_': '/tools/buildbot/bin/python'} 08:22:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:22:39 INFO - mozversion application_buildid: 20160614053033 08:22:39 INFO - mozversion application_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 08:22:39 INFO - mozversion application_display_name: Nightly 08:22:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:39 INFO - mozversion application_name: Firefox 08:22:39 INFO - mozversion application_remotingname: firefox 08:22:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:39 INFO - mozversion application_vendor: Mozilla 08:22:39 INFO - mozversion application_version: 50.0a1 08:22:39 INFO - mozversion platform_buildid: 20160614053033 08:22:39 INFO - mozversion platform_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 08:22:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:39 INFO - mozversion platform_version: 50.0a1 08:22:39 INFO - using testdate: 1465917759 08:22:39 INFO - actual date: 1465917759 08:22:39 INFO - starting webserver on 'localhost:51798' 08:22:39 INFO - SUITE-START | Running 2 tests 08:22:39 INFO - TEST-START | dromaeo_css 08:22:39 INFO - operating with platform_type : linux_ 08:22:39 INFO - Initialising browser for dromaeo_css test... 08:22:39 INFO - TEST-INFO | started process 17103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeQU5F3/profile http://localhost:51798/getInfo.html) 08:22:46 INFO - PROCESS | 17103 | __metrics Screen width/height:1600/1200 08:22:46 INFO - PROCESS | 17103 | colorDepth:24 08:22:46 INFO - PROCESS | 17103 | Browser inner width/height: 1024/697 08:22:46 INFO - PROCESS | 17103 | __metrics 08:22:48 ERROR - PROCESS | 17103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:22:49 INFO - TEST-INFO | 17103: exit 0 08:22:49 INFO - Browser initialized. 08:22:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:49 INFO - TEST-INFO | started process 17230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeQU5F3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:01 INFO - PROCESS | 17230 | RSS: Main: 184786944 08:23:01 INFO - PROCESS | 17230 | 08:23:51 INFO - PROCESS | 17230 | 1465917831511 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:26:02 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51798/tests/dromaeo/cssquery-ext.html) 08:26:03 INFO - PROCESS | 17230 | RSS: Main: 188723200 08:26:03 INFO - PROCESS | 17230 | 08:29:06 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-ext.html (next: http://localhost:51798/tests/dromaeo/cssquery-jquery.html) 08:29:06 INFO - PROCESS | 17230 | RSS: Main: 187547648 08:29:06 INFO - PROCESS | 17230 | 08:32:08 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51798/tests/dromaeo/cssquery-mootools.html) 08:32:09 INFO - PROCESS | 17230 | RSS: Main: 189239296 08:32:09 INFO - PROCESS | 17230 | 08:35:10 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51798/tests/dromaeo/cssquery-prototype.html) 08:35:11 INFO - PROCESS | 17230 | RSS: Main: 186904576 08:35:11 INFO - PROCESS | 17230 | 08:38:13 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51798/tests/dromaeo/cssquery-yui.html) 08:38:14 INFO - PROCESS | 17230 | RSS: Main: 188538880 08:38:14 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:51798/tests/dromaeo/cssquery-yui.html (next: http://localhost:51798/tests/dromaeo/cssquery-dojo.html) 08:41:17 INFO - PROCESS | 17230 | RSS: Main: 189829120 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | __start_tp_report 08:41:17 INFO - PROCESS | 17230 | _x_x_mozilla_page_load 08:41:17 INFO - PROCESS | 17230 | _x_x_mozilla_page_load_details 08:41:17 INFO - PROCESS | 17230 | |i|pagename|runs| 08:41:17 INFO - PROCESS | 17230 | |0;dojo.html;3113.1750086227166;3131.467650499415;3139.199504126447;3141.230398552355;3148.858301376438;5422.53908417785;5453.590980676446;5464.535514481274;5504.779808807642;5524.364698059724;5269.736513174345;5475.069238229501;5485.396606373296;5514.393416724157;5599.188117722928;4933.777979990909;4971.130052240862;4989.800407983676;5051.974740126294;5062.367204099488;4870.902581948359;4882.731449770261;4886.413630364344;4938.7530623468865;4938.975305123469;4893.951060489385;4907.190313598252;4907.8773030674165;4986.326845875833;5031.597472202215;4958.429780575208;4961.751912404366;4977.576905962997;4979.10376132296;5030.245463180552;4884.267359896008;4892.779824907852;4906.994066216417;4925.704457732548;4932.235503496964;5518.089515230023;5526.58550608706;5533.08704063829;5557.6109672322955;5600.663960162403;5716.314042314907;5768.509676677488;5845.152452894349;5870.501007414375;5891.528677705774;5859.384764599698;5902.763889444417;5907.054871220584;5908.231929849135;5940.435658612468;5436.53789427903;5485.314335708036;5518.586106042023;5522.757379589641;5525.917111243334;5910.734016969161;6005.3694362091355;6012.879742405127;6028.969855150696;6033.849153771103;5808.564357673192;5821.650700957956;5827.941720582825;5834.095715164156;5859.150423188699;5748.425157484218;5803.593748437569;5807;5862.970685146547;5871.618344807659;5774.451427114417;5817.272840894888;5880.647161170344;5882.676452795137;5937.821865344046;5895.20414744004;5953.672548009901;5958.970205148947;5986.970065149646;5993.580449368589;4450.910981780346;4477.126960242721;4499.212637788374;4503.459584849839;4536.092781443725;3979.5423526294267;4019.2363450944226;4030.6976976726864;4072.857449989295;4082.9591704083173;5493.121100623881;5630.296212973379;5646.463585959327;5658.632188907708;5667.008273552195;5819.621724587888;5893.263342082239;5914.58597898143;5936.198613187251;5953.434423729739;5627.831165065055;5629.915551266734;5630.183623374588;5634.295713035871;5658.575606829422;4834.5890599299455;4902.117618828645;4923.8276660316715;4952.306677065214;4985.1276026695905;5960.791372301948;6011.789587364421;6066.181065556182;6068.21113255274;6120.1737765401995;5903.734331954986;5911.142884281841;5913.940860591339;5929.555283353852;5932.79235226765;5961.105834124916;6055.091736239599;6069.180660610761;6103.6032657877095;6117.908231376444;5829.679367634821;5859.882802343844;5859.882802343844;5880.382559831327;5907.409259074058;5843.532517398513;5903.173555702119;5934.703264836655;5966.940330596639;5971.402859713994;5625.8593535161945;5696.060150075357;5727.5417966561745;5761.251037365116;5791.623544469596;5653.632513886584;5657.8684263146715;5702.714864256687;5775.971120144372;5776.855578610568;5654.095344744821;5654.943450565442;5659.405762394889;5680.77276908919;5691.430856914276;5711.942880571141;5754.4533269339345;5767.423257674367;5810.477057064884;5834.824955251349;5616.073347897551;5659.236003139524;5705.429457054262;5710.657360558213;5716.885662286648 08:41:17 INFO - PROCESS | 17230 | |1;ext.html;549.4972100528017;601.8465291350707;615.7721642992094;616.1497133955143;647.9935200647992;38425.42361864574;41903.790481047625;42042.159156816844;42105.36841947373;42108.57891421085;42529;42798.572014279845;42857.14285714284;42901.78549107258;42927.78536107323;8682.30541556674;8816.074312197223;8851.468911865277;8912.509811960339;8914.732558023237;8860.8670869937;8870.42342247752;8882.511461869595;8897.065808090154;8909.153630405133;8908.376413651047;8997.910020899806;9016.77458063547;9018.233450156744;9026.097390260988;8768.473891566495;8864.423812452202;8866.202041816268;8886.955565222197;8929.33030022751;8737.082606326308;8801.911980880173;8814.382993190478;8839.16027977341;8842.867356989651;40645.390319145234;40719.35324203947;40987.180256395004;40990.180196396206;41057.38413923793;3593.2274560969254;3692.538432695913;3711.5175027246555;3766.4162054881535;4225.767582782945;32150.713971441113;32276.354472910643;32382.6761732382;32784.50823237653;34089.31821363559;4288.721233119868;4430.180416622935;4469.687121901468;4519.706219095749;4612.654050946193;316121;321483;322546;323177;323634;60770;61084;61100.694496527234;61211.69394153001;61311.38688613057;37135;37711;38235.044123897125;39691.80154099269;39962.20075598472;16484.83515164857;16844.494665160066;16887.408940687015;16946.830531694774;17093.658126837392;12719.300438475973;12739.235645861278;12840.165389249669;12845.678858028625;12905.09664323507;19326.903365483082;19521.529193097525;19780.802191978182;19848.40454786359;19902;7440.3675687567165;7453.701851925971;7526.736564220226;7648.80877978055;7869.685212591432;940.238406890421;1070.3310430980637;1070.9625163119254;1097.3964319624174;1101.730076131353;32511.837440812644;32939.341213175605;33062.403506150324;33498.33003339968;33652.83173584165;1089.0742868561817;1132.694172573417;1152.567787079845;1186.0096819156101;1216.871299717893;15978.280977355815;16474.588135296475;16520.339186432648;16524.504264872074;16836.915815420845;530415;533388;536115;537182;537720;58246.70876645589;59337.406625934054;59378.703106484194;59396.109058364156;59445.108323375185;1360.4422935738523;1374.6632075141654;1391.8608139186001;1408.3521580073282;1408.7816388459805;28731.569026465037;28843.5673464894;28861.711382885904;29487.26281842885;29829.850850746476;52050;52538;52676.20985685141;52839;52932.73533632307;447285;449371;451269;451498;452232;29521;29525;30093.09720708382;30206.54690179693;30316.484175791564;49578;49756.75121624369;50105;50106.49893501018;50953.490465094874;41661.37507937444;42195.78902105593;42306;42335.7883210582;43763.78118109389;41387.1722565541;41881.581184187766;41963;42053.78973105115;42099.7895010523;40329.596704032585;40734;42301;42324;42426.78786606047;35145.29709405747;37259.44110838394;37739.62260377471;38069.619303806605;38197;27953.580696289166;28114.250492115778;28120.71879281181;28319;28434.57348139821 08:41:17 INFO - PROCESS | 17230 | |2;jquery.html;412.5523806669763;413.62773503846535;418.6169654765889;422.1240925080458;434.4873049801233;18415.631687366244;19139.99999999998;20018.599628007432;20388.388348349537;20419.183232670675;18671.159797809098;18729.34447294345;19351.419457416265;19684.11421486033;19706.901465492654;5635.859103522414;5705.400932902048;5838.7080645967535;5863.76544938202;5875.383084776101;4052.9392059119136;5612.7754889804355;5684.630499017571;6116.174316467287;6450.6452145132;6461.483081353481;6477.060826180201;6483.740650373979;6490.967545162292;6506.251781045169;6307.495400367982;6397.52018598607;6404.839879003039;6462.935370646281;6515.153030106103;5660.264165658438;5725.398833122504;5734.885302293973;5747.683877386742;5825.9417405825825;23298.65052024221;23850.642240366407;24137.517249655084;24330.27009189727;24423.87788061066;2409.8433601815827;2466.3587467258462;2505.260948020338;2764.543850264704;3207.23026473647;13493;14559.78160327596;15055.171965541891;15094.471693490785;15306.08163510193;1960.372680742163;1994.8204661580382;1999.6000799839944;2006.7591888973416;2041.9693704594442;84732.57633711853;86181.56909215476;86256.13743862607;87319.69020464762;88385.11614883834;11270.661880143609;11347.092232621371;11565.479553420117;11711.063114950783;12063.698407539881;16071.839281607268;16180.838191618168;16239.51281461558;16303.429379971643;16374.426895058616;8019.558924259105;8344.874826877602;8356.749297521084;8487.321014318839;8537.871931921027;7844.450888437755;7925.167857375008;7948.761537153895;7980;8217.506949583045;4953.2074868020945;5055.09008378488;5108.693478391308;5127.64106512548;5161.148410512298;1731.7229243321008;1854.1285595769966;1870;1896.3931541906456;2091.257603550748;970.1317320997667;982.823091843475;1022.3661329975463;1059.2267644619471;1075.7902209069314;19280.132394042303;19513.414597562096;19854.70217946732;19945.800541994686;20180.89909550443;981;986.3982970388057;1002.1932344462632;1043.796459690353;1067.3489171605315;9794.216462682969;10488.160947124212;10980.670579882617;11194.944025279985;11232.775344493228;424341;426409;432276;437256;440429;57858.132128018115;78109.60945195351;91744;94010.52994734983;94364;959.7504648791364;993.0665174735725;999.3204620857741;999.4602914426129;1004.1264100232844;16864.915675421544;16910;16994.320227190772;17243.224054917308;17594;40902.386464202464;41807.790961045;42574.78712606417;42877.57122428861;42938.78530607327;60812.695936521806;61178.69410652918;63187;63301;63334.04998925112;8869.005650503066;9202.309826762885;9203.953980230055;9276.58255378523;9479.336446448682;11596.94201528987;13217.206967581591;13301.800472993107;13348.065635405428;14177.432902683777;11864;12014.279143251433;12048.698782530508;12122.393880306126;12177.878221217674;11749.236299640495;11886.75317465837;12135.817962730389;12339.814902776287;12399.75200496003;12098.697532561757;12117.454714538044;12293.385330733248;12297.56958506448;12531.373431328215;9060.773480662772;9165.129312715282;9203.585838637144;9355.158035776813;9384.95307523458;11777.52889884395;11870.821937671115;11963.76072478563;12290.81563776562;12393.62819115428 08:41:17 INFO - PROCESS | 17230 | |3;mootools.html;1514.6894886548255;1519.1568679382942;1694.8644108471324;1798.6043070524488;1803.4499477659308;8338.541380224086;8921.241694455972;9086.954565227164;9626.614935402575;9642.710718678441;9456.05439456054;9520.809583808319;9583.856242156373;9586.233101351892;9620.182284505809;2483.937901552458;2504.211173480348;2515.4843257132334;2518.2948774343213;2518.4837108392826;2404.987975060131;2444.1201167579657;2444.4622183119773;2448.302233863349;2453.619688948207;2439.2072576412647;2446.902123915041;2537.8350407223566;2540.872956352175;2550.9744902550924;2433.610622300432;2434.513097380522;2463.802895768343;2493.8379005364773;2501.1996161228412;2380.6191009438407;2389.952200955971;2391.976080239193;2400.135951057618;2433.3794882305074;9468.337216394855;9565.617375304979;9589.280803939733;9601.663941762075;9652.372595781251;5544.279243698334;5698.458646428583;5720.456556627114;5727.11229759388;5732.0255556555485;3381.340638575479;3476.687098161178;3533.6819686228105;3541.327147841902;3611.277744451094;1085.066842515436;1107.7839821234863;1137.8122609769462;1145.9025982791472;1166.9941650291694;13384.531541396005;13438.46246150153;13499.730005399935;13506.392212350369;13520.661983450394;4949.133901567211;4965.230389289666;5036.169032109734;5107.055194788976;5111.7699703513435;11054.889451105546;11072.612458563912;11127.554897803997;11130;11136.498857551429;5531.363893152258;5534.252875861787;5535.142052981794;5540.418256083134;5543.7782488700805;4576.931346029813;4973.726445045485;5056.924146137811;5102.209157580581;5106.591472682251;4261.936070958938;4279.272523670983;4309.504406993173;4341.630961368319;4437.2234858899565;1318.7098838255567;1376.8967327450482;1376.9105008174436;1386.9791953120712;1394.8186735724494;932.7015355086443;970.6117552978865;976.3653625143713;985.8324084905584;991.1257353674258;6079.574429789872;6096.573239873255;6156.168917196122;6172.7532993505965;6180.381961803783;485.5387381987126;486.9853904382874;494.8416506717888;497.51492295012076;498.536361184095;4073.816678249486;4165.291900376943;4260.765657888845;4302.44068271129;4310.288802347577;11291.153163512769;11651.76696466066;11802.94098529519;11872.34702091376;11892.405379730979;11281;11630.127740419333;11698.239614425034;11704.590339338252;12090.395480225954;8787.560621968876;8863.601137948808;8920;8923.107689231025;8925.642974280956;6035.714642603625;6278.6546739929745;6312.810615681537;6352.936470635234;6414.230292364946;10692.946535267274;10817.945910270399;11008.39453830047;11051.944740276247;11183.944080279873;11110.277831940897;11129.165312601426;11163.776724465302;11286.717832054264;11300.7739845201;7185.137783465809;8111.432199745961;8244.711435099744;8318.168183181875;8351.24838764514;9352.812943740952;9372.906270937203;9400.764980875532;9450.669226577036;9469.337146399686;8066.83866322682;8431.662733490592;8454.873176902474;8540.957295213484;8562.357823163164;7993.160718124514;8176.877346839683;8227.177282271725;8239.711610093858;8280.254777070093;7060.399866011447;7289.380402665833;7305.853882922418;7309.963450182715;7336.229695881855;5015.6990580563825;5138.486151384832;5147.099257629825;5187.066328060985;5214.713190774544;5335.1730481775385;5338.75975581092;5342.572594192533;5359.115745901882;5439.238506608999 08:41:17 INFO - PROCESS | 17230 | |4;prototype.html;341.8427523339264;345.0855233630878;350.9929801403972;359.3908325388468;361.6311362410343;5470.507654311111;5668.801591944282;5671.886562268752;5699.857503562418;5780.190773291737;5599.8600034999145;5673.716314184295;5681.431856814316;5697.772089116441;5714.714264286779;4431.778411079449;4432.911341773162;4448.310511870665;4460.553944605538;4465.620422264112;4149.585041495857;4385.2106620808245;4402.449693788277;4405.2511073117485;4416;4322.07075478772;4324.567543245666;4329.718568293067;4340.9798697306105;4374.387585737999;4339.327404252346;4350.564943505671;4362.323839804803;4367.628751556122;4376.890577735582;3790.4124860646643;3841.1741475582603;3844.942325865114;3881.9611803882162;3887.3974533947285;5493.708978390076;5542.5565954723525;5587.3015873015875;5604.719764011824;5610.607257491936;4910.337104490919;4999.9500004999845;5023.472535383768;5031.84904452867;5050.772715227824;5724.797792463588;5969.970150149222;5972.193753843219;5991.221141251653;5991.55063370249;4235.661147108224;4258.276093064155;4260;4260.659147268211;4262.680298977589;6220;6229.97525804111;6232.9376706232815;6235.908715974686;6239.469645080174;4274.294741367702;4315.6763242756915;4352.608265256142;4354.303311470149;4373.650107991353;4377.446006667651;4388.363687265329;4410.33844923264;4426.070525189682;4427.667924905581;5022.171341728647;5025.673331233531;5028.371453568304;5037.5214354636255;5055.837157453806;5902.406350285485;5939.46544810969;5986.640801551921;5992.610480318765;6000.5799594028;1513.8940274180923;1520.657851983295;1528.1824224040085;1539.4919676506727;1539.8229203641724;924.0851556958563;934.7663084228943;947.4599478297442;965.2567523007245;988.7393573194234;4969.90060198794;5012;5056.443791182967;5069.898602028013;5082.085224659597;5352.5450336721815;5368.114261146945;5370.812021579226;5394.946050539523;5396.811111611075;5066.442691303953;5070.340855688811;5089.142463001052;5298.311219541435;5790.449907258803;3207.5188721691934;3211.9678803212137;3246.935061298761;3247.3342964692183;3250.3011852451837;6036.673612803462;6348.619082855043;6367.936320636827;6376.39424254695;6429.935700643027;6271.905921411182;6275.843103922347;6293.402126797947;6303.558750887486;6322.241331040304;6297.433231009231;6314.273858506239;6319.8308312962245;6323.683815809283;6359.141515895295;5846;6020.638761674313;6074.331823499323;6100.23747031621;6113.327533971171;5986.910196347146;6051.33435322123;6074.331823499323;6079.635221886524;6094.878102437838;6177.320494745664;6322.747090116344;6331.810045698637;6389.233292004989;6443.484521238383;4358.520562738159;4378.781060947003;4400.207962566768;4404.581564751344;4405.052913623458;6260.5270917988055;6266.587363864854;6268.996960486483;6284.183056202664;6320.336364681642;5688.374278829243;5949.345571986992;6025.78909738157;6045.546584006129;6082.11809287642;5956.13636022783;5987.910181347196;6000.759969601167;6030.698465076816;6036.728347224298;5718.456746609066;5899;5923.7926672566255;5924.763009479745;5981.833542459179;5944.554158438048;5999.370066143167;6001.3698561652145;6027.457528822427;6078.878422431615;5870.853228669317;5890.4698577128265;5909.852253693692;5911.320198177093;5933.2880054393745 08:41:17 INFO - PROCESS | 17230 | |5;yui.html;722.801229661843;786.9409794265432;808.9838203235931;828.9461185022973;839.7438781171741;15786.605334866634;16495.505134845946;16663.75004374934;16743;17035.148242587882;14129.717405651882;14236.359363828627;14270.500532481365;14277.50028748994;14299;671.6272468779825;802.2899733735657;810.8702607582788;818.7625588579334;820.8112134209135;823.9423240373176;830.2361827119034;831.3889291370838;832.0556168748453;832.1886160993043;859.8065435277075;862.1938487514194;862.409249663979;863.7322430046675;864.4035615425337;860.8751730999002;862.0904945282724;862.6420035685214;862.8921384826897;865.2991077227402;628.8490762217081;629.1852051593198;630.7004173017825;632.3549979021373;633.5090305013605;16071.839281607152;16248.83751162485;16396.918015409967;16398.344066237336;16411.753823692656;13592.456301747918;13734.725305493834;13785.172889626654;14421.927890360586;15814.446494372756;13354.599362019155;13476.595702128952;13716.382762775698;13719.314034298246;13899.096558723752;4471.686981911267;4526.3210518422175;4590.862274131781;4594.150082234797;4637.489876113625;71271.78246651411;80882;81868.59065704633;82637.17362826415;82846;11537.826932596017;11661.53353865836;11701.122415818847;12073.57742479009;12076.516939322504;21108.78891211099;21141.365759027252;21177.364679059654;21182.576348473252;21217.78782212189;7959.761207163794;8030.558319292495;8180.9181908181345;8295.253427191581;8656.22094011542;4496.258117410656;4509.616682581952;4515.774211289422;4516.503184649686;4555;3485.9302813944087;3545.804980726085;3565.23347480293;3570.250247448065;3752.887413377603;674.5312008154285;677.8712044711588;694.2398074108944;695.8295217671601;705.5590256089944;628.6542401679059;634.0900807341387;736.2159300345115;736.8194792275926;760.5740785160328;10410.947945260225;10504.264701470976;10584.947075264728;10664.840027399596;10898.12814974816;665.3413121010165;746.1270313732946;756.8221467955026;757.9696812127563;762.4624639629048;5114.846554603293;5202.323697919246;5291.206319052096;5299.894002119936;5320.228566857784;74345.87813620115;130082.09753707403;131102;131437;134535.32732336276;110927;112077.43961280142;112797;113456.43271783588;115352;79298.6035069821;95107.99999999862;98300.50849745849;98735;103612;9696.321257511907;9915;9944.701658949954;10013.148882345082;10013.949930250303;55621.72189139028;56126.43873561375;56530.717346413;56884.715576421855;59648.70175649094;50097.74951125221;81801;82194;82431.58784206041;83654;11901.464434100313;12045.518179273082;12535.623931282076;13004.154729942524;13243.07298489135;14078.225697586731;14664.486742963945;14672.413103475741;14773.556793296219;14794.260286985824;12819.166754161322;13343.599692009255;13422.530211442552;13687.675216484295;13965.371558280105;12698.555550555686;12809.167404118702;13239.933800330937;13819.585412437644;13990.510332138327;13530.120542164728;13543;13749.656258593215;13809.171449712647;14242.145471271757;10897.78204435891;11168.553257869595;11229.21395502307;11297.43512824339;11393.316401015965;10357.75706915175;11249.325040497597;11464.25482343645;11507.367094809866;11613.245139065933 08:41:17 INFO - PROCESS | 17230 | __end_tp_report 08:41:17 INFO - PROCESS | 17230 | __start_cc_report 08:41:17 INFO - PROCESS | 17230 | _x_x_mozilla_cycle_collect,357 08:41:17 INFO - PROCESS | 17230 | __end_cc_report 08:41:17 INFO - PROCESS | 17230 | __startTimestamp1465918877469__endTimestamp 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | ------- Summary: start ------- 08:41:17 INFO - PROCESS | 17230 | Number of tests: 6 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#0] dojo.html Cycles:165 Average:5455.56 Median:5667.01 stddev:634.64 (11.2%) stddev-sans-first:609.40 08:41:17 INFO - PROCESS | 17230 | Values: 3113.2 3131.5 3139.2 3141.2 3148.9 5422.5 5453.6 5464.5 5504.8 5524.4 5269.7 5475.1 5485.4 5514.4 5599.2 4933.8 4971.1 4989.8 5052.0 5062.4 4870.9 4882.7 4886.4 4938.8 4939.0 4894.0 4907.2 4907.9 4986.3 5031.6 4958.4 4961.8 4977.6 4979.1 5030.2 4884.3 4892.8 4907.0 4925.7 4932.2 5518.1 5526.6 5533.1 5557.6 5600.7 5716.3 5768.5 5845.2 5870.5 5891.5 5859.4 5902.8 5907.1 5908.2 5940.4 5436.5 5485.3 5518.6 5522.8 5525.9 5910.7 6005.4 6012.9 6029.0 6033.8 5808.6 5821.7 5827.9 5834.1 5859.2 5748.4 5803.6 5807.0 5863.0 5871.6 5774.5 5817.3 5880.6 5882.7 5937.8 5895.2 5953.7 5959.0 5987.0 5993.6 4450.9 4477.1 4499.2 4503.5 4536.1 3979.5 4019.2 4030.7 4072.9 4083.0 5493.1 5630.3 5646.5 5658.6 5667.0 5819.6 5893.3 5914.6 5936.2 5953.4 5627.8 5629.9 5630.2 5634.3 5658.6 4834.6 4902.1 4923.8 4952.3 4985.1 5960.8 6011.8 6066.2 6068.2 6120.2 5903.7 5911.1 5913.9 5929.6 5932.8 5961.1 6055.1 6069.2 6103.6 6117.9 5829.7 5859.9 5859.9 5880.4 5907.4 5843.5 5903.2 5934.7 5966.9 5971.4 5625.9 5696.1 5727.5 5761.3 5791.6 5653.6 5657.9 5702.7 5776.0 5776.9 5654.1 5654.9 5659.4 5680.8 5691.4 5711.9 5754.5 5767.4 5810.5 5834.8 5616.1 5659.2 5705.4 5710.7 5716.9 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#1] ext.html Cycles:180 Average:59439.38 Median:42002.58 stddev:117861.00 (280.6%) stddev-sans-first:118108.69 08:41:17 INFO - PROCESS | 17230 | Values: 549.5 601.8 615.8 616.1 648.0 38425.4 41903.8 42042.2 42105.4 42108.6 42529.0 42798.6 42857.1 42901.8 42927.8 8682.3 8816.1 8851.5 8912.5 8914.7 8860.9 8870.4 8882.5 8897.1 8909.2 8908.4 8997.9 9016.8 9018.2 9026.1 8768.5 8864.4 8866.2 8887.0 8929.3 8737.1 8801.9 8814.4 8839.2 8842.9 40645.4 40719.4 40987.2 40990.2 41057.4 3593.2 3692.5 3711.5 3766.4 4225.8 32150.7 32276.4 32382.7 32784.5 34089.3 4288.7 4430.2 4469.7 4519.7 4612.7 316121.0 321483.0 322546.0 323177.0 323634.0 60770.0 61084.0 61100.7 61211.7 61311.4 37135.0 37711.0 38235.0 39691.8 39962.2 16484.8 16844.5 16887.4 16946.8 17093.7 12719.3 12739.2 12840.2 12845.7 12905.1 19326.9 19521.5 19780.8 19848.4 19902.0 7440.4 7453.7 7526.7 7648.8 7869.7 940.2 1070.3 1071.0 1097.4 1101.7 32511.8 32939.3 33062.4 33498.3 33652.8 1089.1 1132.7 1152.6 1186.0 1216.9 15978.3 16474.6 16520.3 16524.5 16836.9 530415.0 533388.0 536115.0 537182.0 537720.0 58246.7 59337.4 59378.7 59396.1 59445.1 1360.4 1374.7 1391.9 1408.4 1408.8 28731.6 28843.6 28861.7 29487.3 29829.9 52050.0 52538.0 52676.2 52839.0 52932.7 447285.0 449371.0 451269.0 451498.0 452232.0 29521.0 29525.0 30093.1 30206.5 30316.5 49578.0 49756.8 50105.0 50106.5 50953.5 41661.4 42195.8 42306.0 42335.8 43763.8 41387.2 41881.6 41963.0 42053.8 42099.8 40329.6 40734.0 42301.0 42324.0 42426.8 35145.3 37259.4 37739.6 38069.6 38197.0 27953.6 28114.3 28120.7 28319.0 28434.6 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#2] jquery.html Cycles:180 Average:27806.84 Median:3630.08 stddev:71550.69 (1971.0%) stddev-sans-first:71721.85 08:41:17 INFO - PROCESS | 17230 | Values: 412.6 413.6 418.6 422.1 434.5 18415.6 19140.0 20018.6 20388.4 20419.2 18671.2 18729.3 19351.4 19684.1 19706.9 5635.9 5705.4 5838.7 5863.8 5875.4 4052.9 5612.8 5684.6 6116.2 6450.6 6461.5 6477.1 6483.7 6491.0 6506.3 6307.5 6397.5 6404.8 6462.9 6515.2 5660.3 5725.4 5734.9 5747.7 5825.9 23298.7 23850.6 24137.5 24330.3 24423.9 2409.8 2466.4 2505.3 2764.5 3207.2 13493.0 14559.8 15055.2 15094.5 15306.1 1960.4 1994.8 1999.6 2006.8 2042.0 84732.6 86181.6 86256.1 87319.7 88385.1 11270.7 11347.1 11565.5 11711.1 12063.7 16071.8 16180.8 16239.5 16303.4 16374.4 8019.6 8344.9 8356.7 8487.3 8537.9 7844.5 7925.2 7948.8 7980.0 8217.5 4953.2 5055.1 5108.7 5127.6 5161.1 1731.7 1854.1 1870.0 1896.4 2091.3 970.1 982.8 1022.4 1059.2 1075.8 19280.1 19513.4 19854.7 19945.8 20180.9 981.0 986.4 1002.2 1043.8 1067.3 9794.2 10488.2 10980.7 11194.9 11232.8 424341.0 426409.0 432276.0 437256.0 440429.0 57858.1 78109.6 91744.0 94010.5 94364.0 959.8 993.1 999.3 999.5 1004.1 16864.9 16910.0 16994.3 17243.2 17594.0 40902.4 41807.8 42574.8 42877.6 42938.8 60812.7 61178.7 63187.0 63301.0 63334.0 8869.0 9202.3 9204.0 9276.6 9479.3 11596.9 13217.2 13301.8 13348.1 14177.4 11864.0 12014.3 12048.7 12122.4 12177.9 11749.2 11886.8 12135.8 12339.8 12399.8 12098.7 12117.5 12293.4 12297.6 12531.4 9060.8 9165.1 9203.6 9355.2 9385.0 11777.5 11870.8 11963.8 12290.8 12393.6 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#3] mootools.html Cycles:180 Average:6185.81 Median:2731.37 stddev:3611.70 (132.2%) stddev-sans-first:3604.78 08:41:17 INFO - PROCESS | 17230 | Values: 1514.7 1519.2 1694.9 1798.6 1803.4 8338.5 8921.2 9087.0 9626.6 9642.7 9456.1 9520.8 9583.9 9586.2 9620.2 2483.9 2504.2 2515.5 2518.3 2518.5 2405.0 2444.1 2444.5 2448.3 2453.6 2439.2 2446.9 2537.8 2540.9 2551.0 2433.6 2434.5 2463.8 2493.8 2501.2 2380.6 2390.0 2392.0 2400.1 2433.4 9468.3 9565.6 9589.3 9601.7 9652.4 5544.3 5698.5 5720.5 5727.1 5732.0 3381.3 3476.7 3533.7 3541.3 3611.3 1085.1 1107.8 1137.8 1145.9 1167.0 13384.5 13438.5 13499.7 13506.4 13520.7 4949.1 4965.2 5036.2 5107.1 5111.8 11054.9 11072.6 11127.6 11130.0 11136.5 5531.4 5534.3 5535.1 5540.4 5543.8 4576.9 4973.7 5056.9 5102.2 5106.6 4261.9 4279.3 4309.5 4341.6 4437.2 1318.7 1376.9 1376.9 1387.0 1394.8 932.7 970.6 976.4 985.8 991.1 6079.6 6096.6 6156.2 6172.8 6180.4 485.5 487.0 494.8 497.5 498.5 4073.8 4165.3 4260.8 4302.4 4310.3 11291.2 11651.8 11802.9 11872.3 11892.4 11281.0 11630.1 11698.2 11704.6 12090.4 8787.6 8863.6 8920.0 8923.1 8925.6 6035.7 6278.7 6312.8 6352.9 6414.2 10692.9 10817.9 11008.4 11051.9 11183.9 11110.3 11129.2 11163.8 11286.7 11300.8 7185.1 8111.4 8244.7 8318.2 8351.2 9352.8 9372.9 9400.8 9450.7 9469.3 8066.8 8431.7 8454.9 8541.0 8562.4 7993.2 8176.9 8227.2 8239.7 8280.3 7060.4 7289.4 7305.9 7310.0 7336.2 5015.7 5138.5 5147.1 5187.1 5214.7 5335.2 5338.8 5342.6 5359.1 5439.2 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#4] prototype.html Cycles:180 Average:4970.28 Median:5639.70 stddev:1475.84 (26.2%) stddev-sans-first:1438.51 08:41:17 INFO - PROCESS | 17230 | Values: 341.8 345.1 351.0 359.4 361.6 5470.5 5668.8 5671.9 5699.9 5780.2 5599.9 5673.7 5681.4 5697.8 5714.7 4431.8 4432.9 4448.3 4460.6 4465.6 4149.6 4385.2 4402.4 4405.3 4416.0 4322.1 4324.6 4329.7 4341.0 4374.4 4339.3 4350.6 4362.3 4367.6 4376.9 3790.4 3841.2 3844.9 3882.0 3887.4 5493.7 5542.6 5587.3 5604.7 5610.6 4910.3 5000.0 5023.5 5031.8 5050.8 5724.8 5970.0 5972.2 5991.2 5991.6 4235.7 4258.3 4260.0 4260.7 4262.7 6220.0 6230.0 6232.9 6235.9 6239.5 4274.3 4315.7 4352.6 4354.3 4373.7 4377.4 4388.4 4410.3 4426.1 4427.7 5022.2 5025.7 5028.4 5037.5 5055.8 5902.4 5939.5 5986.6 5992.6 6000.6 1513.9 1520.7 1528.2 1539.5 1539.8 924.1 934.8 947.5 965.3 988.7 4969.9 5012.0 5056.4 5069.9 5082.1 5352.5 5368.1 5370.8 5394.9 5396.8 5066.4 5070.3 5089.1 5298.3 5790.4 3207.5 3212.0 3246.9 3247.3 3250.3 6036.7 6348.6 6367.9 6376.4 6429.9 6271.9 6275.8 6293.4 6303.6 6322.2 6297.4 6314.3 6319.8 6323.7 6359.1 5846.0 6020.6 6074.3 6100.2 6113.3 5986.9 6051.3 6074.3 6079.6 6094.9 6177.3 6322.7 6331.8 6389.2 6443.5 4358.5 4378.8 4400.2 4404.6 4405.1 6260.5 6266.6 6269.0 6284.2 6320.3 5688.4 5949.3 6025.8 6045.5 6082.1 5956.1 5987.9 6000.8 6030.7 6036.7 5718.5 5899.0 5923.8 5924.8 5981.8 5944.6 5999.4 6001.4 6027.5 6078.9 5870.9 5890.5 5909.9 5911.3 5933.3 08:41:17 INFO - PROCESS | 17230 | 08:41:17 INFO - PROCESS | 17230 | [#5] yui.html Cycles:180 Average:22021.60 Median:3661.57 stddev:32687.31 (892.7%) stddev-sans-first:32739.88 08:41:17 INFO - PROCESS | 17230 | Values: 722.8 786.9 809.0 828.9 839.7 15786.6 16495.5 16663.8 16743.0 17035.1 14129.7 14236.4 14270.5 14277.5 14299.0 671.6 802.3 810.9 818.8 820.8 823.9 830.2 831.4 832.1 832.2 859.8 862.2 862.4 863.7 864.4 860.9 862.1 862.6 862.9 865.3 628.8 629.2 630.7 632.4 633.5 16071.8 16248.8 16396.9 16398.3 16411.8 13592.5 13734.7 13785.2 14421.9 15814.4 13354.6 13476.6 13716.4 13719.3 13899.1 4471.7 4526.3 4590.9 4594.2 4637.5 71271.8 80882.0 81868.6 82637.2 82846.0 11537.8 11661.5 11701.1 12073.6 12076.5 21108.8 21141.4 21177.4 21182.6 21217.8 7959.8 8030.6 8180.9 8295.3 8656.2 4496.3 4509.6 4515.8 4516.5 4555.0 3485.9 3545.8 3565.2 3570.3 3752.9 674.5 677.9 694.2 695.8 705.6 628.7 634.1 736.2 736.8 760.6 10410.9 10504.3 10584.9 10664.8 10898.1 665.3 746.1 756.8 758.0 762.5 5114.8 5202.3 5291.2 5299.9 5320.2 74345.9 130082.1 131102.0 131437.0 134535.3 110927.0 112077.4 112797.0 113456.4 115352.0 79298.6 95108.0 98300.5 98735.0 103612.0 9696.3 9915.0 9944.7 10013.1 10013.9 55621.7 56126.4 56530.7 56884.7 59648.7 50097.7 81801.0 82194.0 82431.6 83654.0 11901.5 12045.5 12535.6 13004.2 13243.1 14078.2 14664.5 14672.4 14773.6 14794.3 12819.2 13343.6 13422.5 13687.7 13965.4 12698.6 12809.2 13239.9 13819.6 13990.5 13530.1 13543.0 13749.7 13809.2 14242.1 10897.8 11168.6 11229.2 11297.4 11393.3 10357.8 11249.3 11464.3 11507.4 11613.2 08:41:17 INFO - PROCESS | 17230 | -------- Summary: end -------- 08:41:17 INFO - PROCESS | 17230 | 08:41:18 INFO - TEST-INFO | 17230: exit 0 08:41:18 INFO - TEST-OK | dromaeo_css | took 1119372ms 08:41:18 INFO - TEST-START | kraken 08:41:18 INFO - operating with platform_type : linux_ 08:41:18 INFO - Initialising browser for kraken test... 08:41:18 INFO - TEST-INFO | started process 17459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAk1E5b/profile http://localhost:51798/getInfo.html) 08:41:25 INFO - PROCESS | 17459 | __metrics Screen width/height:1600/1200 08:41:25 INFO - PROCESS | 17459 | colorDepth:24 08:41:25 INFO - PROCESS | 17459 | Browser inner width/height: 1024/697 08:41:25 INFO - PROCESS | 17459 | __metrics 08:41:27 ERROR - PROCESS | 17459 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:41:28 INFO - TEST-INFO | 17459: exit 0 08:41:28 INFO - Browser initialized. 08:41:28 INFO - Running cycle 1/1 for kraken test... 08:41:28 INFO - TEST-INFO | started process 17583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAk1E5b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:40 INFO - PROCESS | 17583 | RSS: Main: 185208832 08:41:40 INFO - PROCESS | 17583 | 08:41:42 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:43 INFO - PROCESS | 17583 | RSS: Main: 191545344 08:41:43 INFO - PROCESS | 17583 | 08:41:46 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-dft) 08:41:47 INFO - PROCESS | 17583 | RSS: Main: 190279680 08:41:47 INFO - PROCESS | 17583 | 08:41:49 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-fft) 08:41:50 INFO - PROCESS | 17583 | RSS: Main: 184848384 08:41:50 INFO - PROCESS | 17583 | 08:41:52 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51798/tests/kraken/driver.html?testName=audio-oscillator) 08:41:53 INFO - PROCESS | 17583 | RSS: Main: 185987072 08:41:53 INFO - PROCESS | 17583 | 08:41:55 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:56 INFO - PROCESS | 17583 | RSS: Main: 185778176 08:41:56 INFO - PROCESS | 17583 | 08:41:59 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:00 INFO - PROCESS | 17583 | RSS: Main: 186601472 08:42:00 INFO - PROCESS | 17583 | 08:42:03 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51798/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:04 INFO - PROCESS | 17583 | RSS: Main: 183730176 08:42:04 INFO - PROCESS | 17583 | 08:42:06 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51798/tests/kraken/driver.html?testName=json-parse-financial) 08:42:07 INFO - PROCESS | 17583 | RSS: Main: 185208832 08:42:07 INFO - PROCESS | 17583 | 08:42:09 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:09 INFO - PROCESS | 17583 | RSS: Main: 185745408 08:42:09 INFO - PROCESS | 17583 | 08:42:11 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:12 INFO - PROCESS | 17583 | RSS: Main: 186470400 08:42:12 INFO - PROCESS | 17583 | 08:42:15 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:16 INFO - PROCESS | 17583 | RSS: Main: 186974208 08:42:16 INFO - PROCESS | 17583 | 08:42:18 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:19 INFO - PROCESS | 17583 | RSS: Main: 187162624 08:42:19 INFO - PROCESS | 17583 | 08:42:22 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:22 INFO - PROCESS | 17583 | RSS: Main: 186404864 08:42:22 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | Cycle 1(1): loaded http://localhost:51798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51798/tests/kraken/driver.html?testName=ai-astar) 08:42:24 INFO - PROCESS | 17583 | RSS: Main: 187789312 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | __start_tp_report 08:42:24 INFO - PROCESS | 17583 | _x_x_mozilla_page_load 08:42:24 INFO - PROCESS | 17583 | _x_x_mozilla_page_load_details 08:42:24 INFO - PROCESS | 17583 | |i|pagename|runs| 08:42:24 INFO - PROCESS | 17583 | |0;ai-astar;110;107;110;111;110;110;110;111;111;110 08:42:24 INFO - PROCESS | 17583 | |1;audio-beat-detection;158;131;159;182;132;160;152;125;179;128 08:42:24 INFO - PROCESS | 17583 | |2;audio-dft;164;162;164;162;169;167;166;162;163;161 08:42:24 INFO - PROCESS | 17583 | |3;audio-fft;75;75;76;167;75;75;74;75;157;76 08:42:24 INFO - PROCESS | 17583 | |4;audio-oscillator;86;85;149;87;85;86;132;87;85;142 08:42:24 INFO - PROCESS | 17583 | |5;imaging-gaussian-blur;118;117;117;118;119;118;121;117;117;118 08:42:24 INFO - PROCESS | 17583 | |6;imaging-darkroom;146;148;148;150;147;149;147;147;153;147 08:42:24 INFO - PROCESS | 17583 | |7;imaging-desaturate;96;95;96;95;95;96;95;96;95;95 08:42:24 INFO - PROCESS | 17583 | |8;json-parse-financial;54;54;57;53;54;53;66;55;53;54 08:42:24 INFO - PROCESS | 17583 | |9;json-stringify-tinderbox;61;61;61;62;60;61;61;60;61;61 08:42:24 INFO - PROCESS | 17583 | |10;stanford-crypto-aes;84;81;83;82;86;82;87;82;119;87 08:42:24 INFO - PROCESS | 17583 | |11;stanford-crypto-ccm;126;123;126;120;141;131;133;134;138;133 08:42:24 INFO - PROCESS | 17583 | |12;stanford-crypto-pbkdf2;168;161;168;169;160;160;167;167;161;161 08:42:24 INFO - PROCESS | 17583 | |13;stanford-crypto-sha256-iterative;66;65;66;63;67;64;63;64;67;62 08:42:24 INFO - PROCESS | 17583 | __end_tp_report 08:42:24 INFO - PROCESS | 17583 | __start_cc_report 08:42:24 INFO - PROCESS | 17583 | _x_x_mozilla_cycle_collect,884 08:42:24 INFO - PROCESS | 17583 | __end_cc_report 08:42:24 INFO - PROCESS | 17583 | __startTimestamp1465918944586__endTimestamp 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | ------- Summary: start ------- 08:42:24 INFO - PROCESS | 17583 | Number of tests: 14 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 08:42:24 INFO - PROCESS | 17583 | Values: 110.0 107.0 110.0 111.0 110.0 110.0 110.0 111.0 111.0 110.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:158.50 stddev:20.83 (13.1%) stddev-sans-first:21.92 08:42:24 INFO - PROCESS | 17583 | Values: 158.0 131.0 159.0 182.0 132.0 160.0 152.0 125.0 179.0 128.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 08:42:24 INFO - PROCESS | 17583 | Values: 164.0 162.0 164.0 162.0 169.0 167.0 166.0 162.0 163.0 161.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.71 (48.9%) stddev-sans-first:38.39 08:42:24 INFO - PROCESS | 17583 | Values: 75.0 75.0 76.0 167.0 75.0 75.0 74.0 75.0 157.0 76.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.50 stddev:26.95 (31.5%) stddev-sans-first:27.92 08:42:24 INFO - PROCESS | 17583 | Values: 86.0 85.0 149.0 87.0 85.0 86.0 132.0 87.0 85.0 142.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 08:42:24 INFO - PROCESS | 17583 | Values: 118.0 117.0 117.0 118.0 119.0 118.0 121.0 117.0 117.0 118.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.04 (1.4%) stddev-sans-first:2.01 08:42:24 INFO - PROCESS | 17583 | Values: 146.0 148.0 148.0 150.0 147.0 149.0 147.0 147.0 153.0 147.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:42:24 INFO - PROCESS | 17583 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:3.95 (7.3%) stddev-sans-first:4.16 08:42:24 INFO - PROCESS | 17583 | Values: 54.0 54.0 57.0 53.0 54.0 53.0 66.0 55.0 53.0 54.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:42:24 INFO - PROCESS | 17583 | Values: 61.0 61.0 61.0 62.0 60.0 61.0 61.0 60.0 61.0 61.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:83.50 stddev:11.35 (13.6%) stddev-sans-first:11.98 08:42:24 INFO - PROCESS | 17583 | Values: 84.0 81.0 83.0 82.0 86.0 82.0 87.0 82.0 119.0 87.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:133.00 stddev:6.65 (5.0%) stddev-sans-first:6.86 08:42:24 INFO - PROCESS | 17583 | Values: 126.0 123.0 126.0 120.0 141.0 131.0 133.0 134.0 138.0 133.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:167.00 stddev:3.85 (2.3%) stddev-sans-first:3.83 08:42:24 INFO - PROCESS | 17583 | Values: 168.0 161.0 168.0 169.0 160.0 160.0 167.0 167.0 161.0 161.0 08:42:24 INFO - PROCESS | 17583 | 08:42:24 INFO - PROCESS | 17583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.50 stddev:1.77 (2.7%) stddev-sans-first:1.81 08:42:24 INFO - PROCESS | 17583 | Values: 66.0 65.0 66.0 63.0 67.0 64.0 63.0 64.0 67.0 62.0 08:42:24 INFO - PROCESS | 17583 | -------- Summary: end -------- 08:42:24 INFO - PROCESS | 17583 | 08:42:25 INFO - TEST-INFO | 17583: exit 0 08:42:25 INFO - TEST-OK | kraken | took 67235ms 08:42:25 INFO - SUITE-END | took 1186s 08:42:26 INFO - Completed test suite (00:19:47) 08:42:26 INFO - javascript benchmark 08:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7489.516862593593, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.1750086227166, 3131.467650499415, 3139.199504126447, 3141.230398552355, 3148.858301376438, 5422.53908417785, 5453.590980676446, 5464.535514481274, 5504.779808807642, 5524.364698059724, 5269.736513174345, 5475.069238229501, 5485.396606373296, 5514.393416724157, 5599.188117722928, 4933.777979990909, 4971.130052240862, 4989.800407983676, 5051.974740126294, 5062.367204099488, 4870.902581948359, 4882.731449770261, 4886.413630364344, 4938.7530623468865, 4938.975305123469, 4893.951060489385, 4907.190313598252, 4907.8773030674165, 4986.326845875833, 5031.597472202215, 4958.429780575208, 4961.751912404366, 4977.576905962997, 4979.10376132296, 5030.245463180552, 4884.267359896008, 4892.779824907852, 4906.994066216417, 4925.704457732548, 4932.235503496964, 5518.089515230023, 5526.58550608706, 5533.08704063829, 5557.6109672322955, 5600.663960162403, 5716.314042314907, 5768.509676677488, 5845.152452894349, 5870.501007414375, 5891.528677705774, 5859.384764599698, 5902.763889444417, 5907.054871220584, 5908.231929849135, 5940.435658612468, 5436.53789427903, 5485.314335708036, 5518.586106042023, 5522.757379589641, 5525.917111243334, 5910.734016969161, 6005.3694362091355, 6012.879742405127, 6028.969855150696, 6033.849153771103, 5808.564357673192, 5821.650700957956, 5827.941720582825, 5834.095715164156, 5859.150423188699, 5748.425157484218, 5803.593748437569, 5807.0, 5862.970685146547, 5871.618344807659, 5774.451427114417, 5817.272840894888, 5880.647161170344, 5882.676452795137, 5937.821865344046, 5895.20414744004, 5953.672548009901, 5958.970205148947, 5986.970065149646, 5993.580449368589, 4450.910981780346, 4477.126960242721, 4499.212637788374, 4503.459584849839, 4536.092781443725, 3979.5423526294267, 4019.2363450944226, 4030.6976976726864, 4072.857449989295, 4082.9591704083173, 5493.121100623881, 5630.296212973379, 5646.463585959327, 5658.632188907708, 5667.008273552195, 5819.621724587888, 5893.263342082239, 5914.58597898143, 5936.198613187251, 5953.434423729739, 5627.831165065055, 5629.915551266734, 5630.183623374588, 5634.295713035871, 5658.575606829422, 4834.5890599299455, 4902.117618828645, 4923.8276660316715, 4952.306677065214, 4985.1276026695905, 5960.791372301948, 6011.789587364421, 6066.181065556182, 6068.21113255274, 6120.1737765401995, 5903.734331954986, 5911.142884281841, 5913.940860591339, 5929.555283353852, 5932.79235226765, 5961.105834124916, 6055.091736239599, 6069.180660610761, 6103.6032657877095, 6117.908231376444, 5829.679367634821, 5859.882802343844, 5859.882802343844, 5880.382559831327, 5907.409259074058, 5843.532517398513, 5903.173555702119, 5934.703264836655, 5966.940330596639, 5971.402859713994, 5625.8593535161945, 5696.060150075357, 5727.5417966561745, 5761.251037365116, 5791.623544469596, 5653.632513886584, 5657.8684263146715, 5702.714864256687, 5775.971120144372, 5776.855578610568, 5654.095344744821, 5654.943450565442, 5659.405762394889, 5680.77276908919, 5691.430856914276, 5711.942880571141, 5754.4533269339345, 5767.423257674367, 5810.477057064884, 5834.824955251349, 5616.073347897551, 5659.236003139524, 5705.429457054262, 5710.657360558213, 5716.885662286648], "value": 5411.538729566466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4972100528017, 601.8465291350707, 615.7721642992094, 616.1497133955143, 647.9935200647992, 38425.42361864574, 41903.790481047625, 42042.159156816844, 42105.36841947373, 42108.57891421085, 42529.0, 42798.572014279845, 42857.14285714284, 42901.78549107258, 42927.78536107323, 8682.30541556674, 8816.074312197223, 8851.468911865277, 8912.509811960339, 8914.732558023237, 8860.8670869937, 8870.42342247752, 8882.511461869595, 8897.065808090154, 8909.153630405133, 8908.376413651047, 8997.910020899806, 9016.77458063547, 9018.233450156744, 9026.097390260988, 8768.473891566495, 8864.423812452202, 8866.202041816268, 8886.955565222197, 8929.33030022751, 8737.082606326308, 8801.911980880173, 8814.382993190478, 8839.16027977341, 8842.867356989651, 40645.390319145234, 40719.35324203947, 40987.180256395004, 40990.180196396206, 41057.38413923793, 3593.2274560969254, 3692.538432695913, 3711.5175027246555, 3766.4162054881535, 4225.767582782945, 32150.713971441113, 32276.354472910643, 32382.6761732382, 32784.50823237653, 34089.31821363559, 4288.721233119868, 4430.180416622935, 4469.687121901468, 4519.706219095749, 4612.654050946193, 316121.0, 321483.0, 322546.0, 323177.0, 323634.0, 60770.0, 61084.0, 61100.694496527234, 61211.69394153001, 61311.38688613057, 37135.0, 37711.0, 38235.044123897125, 39691.80154099269, 39962.20075598472, 16484.83515164857, 16844.494665160066, 16887.408940687015, 16946.830531694774, 17093.658126837392, 12719.300438475973, 12739.235645861278, 12840.165389249669, 12845.678858028625, 12905.09664323507, 19326.903365483082, 19521.529193097525, 19780.802191978182, 19848.40454786359, 19902.0, 7440.3675687567165, 7453.701851925971, 7526.736564220226, 7648.80877978055, 7869.685212591432, 940.238406890421, 1070.3310430980637, 1070.9625163119254, 1097.3964319624174, 1101.730076131353, 32511.837440812644, 32939.341213175605, 33062.403506150324, 33498.33003339968, 33652.83173584165, 1089.0742868561817, 1132.694172573417, 1152.567787079845, 1186.0096819156101, 1216.871299717893, 15978.280977355815, 16474.588135296475, 16520.339186432648, 16524.504264872074, 16836.915815420845, 530415.0, 533388.0, 536115.0, 537182.0, 537720.0, 58246.70876645589, 59337.406625934054, 59378.703106484194, 59396.109058364156, 59445.108323375185, 1360.4422935738523, 1374.6632075141654, 1391.8608139186001, 1408.3521580073282, 1408.7816388459805, 28731.569026465037, 28843.5673464894, 28861.711382885904, 29487.26281842885, 29829.850850746476, 52050.0, 52538.0, 52676.20985685141, 52839.0, 52932.73533632307, 447285.0, 449371.0, 451269.0, 451498.0, 452232.0, 29521.0, 29525.0, 30093.09720708382, 30206.54690179693, 30316.484175791564, 49578.0, 49756.75121624369, 50105.0, 50106.49893501018, 50953.490465094874, 41661.37507937444, 42195.78902105593, 42306.0, 42335.7883210582, 43763.78118109389, 41387.1722565541, 41881.581184187766, 41963.0, 42053.78973105115, 42099.7895010523, 40329.596704032585, 40734.0, 42301.0, 42324.0, 42426.78786606047, 35145.29709405747, 37259.44110838394, 37739.62260377471, 38069.619303806605, 38197.0, 27953.580696289166, 28114.250492115778, 28120.71879281181, 28319.0, 28434.57348139821], "value": 20066.17316806807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.5523806669763, 413.62773503846535, 418.6169654765889, 422.1240925080458, 434.4873049801233, 18415.631687366244, 19139.99999999998, 20018.599628007432, 20388.388348349537, 20419.183232670675, 18671.159797809098, 18729.34447294345, 19351.419457416265, 19684.11421486033, 19706.901465492654, 5635.859103522414, 5705.400932902048, 5838.7080645967535, 5863.76544938202, 5875.383084776101, 4052.9392059119136, 5612.7754889804355, 5684.630499017571, 6116.174316467287, 6450.6452145132, 6461.483081353481, 6477.060826180201, 6483.740650373979, 6490.967545162292, 6506.251781045169, 6307.495400367982, 6397.52018598607, 6404.839879003039, 6462.935370646281, 6515.153030106103, 5660.264165658438, 5725.398833122504, 5734.885302293973, 5747.683877386742, 5825.9417405825825, 23298.65052024221, 23850.642240366407, 24137.517249655084, 24330.27009189727, 24423.87788061066, 2409.8433601815827, 2466.3587467258462, 2505.260948020338, 2764.543850264704, 3207.23026473647, 13493.0, 14559.78160327596, 15055.171965541891, 15094.471693490785, 15306.08163510193, 1960.372680742163, 1994.8204661580382, 1999.6000799839944, 2006.7591888973416, 2041.9693704594442, 84732.57633711853, 86181.56909215476, 86256.13743862607, 87319.69020464762, 88385.11614883834, 11270.661880143609, 11347.092232621371, 11565.479553420117, 11711.063114950783, 12063.698407539881, 16071.839281607268, 16180.838191618168, 16239.51281461558, 16303.429379971643, 16374.426895058616, 8019.558924259105, 8344.874826877602, 8356.749297521084, 8487.321014318839, 8537.871931921027, 7844.450888437755, 7925.167857375008, 7948.761537153895, 7980.0, 8217.506949583045, 4953.2074868020945, 5055.09008378488, 5108.693478391308, 5127.64106512548, 5161.148410512298, 1731.7229243321008, 1854.1285595769966, 1870.0, 1896.3931541906456, 2091.257603550748, 970.1317320997667, 982.823091843475, 1022.3661329975463, 1059.2267644619471, 1075.7902209069314, 19280.132394042303, 19513.414597562096, 19854.70217946732, 19945.800541994686, 20180.89909550443, 981.0, 986.3982970388057, 1002.1932344462632, 1043.796459690353, 1067.3489171605315, 9794.216462682969, 10488.160947124212, 10980.670579882617, 11194.944025279985, 11232.775344493228, 424341.0, 426409.0, 432276.0, 437256.0, 440429.0, 57858.132128018115, 78109.60945195351, 91744.0, 94010.52994734983, 94364.0, 959.7504648791364, 993.0665174735725, 999.3204620857741, 999.4602914426129, 1004.1264100232844, 16864.915675421544, 16910.0, 16994.320227190772, 17243.224054917308, 17594.0, 40902.386464202464, 41807.790961045, 42574.78712606417, 42877.57122428861, 42938.78530607327, 60812.695936521806, 61178.69410652918, 63187.0, 63301.0, 63334.04998925112, 8869.005650503066, 9202.309826762885, 9203.953980230055, 9276.58255378523, 9479.336446448682, 11596.94201528987, 13217.206967581591, 13301.800472993107, 13348.065635405428, 14177.432902683777, 11864.0, 12014.279143251433, 12048.698782530508, 12122.393880306126, 12177.878221217674, 11749.236299640495, 11886.75317465837, 12135.817962730389, 12339.814902776287, 12399.75200496003, 12098.697532561757, 12117.454714538044, 12293.385330733248, 12297.56958506448, 12531.373431328215, 9060.773480662772, 9165.129312715282, 9203.585838637144, 9355.158035776813, 9384.95307523458, 11777.52889884395, 11870.821937671115, 11963.76072478563, 12290.81563776562, 12393.62819115428], "value": 9571.24895825729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.6894886548255, 1519.1568679382942, 1694.8644108471324, 1798.6043070524488, 1803.4499477659308, 8338.541380224086, 8921.241694455972, 9086.954565227164, 9626.614935402575, 9642.710718678441, 9456.05439456054, 9520.809583808319, 9583.856242156373, 9586.233101351892, 9620.182284505809, 2483.937901552458, 2504.211173480348, 2515.4843257132334, 2518.2948774343213, 2518.4837108392826, 2404.987975060131, 2444.1201167579657, 2444.4622183119773, 2448.302233863349, 2453.619688948207, 2439.2072576412647, 2446.902123915041, 2537.8350407223566, 2540.872956352175, 2550.9744902550924, 2433.610622300432, 2434.513097380522, 2463.802895768343, 2493.8379005364773, 2501.1996161228412, 2380.6191009438407, 2389.952200955971, 2391.976080239193, 2400.135951057618, 2433.3794882305074, 9468.337216394855, 9565.617375304979, 9589.280803939733, 9601.663941762075, 9652.372595781251, 5544.279243698334, 5698.458646428583, 5720.456556627114, 5727.11229759388, 5732.0255556555485, 3381.340638575479, 3476.687098161178, 3533.6819686228105, 3541.327147841902, 3611.277744451094, 1085.066842515436, 1107.7839821234863, 1137.8122609769462, 1145.9025982791472, 1166.9941650291694, 13384.531541396005, 13438.46246150153, 13499.730005399935, 13506.392212350369, 13520.661983450394, 4949.133901567211, 4965.230389289666, 5036.169032109734, 5107.055194788976, 5111.7699703513435, 11054.889451105546, 11072.612458563912, 11127.554897803997, 11130.0, 11136.498857551429, 5531.363893152258, 5534.252875861787, 5535.142052981794, 5540.418256083134, 5543.7782488700805, 4576.931346029813, 4973.726445045485, 5056.924146137811, 5102.209157580581, 5106.591472682251, 4261.936070958938, 4279.272523670983, 4309.504406993173, 4341.630961368319, 4437.2234858899565, 1318.7098838255567, 1376.8967327450482, 1376.9105008174436, 1386.9791953120712, 1394.8186735724494, 932.7015355086443, 970.6117552978865, 976.3653625143713, 985.8324084905584, 991.1257353674258, 6079.574429789872, 6096.573239873255, 6156.168917196122, 6172.7532993505965, 6180.381961803783, 485.5387381987126, 486.9853904382874, 494.8416506717888, 497.51492295012076, 498.536361184095, 4073.816678249486, 4165.291900376943, 4260.765657888845, 4302.44068271129, 4310.288802347577, 11291.153163512769, 11651.76696466066, 11802.94098529519, 11872.34702091376, 11892.405379730979, 11281.0, 11630.127740419333, 11698.239614425034, 11704.590339338252, 12090.395480225954, 8787.560621968876, 8863.601137948808, 8920.0, 8923.107689231025, 8925.642974280956, 6035.714642603625, 6278.6546739929745, 6312.810615681537, 6352.936470635234, 6414.230292364946, 10692.946535267274, 10817.945910270399, 11008.39453830047, 11051.944740276247, 11183.944080279873, 11110.277831940897, 11129.165312601426, 11163.776724465302, 11286.717832054264, 11300.7739845201, 7185.137783465809, 8111.432199745961, 8244.711435099744, 8318.168183181875, 8351.24838764514, 9352.812943740952, 9372.906270937203, 9400.764980875532, 9450.669226577036, 9469.337146399686, 8066.83866322682, 8431.662733490592, 8454.873176902474, 8540.957295213484, 8562.357823163164, 7993.160718124514, 8176.877346839683, 8227.177282271725, 8239.711610093858, 8280.254777070093, 7060.399866011447, 7289.380402665833, 7305.853882922418, 7309.963450182715, 7336.229695881855, 5015.6990580563825, 5138.486151384832, 5147.099257629825, 5187.066328060985, 5214.713190774544, 5335.1730481775385, 5338.75975581092, 5342.572594192533, 5359.115745901882, 5439.238506608999], "value": 4831.0476462327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8427523339264, 345.0855233630878, 350.9929801403972, 359.3908325388468, 361.6311362410343, 5470.507654311111, 5668.801591944282, 5671.886562268752, 5699.857503562418, 5780.190773291737, 5599.8600034999145, 5673.716314184295, 5681.431856814316, 5697.772089116441, 5714.714264286779, 4431.778411079449, 4432.911341773162, 4448.310511870665, 4460.553944605538, 4465.620422264112, 4149.585041495857, 4385.2106620808245, 4402.449693788277, 4405.2511073117485, 4416.0, 4322.07075478772, 4324.567543245666, 4329.718568293067, 4340.9798697306105, 4374.387585737999, 4339.327404252346, 4350.564943505671, 4362.323839804803, 4367.628751556122, 4376.890577735582, 3790.4124860646643, 3841.1741475582603, 3844.942325865114, 3881.9611803882162, 3887.3974533947285, 5493.708978390076, 5542.5565954723525, 5587.3015873015875, 5604.719764011824, 5610.607257491936, 4910.337104490919, 4999.9500004999845, 5023.472535383768, 5031.84904452867, 5050.772715227824, 5724.797792463588, 5969.970150149222, 5972.193753843219, 5991.221141251653, 5991.55063370249, 4235.661147108224, 4258.276093064155, 4260.0, 4260.659147268211, 4262.680298977589, 6220.0, 6229.97525804111, 6232.9376706232815, 6235.908715974686, 6239.469645080174, 4274.294741367702, 4315.6763242756915, 4352.608265256142, 4354.303311470149, 4373.650107991353, 4377.446006667651, 4388.363687265329, 4410.33844923264, 4426.070525189682, 4427.667924905581, 5022.171341728647, 5025.673331233531, 5028.371453568304, 5037.5214354636255, 5055.837157453806, 5902.406350285485, 5939.46544810969, 5986.640801551921, 5992.610480318765, 6000.5799594028, 1513.8940274180923, 1520.657851983295, 1528.1824224040085, 1539.4919676506727, 1539.8229203641724, 924.0851556958563, 934.7663084228943, 947.4599478297442, 965.2567523007245, 988.7393573194234, 4969.90060198794, 5012.0, 5056.443791182967, 5069.898602028013, 5082.085224659597, 5352.5450336721815, 5368.114261146945, 5370.812021579226, 5394.946050539523, 5396.811111611075, 5066.442691303953, 5070.340855688811, 5089.142463001052, 5298.311219541435, 5790.449907258803, 3207.5188721691934, 3211.9678803212137, 3246.935061298761, 3247.3342964692183, 3250.3011852451837, 6036.673612803462, 6348.619082855043, 6367.936320636827, 6376.39424254695, 6429.935700643027, 6271.905921411182, 6275.843103922347, 6293.402126797947, 6303.558750887486, 6322.241331040304, 6297.433231009231, 6314.273858506239, 6319.8308312962245, 6323.683815809283, 6359.141515895295, 5846.0, 6020.638761674313, 6074.331823499323, 6100.23747031621, 6113.327533971171, 5986.910196347146, 6051.33435322123, 6074.331823499323, 6079.635221886524, 6094.878102437838, 6177.320494745664, 6322.747090116344, 6331.810045698637, 6389.233292004989, 6443.484521238383, 4358.520562738159, 4378.781060947003, 4400.207962566768, 4404.581564751344, 4405.052913623458, 6260.5270917988055, 6266.587363864854, 6268.996960486483, 6284.183056202664, 6320.336364681642, 5688.374278829243, 5949.345571986992, 6025.78909738157, 6045.546584006129, 6082.11809287642, 5956.13636022783, 5987.910181347196, 6000.759969601167, 6030.698465076816, 6036.728347224298, 5718.456746609066, 5899.0, 5923.7926672566255, 5924.763009479745, 5981.833542459179, 5944.554158438048, 5999.370066143167, 6001.3698561652145, 6027.457528822427, 6078.878422431615, 5870.853228669317, 5890.4698577128265, 5909.852253693692, 5911.320198177093, 5933.2880054393745], "value": 4497.671122406246, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.801229661843, 786.9409794265432, 808.9838203235931, 828.9461185022973, 839.7438781171741, 15786.605334866634, 16495.505134845946, 16663.75004374934, 16743.0, 17035.148242587882, 14129.717405651882, 14236.359363828627, 14270.500532481365, 14277.50028748994, 14299.0, 671.6272468779825, 802.2899733735657, 810.8702607582788, 818.7625588579334, 820.8112134209135, 823.9423240373176, 830.2361827119034, 831.3889291370838, 832.0556168748453, 832.1886160993043, 859.8065435277075, 862.1938487514194, 862.409249663979, 863.7322430046675, 864.4035615425337, 860.8751730999002, 862.0904945282724, 862.6420035685214, 862.8921384826897, 865.2991077227402, 628.8490762217081, 629.1852051593198, 630.7004173017825, 632.3549979021373, 633.5090305013605, 16071.839281607152, 16248.83751162485, 16396.918015409967, 16398.344066237336, 16411.753823692656, 13592.456301747918, 13734.725305493834, 13785.172889626654, 14421.927890360586, 15814.446494372756, 13354.599362019155, 13476.595702128952, 13716.382762775698, 13719.314034298246, 13899.096558723752, 4471.686981911267, 4526.3210518422175, 4590.862274131781, 4594.150082234797, 4637.489876113625, 71271.78246651411, 80882.0, 81868.59065704633, 82637.17362826415, 82846.0, 11537.826932596017, 11661.53353865836, 11701.122415818847, 12073.57742479009, 12076.516939322504, 21108.78891211099, 21141.365759027252, 21177.364679059654, 21182.576348473252, 21217.78782212189, 7959.761207163794, 8030.558319292495, 8180.9181908181345, 8295.253427191581, 8656.22094011542, 4496.258117410656, 4509.616682581952, 4515.774211289422, 4516.503184649686, 4555.0, 3485.9302813944087, 3545.804980726085, 3565.23347480293, 3570.250247448065, 3752.887413377603, 674.5312008154285, 677.8712044711588, 694.2398074108944, 695.8295217671601, 705.5590256089944, 628.6542401679059, 634.0900807341387, 736.2159300345115, 736.8194792275926, 760.5740785160328, 10410.947945260225, 10504.264701470976, 10584.947075264728, 10664.840027399596, 10898.12814974816, 665.3413121010165, 746.1270313732946, 756.8221467955026, 757.9696812127563, 762.4624639629048, 5114.846554603293, 5202.323697919246, 5291.206319052096, 5299.894002119936, 5320.228566857784, 74345.87813620115, 130082.09753707403, 131102.0, 131437.0, 134535.32732336276, 110927.0, 112077.43961280142, 112797.0, 113456.43271783588, 115352.0, 79298.6035069821, 95107.99999999862, 98300.50849745849, 98735.0, 103612.0, 9696.321257511907, 9915.0, 9944.701658949954, 10013.148882345082, 10013.949930250303, 55621.72189139028, 56126.43873561375, 56530.717346413, 56884.715576421855, 59648.70175649094, 50097.74951125221, 81801.0, 82194.0, 82431.58784206041, 83654.0, 11901.464434100313, 12045.518179273082, 12535.623931282076, 13004.154729942524, 13243.07298489135, 14078.225697586731, 14664.486742963945, 14672.413103475741, 14773.556793296219, 14794.260286985824, 12819.166754161322, 13343.599692009255, 13422.530211442552, 13687.675216484295, 13965.371558280105, 12698.555550555686, 12809.167404118702, 13239.933800330937, 13819.585412437644, 13990.510332138327, 13530.120542164728, 13543.0, 13749.656258593215, 13809.171449712647, 14242.145471271757, 10897.78204435891, 11168.553257869595, 11229.21395502307, 11297.43512824339, 11393.316401015965, 10357.75706915175, 11249.325040497597, 11464.25482343645, 11507.367094809866, 11613.245139065933], "value": 7814.451322301004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 159.0, 182.0, 132.0, 160.0, 152.0, 125.0, 179.0, 128.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 162.0, 169.0, 167.0, 166.0, 162.0, 163.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 167.0, 75.0, 75.0, 74.0, 75.0, 157.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 87.0, 85.0, 86.0, 132.0, 87.0, 85.0, 142.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 121.0, 117.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 150.0, 147.0, 149.0, 147.0, 147.0, 153.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 57.0, 53.0, 54.0, 53.0, 66.0, 55.0, 53.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 82.0, 86.0, 82.0, 87.0, 82.0, 119.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 126.0, 120.0, 141.0, 131.0, 133.0, 134.0, 138.0, 133.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 168.0, 169.0, 160.0, 160.0, 167.0, 167.0, 161.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 63.0, 67.0, 64.0, 63.0, 64.0, 67.0, 62.0], "value": 64.7, "unit": "score"}]}]} 08:42:26 INFO - Return code: 0 08:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:26 ERROR - # TBPL SUCCESS # 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - ##### 08:42:26 INFO - ##### Finished run-tests step (success) 08:42:26 INFO - ##### 08:42:26 INFO - Running post-run listener: _resource_record_post_run 08:42:26 INFO - Total resource usage - Wall time: 1210s; CPU: 14.0%; Read bytes: 4096; Write bytes: 486182912; Read time: 12; Write time: 3370908 08:42:26 INFO - TinderboxPrint: CPU usage
13.8% 08:42:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:42:26 INFO - TinderboxPrint: I/O write bytes / time
486,182,912 / 3,370,908 08:42:26 INFO - TinderboxPrint: CPU idle
8,314.3 (86.1%) 08:42:26 INFO - TinderboxPrint: CPU user
1,226.3 (12.7%) 08:42:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:42:26 INFO - install - Wall time: 22s; CPU: 24.0%; Read bytes: 0; Write bytes: 174415872; Read time: 0; Write time: 1920116 08:42:26 INFO - run-tests - Wall time: 1188s; CPU: 14.0%; Read bytes: 4096; Write bytes: 291790848; Read time: 12; Write time: 1334780 08:42:27 INFO - Running post-run listener: _upload_blobber_files 08:42:27 INFO - Blob upload gear active. 08:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:31 INFO - (blobuploader) - INFO - Done attempting. 08:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:31 INFO - (blobuploader) - INFO - Done attempting. 08:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:42:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:32 INFO - (blobuploader) - INFO - Done attempting. 08:42:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:32 INFO - Return code: 0 08:42:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e39c2eff2b1e8846768aab5e3bd420ede6584835bd5880705be1877719b75206d69d55a69c768879aebbeced757746e0d7eb9097a0110d0cb46ee22718482add", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61b72edea9fa04b6ddd6a9a78292c75162b08faa4943a320fc70aa1e03ee5950cb1bf3efb30f063214f53dea7eb8c212627da34357bc7e5af3dcbc9b55ccc50e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53706e8a84b0bdf087ec081f9140ecdbd36d8bc9ed41955751924c575ab9a8ba8dfe25bdbd2eafff8bbe8f3f4a9b1abb9cf60ee6a9a6707986ef04e5986967de"} 08:42:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:32 INFO - Contents: 08:42:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e39c2eff2b1e8846768aab5e3bd420ede6584835bd5880705be1877719b75206d69d55a69c768879aebbeced757746e0d7eb9097a0110d0cb46ee22718482add", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61b72edea9fa04b6ddd6a9a78292c75162b08faa4943a320fc70aa1e03ee5950cb1bf3efb30f063214f53dea7eb8c212627da34357bc7e5af3dcbc9b55ccc50e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53706e8a84b0bdf087ec081f9140ecdbd36d8bc9ed41955751924c575ab9a8ba8dfe25bdbd2eafff8bbe8f3f4a9b1abb9cf60ee6a9a6707986ef04e5986967de"} 08:42:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:32 INFO - Copying logs to upload dir... 08:42:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.969469 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-14 08:42:31.564871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 08:42:31.567954) ========= 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=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e39c2eff2b1e8846768aab5e3bd420ede6584835bd5880705be1877719b75206d69d55a69c768879aebbeced757746e0d7eb9097a0110d0cb46ee22718482add", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61b72edea9fa04b6ddd6a9a78292c75162b08faa4943a320fc70aa1e03ee5950cb1bf3efb30f063214f53dea7eb8c212627da34357bc7e5af3dcbc9b55ccc50e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53706e8a84b0bdf087ec081f9140ecdbd36d8bc9ed41955751924c575ab9a8ba8dfe25bdbd2eafff8bbe8f3f4a9b1abb9cf60ee6a9a6707986ef04e5986967de"} build_url:https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e39c2eff2b1e8846768aab5e3bd420ede6584835bd5880705be1877719b75206d69d55a69c768879aebbeced757746e0d7eb9097a0110d0cb46ee22718482add", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61b72edea9fa04b6ddd6a9a78292c75162b08faa4943a320fc70aa1e03ee5950cb1bf3efb30f063214f53dea7eb8c212627da34357bc7e5af3dcbc9b55ccc50e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53706e8a84b0bdf087ec081f9140ecdbd36d8bc9ed41955751924c575ab9a8ba8dfe25bdbd2eafff8bbe8f3f4a9b1abb9cf60ee6a9a6707986ef04e5986967de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 08:42:31.593076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:42:31.593389) ========= 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=33d5923976266a1c518c4bf7000001ab-1465917485.376199-1137724145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:42:31.675294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 08:42:31.675662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 08:42:31.675934) ========= ========= Total master_lag: 0.18 =========