builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1467648108.38 results: success (0) buildid: 20160704063025 builduid: d18b97a71d7d4c68a2c280284a06a367 revision: a8e8182cf0001db745f02afed94fd60275054ccd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.380375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.380797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.381086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.410065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.410368) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 09:01:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-07-04 09:01:49 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.533595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.533907) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.583387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:48.583750) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a8e8182cf0001db745f02afed94fd60275054ccd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a8e8182cf0001db745f02afed94fd60275054ccd --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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 09:01:49,544 truncating revision to first 12 chars 2016-07-04 09:01:49,544 Setting DEBUG logging. 2016-07-04 09:01:49,544 attempt 1/10 2016-07-04 09:01:49,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a8e8182cf000?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 09:01:49,844 unpacking tar archive at: mozilla-aurora-a8e8182cf000/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630104 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:49.227452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:49.227766) ========= script_repo_revision: a8e8182cf0001db745f02afed94fd60275054ccd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:49.228156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:49.228420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:01:49.237184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-04 09:01:49.237575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:50 INFO - MultiFileLogger online at 20160704 09:01:50 in /builds/slave/test 09:01:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:50 INFO - {'append_to_log': False, 09:01:50 INFO - 'base_work_dir': '/builds/slave/test', 09:01:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:50 INFO - 'branch': 'Mozilla-Aurora', 09:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:50 INFO - 'config_files': ('talos/linux_config.py',), 09:01:50 INFO - 'default_actions': ('clobber', 09:01:50 INFO - 'read-buildbot-config', 09:01:50 INFO - 'download-and-extract', 09:01:50 INFO - 'populate-webroot', 09:01:50 INFO - 'create-virtualenv', 09:01:50 INFO - 'install', 09:01:50 INFO - 'run-tests'), 09:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:50 INFO - 'download_minidump_stackwalk': True, 09:01:50 INFO - 'download_symbols': 'ondemand', 09:01:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:50 INFO - 'installer_path': 'installer.exe', 09:01:50 INFO - 'log_level': 'info', 09:01:50 INFO - 'log_name': 'talos', 09:01:50 INFO - 'log_to_console': True, 09:01:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:50 INFO - 'opt_config_files': (), 09:01:50 INFO - 'pip_index': False, 09:01:50 INFO - 'sps_profile': False, 09:01:50 INFO - 'sps_profile_interval': 0, 09:01:50 INFO - 'suite': 'dromaeojs-e10s', 09:01:50 INFO - 'system_bits': '32', 09:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:50 INFO - 'title': 'talos-linux64-ix-041', 09:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:50 INFO - 'use_talos_json': True, 09:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:50 INFO - 'work_dir': 'build'} 09:01:50 INFO - ##### 09:01:50 INFO - ##### Running clobber step. 09:01:50 INFO - ##### 09:01:50 INFO - Running pre-action listener: _resource_record_pre_action 09:01:50 INFO - Running main action method: clobber 09:01:50 INFO - rmtree: /builds/slave/test/build 09:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:50 INFO - Running post-action listener: _resource_record_post_action 09:01:50 INFO - ##### 09:01:50 INFO - ##### Finished clobber step (success) 09:01:50 INFO - ##### 09:01:50 INFO - ##### 09:01:50 INFO - ##### Running read-buildbot-config step. 09:01:50 INFO - ##### 09:01:50 INFO - Running pre-action listener: _resource_record_pre_action 09:01:50 INFO - Running main action method: read_buildbot_config 09:01:50 INFO - Using buildbot properties: 09:01:50 INFO - { 09:01:50 INFO - "project": "", 09:01:50 INFO - "product": "firefox", 09:01:50 INFO - "script_repo_revision": "production", 09:01:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:01:50 INFO - "repository": "", 09:01:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:01:50 INFO - "buildid": "20160704063025", 09:01:50 INFO - "pgo_build": "True", 09:01:50 INFO - "basedir": "/builds/slave/test", 09:01:50 INFO - "buildnumber": 397, 09:01:50 INFO - "slavename": "talos-linux64-ix-041", 09:01:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:01:50 INFO - "platform": "ubuntu64_hw", 09:01:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:01:50 INFO - "branch": "mozilla-aurora", 09:01:50 INFO - "repo_path": "releases/mozilla-aurora", 09:01:50 INFO - "revision": "a8e8182cf0001db745f02afed94fd60275054ccd", 09:01:50 INFO - "stage_platform": "linux64-pgo", 09:01:50 INFO - "builduid": "d18b97a71d7d4c68a2c280284a06a367", 09:01:50 INFO - "slavebuilddir": "test" 09:01:50 INFO - } 09:01:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:01:50 INFO - Running post-action listener: _resource_record_post_action 09:01:50 INFO - ##### 09:01:50 INFO - ##### Finished read-buildbot-config step (success) 09:01:50 INFO - ##### 09:01:50 INFO - ##### 09:01:50 INFO - ##### Running download-and-extract step. 09:01:50 INFO - ##### 09:01:50 INFO - Running pre-action listener: _resource_record_pre_action 09:01:50 INFO - Running main action method: download_and_extract 09:01:50 INFO - mkdir: /builds/slave/test/build/tests 09:01: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')]} 09:01:50 INFO - https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:01:54 INFO - Downloaded 1361 bytes. 09:01:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:01:54 INFO - Using the following test package requirements: 09:01:54 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:01:54 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:54 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:01:54 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'jsshell-linux-x86_64.zip'], 09:01:54 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:54 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:01:54 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:01:54 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:01:54 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:54 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:01:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:54 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01:54 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')]} 09:01:54 INFO - https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:02:06 INFO - Downloaded 24526241 bytes. 09:02:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:02:07 INFO - Return code: 0 09:02:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:07 INFO - https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:02:08 INFO - Downloaded 24526241 bytes. 09:02:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:02:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:02:10 INFO - Return code: 0 09:02: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')]} 09:02:10 INFO - https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:02:11 INFO - Downloaded 10833369 bytes. 09:02:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:02:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:02:11 INFO - Return code: 0 09:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:11 INFO - https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:02:14 INFO - Downloaded 63609958 bytes. 09:02:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:02:14 INFO - mkdir: /builds/slave/test/properties 09:02:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:02:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:02:14 INFO - Contents: 09:02:14 INFO - build_url:https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:02:14 INFO - Running post-action listener: _resource_record_post_action 09:02:14 INFO - Running post-action listener: set_extra_try_arguments 09:02:14 INFO - ##### 09:02:14 INFO - ##### Finished download-and-extract step (success) 09:02:14 INFO - ##### 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running populate-webroot step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: populate_webroot 09:02:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:02:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:02:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:02:14 INFO - '--tppagecycles', 09:02:14 INFO - '7'], 09:02:14 INFO - 'tests': ['tsvgm']}}, 09:02:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:02:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:02:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:02:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:02:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['damp', 'tps']}, 09:02:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'tests': ['damp', 'tps']}, 09:02:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['dromaeo_dom']}, 09:02:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:02:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['a11yr', 09:02:14 INFO - 'ts_paint', 09:02:14 INFO - 'tpaint', 09:02:14 INFO - 'sessionrestore', 09:02:14 INFO - 'sessionrestore_no_auto_restore', 09:02:14 INFO - 'tabpaint']}, 09:02:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['tsvgx', 09:02:14 INFO - 'tsvgr_opacity', 09:02:14 INFO - 'tart', 09:02:14 INFO - 'tscrollx', 09:02:14 INFO - 'cart']}, 09:02:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:02:14 INFO - 'tsvgr_opacity', 09:02:14 INFO - 'tart', 09:02:14 INFO - 'tscrollx', 09:02:14 INFO - 'cart']}, 09:02:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'talos_options': ['--disable-e10s'], 09:02:14 INFO - 'tests': ['tp5o']}, 09:02:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'tests': ['tp5o']}, 09:02:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'talos_options': ['--disable-e10s', 09:02:14 INFO - '--xperf_path', 09:02:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:14 INFO - 'tests': ['tp5n']}, 09:02:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:14 INFO - 'talos_options': ['--xperf_path', 09:02:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:14 INFO - 'tests': ['tp5n']}}, 09:02:14 INFO - 'talos.zip': {'path': '', 09:02:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:02:14 INFO - Running post-action listener: _resource_record_post_action 09:02:14 INFO - ##### 09:02:14 INFO - ##### Finished populate-webroot step (success) 09:02:14 INFO - ##### 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running create-virtualenv step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: create_virtualenv 09:02:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:02:14 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 09:02:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:02:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:02:14 INFO - Using real prefix '/usr' 09:02:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:02:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:02:17 INFO - Installing pip.................done. 09:02:17 INFO - Return code: 0 09:02:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:17 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:17 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 09:02:17 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 09:02:17 INFO - Using env: {'DISPLAY': ':0', 09:02:17 INFO - 'HOME': '/home/cltbld', 09:02:17 INFO - 'LANG': 'en_US.UTF-8', 09:02:17 INFO - 'LANGUAGE': 'en_US:en', 09:02:17 INFO - 'LOGNAME': 'cltbld', 09:02:17 INFO - 'MAIL': '/var/mail/cltbld', 09:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:17 INFO - 'MOZ_NO_REMOTE': '1', 09:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:17 INFO - 'NO_EM_RESTART': '1', 09:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:17 INFO - 'PWD': '/builds/slave/test', 09:02:17 INFO - 'SHELL': '/bin/bash', 09:02:17 INFO - 'SHLVL': '1', 09:02:17 INFO - 'TERM': 'linux', 09:02:17 INFO - 'TMOUT': '86400', 09:02:17 INFO - 'USER': 'cltbld', 09:02:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:17 INFO - '_': '/tools/buildbot/bin/python'} 09:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:17 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 09:02:17 INFO - Cleaning up... 09:02:17 INFO - Return code: 0 09:02:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:17 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:17 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 09:02:17 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 09:02:17 INFO - Using env: {'DISPLAY': ':0', 09:02:17 INFO - 'HOME': '/home/cltbld', 09:02:17 INFO - 'LANG': 'en_US.UTF-8', 09:02:17 INFO - 'LANGUAGE': 'en_US:en', 09:02:17 INFO - 'LOGNAME': 'cltbld', 09:02:17 INFO - 'MAIL': '/var/mail/cltbld', 09:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:17 INFO - 'MOZ_NO_REMOTE': '1', 09:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:17 INFO - 'NO_EM_RESTART': '1', 09:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:17 INFO - 'PWD': '/builds/slave/test', 09:02:17 INFO - 'SHELL': '/bin/bash', 09:02:17 INFO - 'SHLVL': '1', 09:02:17 INFO - 'TERM': 'linux', 09:02:17 INFO - 'TMOUT': '86400', 09:02:17 INFO - 'USER': 'cltbld', 09:02:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:17 INFO - '_': '/tools/buildbot/bin/python'} 09:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:17 INFO - Downloading/unpacking psutil>=3.1.1 09:02:17 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 09:02:17 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 09:02:17 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 09:02:17 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 09:02:17 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 09:02:17 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 09:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:02:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:19 INFO - Installing collected packages: psutil 09:02:19 INFO - Running setup.py install for psutil 09:02:19 INFO - building 'psutil._psutil_linux' extension 09:02:19 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 09:02:20 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 09:02:20 INFO - building 'psutil._psutil_posix' extension 09:02:20 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 09:02:20 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 09:02:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:20 INFO - Successfully installed psutil 09:02:20 INFO - Cleaning up... 09:02:20 INFO - Return code: 0 09:02:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:20 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 09:02:20 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 09:02:20 INFO - Using env: {'DISPLAY': ':0', 09:02:20 INFO - 'HOME': '/home/cltbld', 09:02:20 INFO - 'LANG': 'en_US.UTF-8', 09:02:20 INFO - 'LANGUAGE': 'en_US:en', 09:02:20 INFO - 'LOGNAME': 'cltbld', 09:02:20 INFO - 'MAIL': '/var/mail/cltbld', 09:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:20 INFO - 'MOZ_NO_REMOTE': '1', 09:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:20 INFO - 'NO_EM_RESTART': '1', 09:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:20 INFO - 'PWD': '/builds/slave/test', 09:02:20 INFO - 'SHELL': '/bin/bash', 09:02:20 INFO - 'SHLVL': '1', 09:02:20 INFO - 'TERM': 'linux', 09:02:20 INFO - 'TMOUT': '86400', 09:02:20 INFO - 'USER': 'cltbld', 09:02:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:20 INFO - '_': '/tools/buildbot/bin/python'} 09:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:02:20 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 09:02:20 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 09:02:20 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 09:02:20 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 09:02:20 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 09:02:20 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 09:02:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:02:22 INFO - Installing collected packages: mozsystemmonitor 09:02:22 INFO - Running setup.py install for mozsystemmonitor 09:02:22 INFO - Successfully installed mozsystemmonitor 09:02:22 INFO - Cleaning up... 09:02:22 INFO - Return code: 0 09:02:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:02:22 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')]} 09:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:22 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')]} 09:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:22 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:22 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 09:02:22 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 09:02:22 INFO - Using env: {'DISPLAY': ':0', 09:02:22 INFO - 'HOME': '/home/cltbld', 09:02:22 INFO - 'LANG': 'en_US.UTF-8', 09:02:22 INFO - 'LANGUAGE': 'en_US:en', 09:02:22 INFO - 'LOGNAME': 'cltbld', 09:02:22 INFO - 'MAIL': '/var/mail/cltbld', 09:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:22 INFO - 'MOZ_NO_REMOTE': '1', 09:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:22 INFO - 'NO_EM_RESTART': '1', 09:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:22 INFO - 'PWD': '/builds/slave/test', 09:02:22 INFO - 'SHELL': '/bin/bash', 09:02:22 INFO - 'SHLVL': '1', 09:02:22 INFO - 'TERM': 'linux', 09:02:22 INFO - 'TMOUT': '86400', 09:02:22 INFO - 'USER': 'cltbld', 09:02:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:22 INFO - '_': '/tools/buildbot/bin/python'} 09:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:02:22 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 09:02:22 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 09:02:22 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 09:02:22 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 09:02:22 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 09:02:22 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 09:02:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:02:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:02:25 INFO - warning: no files found matching '*.txt' 09:02:25 INFO - no previously-included directories found matching 'build' 09:02:25 INFO - no previously-included directories found matching 'dist' 09:02:25 INFO - no previously-included directories found matching '.git*' 09:02:25 INFO - Installing collected packages: jsonschema, functools32 09:02:25 INFO - Running setup.py install for functools32 09:02:25 INFO - warning: no files found matching '*.txt' 09:02:25 INFO - no previously-included directories found matching 'build' 09:02:25 INFO - no previously-included directories found matching 'dist' 09:02:25 INFO - no previously-included directories found matching '.git*' 09:02:25 INFO - Successfully installed jsonschema functools32 09:02:25 INFO - Cleaning up... 09:02:25 INFO - Return code: 0 09:02:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:02:25 INFO - Using env: {'DISPLAY': ':0', 09:02:25 INFO - 'HOME': '/home/cltbld', 09:02:25 INFO - 'LANG': 'en_US.UTF-8', 09:02:25 INFO - 'LANGUAGE': 'en_US:en', 09:02:25 INFO - 'LOGNAME': 'cltbld', 09:02:25 INFO - 'MAIL': '/var/mail/cltbld', 09:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:25 INFO - 'MOZ_NO_REMOTE': '1', 09:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:25 INFO - 'NO_EM_RESTART': '1', 09:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:25 INFO - 'PWD': '/builds/slave/test', 09:02:25 INFO - 'SHELL': '/bin/bash', 09:02:25 INFO - 'SHLVL': '1', 09:02:25 INFO - 'TERM': 'linux', 09:02:25 INFO - 'TMOUT': '86400', 09:02:25 INFO - 'USER': 'cltbld', 09:02:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:25 INFO - '_': '/tools/buildbot/bin/python'} 09:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:02:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:27 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 09:02:28 INFO - Downloading docopt-0.6.1.tar.gz 09:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:28 INFO - Running setup.py install for blobuploader 09:02:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:02:28 INFO - Running setup.py install for requests 09:02:28 INFO - Running setup.py install for docopt 09:02:28 INFO - Successfully installed blobuploader requests docopt 09:02:28 INFO - Cleaning up... 09:02:28 INFO - Return code: 0 09:02:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02: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')]} 09:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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')]} 09:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:28 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:28 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 09:02:28 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 09:02:28 INFO - Using env: {'DISPLAY': ':0', 09:02:28 INFO - 'HOME': '/home/cltbld', 09:02:28 INFO - 'LANG': 'en_US.UTF-8', 09:02:28 INFO - 'LANGUAGE': 'en_US:en', 09:02:28 INFO - 'LOGNAME': 'cltbld', 09:02:28 INFO - 'MAIL': '/var/mail/cltbld', 09:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:28 INFO - 'MOZ_NO_REMOTE': '1', 09:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:28 INFO - 'NO_EM_RESTART': '1', 09:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:28 INFO - 'PWD': '/builds/slave/test', 09:02:28 INFO - 'SHELL': '/bin/bash', 09:02:28 INFO - 'SHLVL': '1', 09:02:28 INFO - 'TERM': 'linux', 09:02:28 INFO - 'TMOUT': '86400', 09:02:28 INFO - 'USER': 'cltbld', 09:02:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:28 INFO - '_': '/tools/buildbot/bin/python'} 09:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:28 INFO - Running setup.py (path:/tmp/pip-PIpQBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:29 INFO - Running setup.py (path:/tmp/pip-VkGn8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:29 INFO - Running setup.py (path:/tmp/pip-Zo4RDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:29 INFO - Running setup.py (path:/tmp/pip-pTwU3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:29 INFO - Running setup.py (path:/tmp/pip-ZXQQT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:29 INFO - Running setup.py (path:/tmp/pip-EsfdxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:29 INFO - Running setup.py (path:/tmp/pip-e6Mljn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:29 INFO - Running setup.py (path:/tmp/pip-D6qUh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:29 INFO - Running setup.py (path:/tmp/pip-KxW2Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:29 INFO - Running setup.py (path:/tmp/pip-4z0gIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:29 INFO - Running setup.py (path:/tmp/pip-jFfcKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:29 INFO - Running setup.py (path:/tmp/pip-s81UkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:29 INFO - Running setup.py (path:/tmp/pip-PlXefu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:29 INFO - Running setup.py (path:/tmp/pip-Bkzrzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:29 INFO - Running setup.py (path:/tmp/pip-0MUXWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:30 INFO - Running setup.py (path:/tmp/pip-7uyIfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:30 INFO - Running setup.py (path:/tmp/pip-CdH22o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:02:30 INFO - Running setup.py install for manifestparser 09:02:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Running setup.py install for mozcrash 09:02:30 INFO - Running setup.py install for mozdebug 09:02:30 INFO - Running setup.py install for mozdevice 09:02:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Running setup.py install for mozfile 09:02:30 INFO - Running setup.py install for mozhttpd 09:02:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Running setup.py install for mozinfo 09:02:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Running setup.py install for mozInstall 09:02:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:02:30 INFO - Running setup.py install for mozleak 09:02:31 INFO - Running setup.py install for mozlog 09:02:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Running setup.py install for moznetwork 09:02:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Running setup.py install for mozprocess 09:02:31 INFO - Running setup.py install for mozprofile 09:02:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Running setup.py install for mozrunner 09:02:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Running setup.py install for mozscreenshot 09:02:31 INFO - Running setup.py install for moztest 09:02:31 INFO - Running setup.py install for mozversion 09:02:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:02:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:02:31 INFO - Cleaning up... 09:02:31 INFO - Return code: 0 09:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:31 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')]} 09:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:31 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')]} 09:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:31 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:31 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 09:02:31 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 09:02:31 INFO - Using env: {'DISPLAY': ':0', 09:02:31 INFO - 'HOME': '/home/cltbld', 09:02:31 INFO - 'LANG': 'en_US.UTF-8', 09:02:31 INFO - 'LANGUAGE': 'en_US:en', 09:02:31 INFO - 'LOGNAME': 'cltbld', 09:02:31 INFO - 'MAIL': '/var/mail/cltbld', 09:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:31 INFO - 'MOZ_NO_REMOTE': '1', 09:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:31 INFO - 'NO_EM_RESTART': '1', 09:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:31 INFO - 'PWD': '/builds/slave/test', 09:02:31 INFO - 'SHELL': '/bin/bash', 09:02:31 INFO - 'SHLVL': '1', 09:02:31 INFO - 'TERM': 'linux', 09:02:31 INFO - 'TMOUT': '86400', 09:02:31 INFO - 'USER': 'cltbld', 09:02:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:31 INFO - '_': '/tools/buildbot/bin/python'} 09:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:32 INFO - Running setup.py (path:/tmp/pip-huJ5HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:32 INFO - Running setup.py (path:/tmp/pip-WWSJCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:32 INFO - Running setup.py (path:/tmp/pip-JdACxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:32 INFO - Running setup.py (path:/tmp/pip-KX2LSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:32 INFO - Running setup.py (path:/tmp/pip-Uw4du4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:32 INFO - Running setup.py (path:/tmp/pip-l3adPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:32 INFO - Running setup.py (path:/tmp/pip-kqEdND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:32 INFO - Running setup.py (path:/tmp/pip-BaMWwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:32 INFO - Running setup.py (path:/tmp/pip-YLVCY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:32 INFO - Running setup.py (path:/tmp/pip-OfrjEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:32 INFO - Running setup.py (path:/tmp/pip-xqPTdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:32 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)) 09:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:32 INFO - Running setup.py (path:/tmp/pip-xoT929-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:33 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)) 09:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:33 INFO - Running setup.py (path:/tmp/pip-pMllDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:33 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)) 09:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:33 INFO - Running setup.py (path:/tmp/pip-QNDt8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:33 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)) 09:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:33 INFO - Running setup.py (path:/tmp/pip-HRfR6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:33 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)) 09:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:33 INFO - Running setup.py (path:/tmp/pip-I79x_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:33 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)) 09:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:33 INFO - Running setup.py (path:/tmp/pip-OAdnPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:33 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)) 09:02:33 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)) 09:02:33 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)) 09:02:33 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)) 09:02:33 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)) 09:02:33 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)) 09:02:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:33 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 09:02:33 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 09:02:33 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 09:02:33 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 09:02:33 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 09:02:33 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 09:02:35 INFO - Downloading blessings-1.6.tar.gz 09:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:35 INFO - Installing collected packages: blessings 09:02:35 INFO - Running setup.py install for blessings 09:02:35 INFO - Successfully installed blessings 09:02:35 INFO - Cleaning up... 09:02:35 INFO - Return code: 0 09:02:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:35 INFO - Reading from file tmpfile_stdout 09:02:35 INFO - Current package versions: 09:02:35 INFO - argparse == 1.2.1 09:02:35 INFO - blessings == 1.6 09:02:35 INFO - blobuploader == 1.2.4 09:02:35 INFO - docopt == 0.6.1 09:02:35 INFO - functools32 == 3.2.3-2 09:02:35 INFO - jsonschema == 2.5.1 09:02:35 INFO - manifestparser == 1.1 09:02:35 INFO - mozInstall == 1.12 09:02:35 INFO - mozcrash == 0.17 09:02:35 INFO - mozdebug == 0.1 09:02:35 INFO - mozdevice == 0.48 09:02:35 INFO - mozfile == 1.2 09:02:35 INFO - mozhttpd == 0.7 09:02:35 INFO - mozinfo == 0.9 09:02:35 INFO - mozleak == 0.1 09:02:35 INFO - mozlog == 3.2 09:02:35 INFO - moznetwork == 0.27 09:02:35 INFO - mozprocess == 0.22 09:02:35 INFO - mozprofile == 0.28 09:02:35 INFO - mozrunner == 6.11 09:02:35 INFO - mozscreenshot == 0.1 09:02:35 INFO - mozsystemmonitor == 0.3 09:02:35 INFO - moztest == 0.7 09:02:35 INFO - mozversion == 1.4 09:02:35 INFO - psutil == 3.1.1 09:02:35 INFO - requests == 1.2.3 09:02:35 INFO - wsgiref == 0.1.2 09:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:35 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 09:02:35 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 09:02:35 INFO - Using env: {'DISPLAY': ':0', 09:02:35 INFO - 'HOME': '/home/cltbld', 09:02:35 INFO - 'LANG': 'en_US.UTF-8', 09:02:35 INFO - 'LANGUAGE': 'en_US:en', 09:02:35 INFO - 'LOGNAME': 'cltbld', 09:02:35 INFO - 'MAIL': '/var/mail/cltbld', 09:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:35 INFO - 'MOZ_NO_REMOTE': '1', 09:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:35 INFO - 'NO_EM_RESTART': '1', 09:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:35 INFO - 'PWD': '/builds/slave/test', 09:02:35 INFO - 'SHELL': '/bin/bash', 09:02:35 INFO - 'SHLVL': '1', 09:02:35 INFO - 'TERM': 'linux', 09:02:35 INFO - 'TMOUT': '86400', 09:02:35 INFO - 'USER': 'cltbld', 09:02:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:35 INFO - '_': '/tools/buildbot/bin/python'} 09:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:35 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)) 09:02:36 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)) 09:02:36 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)) 09:02:36 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)) 09:02:36 INFO - Cleaning up... 09:02:36 INFO - Return code: 0 09:02:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:36 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:36 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 09:02:36 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 09:02:36 INFO - Using env: {'DISPLAY': ':0', 09:02:36 INFO - 'HOME': '/home/cltbld', 09:02:36 INFO - 'LANG': 'en_US.UTF-8', 09:02:36 INFO - 'LANGUAGE': 'en_US:en', 09:02:36 INFO - 'LOGNAME': 'cltbld', 09:02:36 INFO - 'MAIL': '/var/mail/cltbld', 09:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:36 INFO - 'MOZ_NO_REMOTE': '1', 09:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:36 INFO - 'NO_EM_RESTART': '1', 09:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:36 INFO - 'PWD': '/builds/slave/test', 09:02:36 INFO - 'SHELL': '/bin/bash', 09:02:36 INFO - 'SHLVL': '1', 09:02:36 INFO - 'TERM': 'linux', 09:02:36 INFO - 'TMOUT': '86400', 09:02:36 INFO - 'USER': 'cltbld', 09:02:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:36 INFO - '_': '/tools/buildbot/bin/python'} 09:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:02:36 INFO - Cleaning up... 09:02:36 INFO - Return code: 0 09:02:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:36 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 0x7f53055e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1351350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', '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 09:02:36 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 09:02:36 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 09:02:36 INFO - Using env: {'DISPLAY': ':0', 09:02:36 INFO - 'HOME': '/home/cltbld', 09:02:36 INFO - 'LANG': 'en_US.UTF-8', 09:02:36 INFO - 'LANGUAGE': 'en_US:en', 09:02:36 INFO - 'LOGNAME': 'cltbld', 09:02:36 INFO - 'MAIL': '/var/mail/cltbld', 09:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:36 INFO - 'MOZ_NO_REMOTE': '1', 09:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:36 INFO - 'NO_EM_RESTART': '1', 09:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:36 INFO - 'PWD': '/builds/slave/test', 09:02:36 INFO - 'SHELL': '/bin/bash', 09:02:36 INFO - 'SHLVL': '1', 09:02:36 INFO - 'TERM': 'linux', 09:02:36 INFO - 'TMOUT': '86400', 09:02:36 INFO - 'USER': 'cltbld', 09:02:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:36 INFO - '_': '/tools/buildbot/bin/python'} 09:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:36 INFO - Downloading/unpacking flake8 09:02:36 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 09:02:36 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 09:02:36 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 09:02:36 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 09:02:36 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 09:02:36 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 09:02:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:02:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:02:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 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 09:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:39 INFO - no previously-included directories found matching 'docs/_build' 09:02:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:02:39 INFO - Running setup.py install for pep8 09:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:39 INFO - no previously-included directories found matching 'docs/_build' 09:02:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:02:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:02:39 INFO - Cleaning up... 09:02:39 INFO - Return code: 0 09:02:39 INFO - Running post-action listener: _resource_record_post_action 09:02:39 INFO - Running post-action listener: _start_resource_monitoring 09:02:39 INFO - Starting resource monitoring. 09:02:39 INFO - ##### 09:02:39 INFO - ##### Finished create-virtualenv step (success) 09:02:39 INFO - ##### 09:02:39 INFO - ##### 09:02:39 INFO - ##### Running install step. 09:02:39 INFO - ##### 09:02:39 INFO - Running pre-action listener: _resource_record_pre_action 09:02:39 INFO - Running main action method: install 09:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:39 INFO - Reading from file tmpfile_stdout 09:02:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:02:39 INFO - Reading from file tmpfile_stdout 09:02:39 INFO - Output received: 09:02:39 INFO - Usage: mozinstall [options] installer 09:02:39 INFO - Options: 09:02:39 INFO - -h, --help show this help message and exit 09:02:39 INFO - -d DEST, --destination=DEST 09:02:39 INFO - Directory to install application into. [default: 09:02:39 INFO - "/builds/slave/test"] 09:02:39 INFO - --app=APP Application being installed. [default: firefox] 09:02:39 INFO - mkdir: /builds/slave/test/build/application 09:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:02:55 INFO - Reading from file tmpfile_stdout 09:02:55 INFO - Output received: 09:02:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:02:55 INFO - Running post-action listener: _resource_record_post_action 09:02:55 INFO - ##### 09:02:55 INFO - ##### Finished install step (success) 09:02:55 INFO - ##### 09:02:55 INFO - ##### 09:02:55 INFO - ##### Running run-tests step. 09:02:55 INFO - ##### 09:02:55 INFO - Running pre-action listener: _resource_record_pre_action 09:02:55 INFO - Running main action method: run_tests 09:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:02:55 INFO - Python 2.7.3 09:02:55 INFO - Return code: 0 09:02:55 INFO - grabbing minidump binary from tooltool 09:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:55 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 0x13e01c0>, '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 0x13e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:02:55 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 09:02:55 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 09:02:55 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 09:02:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:55 INFO - Return code: 0 09:02:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:02:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:02:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:02:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:02:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:02:56 INFO - Return code: 0 09:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 09:02:56 INFO - Using env: {'DISPLAY': ':0', 09:02:56 INFO - 'HOME': '/home/cltbld', 09:02:56 INFO - 'LANG': 'en_US.UTF-8', 09:02:56 INFO - 'LANGUAGE': 'en_US:en', 09:02:56 INFO - 'LOGNAME': 'cltbld', 09:02:56 INFO - 'MAIL': '/var/mail/cltbld', 09:02:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:02:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:56 INFO - 'MOZ_NO_REMOTE': '1', 09:02:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:56 INFO - 'NO_EM_RESTART': '1', 09:02:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:56 INFO - 'PWD': '/builds/slave/test', 09:02:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:02:56 INFO - 'SHELL': '/bin/bash', 09:02:56 INFO - 'SHLVL': '1', 09:02:56 INFO - 'TERM': 'linux', 09:02:56 INFO - 'TMOUT': '86400', 09:02:56 INFO - 'USER': 'cltbld', 09:02:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736', 09:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:56 INFO - '_': '/tools/buildbot/bin/python'} 09:02:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:02:56 INFO - mozversion application_buildid: 20160704063025 09:02:56 INFO - mozversion application_changeset: a8e8182cf0001db745f02afed94fd60275054ccd 09:02:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:02:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:56 INFO - mozversion application_name: Firefox 09:02:56 INFO - mozversion application_remotingname: firefox-dev 09:02:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:02:56 INFO - mozversion application_vendor: Mozilla 09:02:56 INFO - mozversion application_version: 49.0a2 09:02:56 INFO - mozversion platform_buildid: 20160704063025 09:02:56 INFO - mozversion platform_changeset: a8e8182cf0001db745f02afed94fd60275054ccd 09:02:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:02:56 INFO - mozversion platform_version: 49.0a2 09:02:56 INFO - using testdate: 1467648176 09:02:56 INFO - actual date: 1467648176 09:02:56 INFO - starting webserver on 'localhost:53435' 09:02:56 INFO - SUITE-START | Running 2 tests 09:02:56 INFO - TEST-START | dromaeo_css 09:02:56 INFO - operating with platform_type : linux_ 09:02:56 INFO - Initialising browser for dromaeo_css test... 09:02:56 INFO - TEST-INFO | started process 13275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiDeHCh/profile http://localhost:53435/getInfo.html) 09:03:01 INFO - PROCESS | 13275 | __metrics Screen width/height:1600/1200 09:03:01 INFO - PROCESS | 13275 | colorDepth:24 09:03:01 INFO - PROCESS | 13275 | Browser inner width/height: 1024/697 09:03:01 INFO - PROCESS | 13275 | __metrics 09:03:01 ERROR - PROCESS | 13275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:03:02 INFO - TEST-INFO | 13275: exit 0 09:03:02 INFO - Browser initialized. 09:03:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:02 INFO - TEST-INFO | started process 13403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiDeHCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:14 INFO - PROCESS | 13403 | RSS: Main: 155881472 09:03:14 INFO - PROCESS | 13403 | 09:04:04 INFO - PROCESS | 13403 | 1467648244128 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] 09:06:12 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53435/tests/dromaeo/cssquery-ext.html) 09:06:13 INFO - PROCESS | 13403 | RSS: Main: 158969856 09:06:13 INFO - PROCESS | 13403 | 09:09:15 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-ext.html (next: http://localhost:53435/tests/dromaeo/cssquery-jquery.html) 09:09:15 INFO - PROCESS | 13403 | RSS: Main: 157270016 09:09:15 INFO - PROCESS | 13403 | 09:12:17 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53435/tests/dromaeo/cssquery-mootools.html) 09:12:17 INFO - PROCESS | 13403 | RSS: Main: 157159424 09:12:17 INFO - PROCESS | 13403 | 09:15:19 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53435/tests/dromaeo/cssquery-prototype.html) 09:15:20 INFO - PROCESS | 13403 | RSS: Main: 156680192 09:15:20 INFO - PROCESS | 13403 | 09:18:22 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53435/tests/dromaeo/cssquery-yui.html) 09:18:23 INFO - PROCESS | 13403 | RSS: Main: 158609408 09:18:23 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | Cycle 1(1): loaded http://localhost:53435/tests/dromaeo/cssquery-yui.html (next: http://localhost:53435/tests/dromaeo/cssquery-dojo.html) 09:21:25 INFO - PROCESS | 13403 | RSS: Main: 159027200 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | __start_tp_report 09:21:25 INFO - PROCESS | 13403 | _x_x_mozilla_page_load 09:21:25 INFO - PROCESS | 13403 | _x_x_mozilla_page_load_details 09:21:25 INFO - PROCESS | 13403 | |i|pagename|runs| 09:21:25 INFO - PROCESS | 13403 | |0;dojo.html;3343.515190297406;3421.31573685263;3443.345764304782;3449.603295621003;3464.3417750627364;5775.364709881909;5799.2750906136735;5839.737211825467;5874.853128671774;5915.674637894914;5823.883522329562;5851.3563508014195;5875.559333050017;5906.025505791539;5911.438413350736;5235.031519168956;5287.444818294081;5308.416074231832;5320.228566857803;5329.280547126146;5151.6908985460805;5166.328377310944;5325.680459172443;5349.197620356958;5358.705271210082;5176.352955880515;5184.300119483878;5209.062368773619;5280.656757310762;5285.814996475124;5220.504052115062;5257.894842103136;5267.947320526784;5269.920951185735;5275.86810329741;5201.765920533585;5273.839755253876;5290.761915713802;5324.627276090675;5327.627066105335;5497.202905578669;5498.80754173606;5526.889462210734;5549.19536667185;5726.942730572682;6164.4143806338325;6167.259928808527;6183.6598987055695;6186.783462578788;6201.72092255845;6209.429577992627;6214.813555593294;6222.533310001768;6225.785971735513;6243.751249750068;5626.381098079208;5715.485606295411;5786.103154011135;5809.477147056785;5858.912116318259;6369.554131210771;6390.8721825563225;6401.391867772554;6403.359664033559;6418.775342862978;5940.524758019435;6107.6640784757265;6144.846378840565;6183.165272688219;6188.721507532172;6163.414475624809;6179.104029915637;6230.563860529719;6344.524160687967;6365.013422919455;6220.657863817443;6251.499880009588;6283.088952102011;6297;6321.8735625288155;5924.911126333109;6121.632702037892;6265.4361107499635;6272.40412160844;6293.874122517524;4679.789409476582;4734.573888350065;4741.810327586858;4743.478217396084;4754.833580824724;4213.494380674278;4249.702520823575;4254.234237837219;4256.574342565718;4267.637250833714;5886.970565147232;5892.823215303548;5921.052631578927;6105.175801266772;6124.11200375943;6103;6140.083460356295;6164.537659675542;6219;6297.811065668037;6069.939300606938;6070.817875463743;6073.423024812724;6082;6115.480184184395;5164.25118357836;5211.374635043819;5338.412774594792;5399.217113518518;5401.459854014645;6333.081703153109;6509.153810004764;6518.217813862367;6535.8692826143215;6553.148090748172;6318.968405158037;6322.336154703874;6328.114064030948;6329.936700632935;6336.58812177207;6252.437280644764;6364.236291645032;6392.584482008655;6567.671616419256;6571.901421478586;6172.043333283348;6177.135201071764;6183.041628547582;6187.16473276102;6230.59501132425;6276.215473065867;6277.435030847246;6283.842903927439;6285.528585356208;6294.5279104068295;5905.793297234576;5999.640021598718;6032.245969253843;6060.878782424415;6136.9873970794315;6036.215292012011;6115.388461153849;6122.173506576555;6127.571070025056;6162.876742465215;5958.19564358806;6035.39646035393;6037.366076561898;6039.761848820894;6051.848703782441;5874.118882167709;6031.638101713911;6072.271327440735;6121.666376154749;6209.627422354673;6024.638521688713;6038.426349496791;6066.817995460143;6074;6077.149199112217 09:21:25 INFO - PROCESS | 13403 | |1;ext.html;592.3336246722437;632.8006677896462;639.4404895716249;653.9051837483563;677.7526202935929;42877.35683964739;46029.30956035662;46134.30798538025;46471;46534.767326163324;46845.297320540216;47305;47491.52508474914;47675.28487072688;47699;8964.01395846458;9059.048799876016;9071;9098.909010909905;9107.453552786854;8935.106489351077;8937.240334571537;9004.68483603074;9059.320550958671;9059.59231834569;9007.864882026775;9072.092790720908;9074.682386116487;9086.04596517366;9131.771705707377;8943.95528022359;8965.95517022414;9027.45835249887;9029.548522573878;9038.186563209343;8915.242204412632;8945.64217431302;9029.503377314246;9038.186563209343;9038.231750301233;42555.57444425547;42759.57240427618;42865;43205.35191972123;43410;3860.343741563941;3947.980260098681;4493.41585593874;4505.954940450619;4587.288970209623;34159.65840341614;34364.48453273203;34713;34934.82532587346;34936.65063349359;4693.389859318267;4770.260609605517;4840.249761287007;4856.490068542823;4860.684055536379;367189;367235;370176;370176;370714;35610.821945890624;64412.677936610016;65241.347586524476;65297.673511632136;65456.34543654598;37475.06312342159;39165.21669566593;39184;39199.80400098038;39298.01754956149;16589.91705041491;16949.915250423917;16950.915245423694;16959.660806784043;17065.06142162168;15015.699686006219;15037.699246015018;15054.322555485029;15076.849231507764;15099;9042.683506077386;9093.77265568366;9094.272458203328;9167.44995300284;9234;3482.7387945904156;3503.579570451562;3506.50908872758;3531.7351198660203;3557.4130268505405;966.3090890013533;1038.1953985661023;1042.2704107125044;1106.2201148190507;1157.4039369724599;33251;33308.167295817315;33702;34052.48921266183;34254.14364640854;1126.4536699700639;1131.603938621476;1222.6515443098851;1236.7650146472142;1246.052999720219;17582.38461653836;17678.558036049202;17734.822651773575;17819.643607128044;17847.643047138983;575366;649322;652139;653811;984850;60841.69579152076;61521.38478615157;61667.69166154141;61849.69075154595;61896.69051654803;1417.6101572067557;1423.3879431844407;1423.5800438870558;1424.5583869000436;1441.0489077208993;31627.20931976719;32459.350812983135;32566.511502327012;33097.669023309456;33141;53377.73311133419;53608;53702.194467083806;54067.72966135144;54155.18767218573;435924;440326;442008;443501;443752;29791.106266812032;30810;30889.69110308868;30995.0701478956;31057.223569410944;48867;50193.74903125461;50297.24554131618;50324.66235115585;50493.74753126211;41195.58804411918;41858.37212441755;42720;43009.56990430056;43742.343864841416;41587;41638.791806040776;42384.7284581463;42459.15081698287;42946.57053429426;41911.7904410476;42339.1532169361;42354.78822605991;42792.358114627685;42998;36000;36227;36577.050360431436;37636.435453468766;37766.62233377631;28645.140645779826;28761.856190718914;29021;29110.27224319409;29356.266093347836 09:21:25 INFO - PROCESS | 13403 | |2;jquery.html;416.46692233940564;424.7005860868088;428.72133113476235;428.7941787941788;448.55368907936605;18531;19636.803631963692;20167.39497815064;20308.18767249308;20521;19409.611807763835;19419.611607767834;19470;20232;20240.190392384324;5799.217105690741;6002.609830361012;6003.909941350883;6026.819195424122;6043.244594425697;4666.580007799297;5919.763209471616;5980.431858973412;6256.968715156418;6317.1156038154695;5988.341282458926;6196.285624397608;6322.1149039134325;6376.39424254695;6440.581362211465;6073.969630151821;6092.6953652317425;6100.786472473486;6106.084087386883;6114.663693496856;5816.796412125597;5858.443447872445;5904.911426328608;5948.405159484017;5949.9702501487645;14386.208758518382;14628.41486340545;14717.116972981548;14811;14954.40182392703;2300.3559003479054;2329.417645588586;2437;2508.7240403555593;2534.4677617700304;10653.946730266376;11308.830367544493;11699.18105732599;14130.22283774392;15379.154146521936;2039.7246371739773;2109.789021097893;2120.416885356524;2166.155199472207;2208.9558208835733;84601;87324.12675873288;87659;87880.99999999936;88255;11170.944145279222;11271.09831213501;11493.195476316578;11620.53517859293;11670.824937625943;15792.447264345692;15830.44593439224;15901.52295431139;15938.123403212934;15986.280617372246;8476.321894248445;8705.608247628872;8724.520151391735;8736.388452808242;8755.693550725695;8295.12901145371;8376.49741015541;8437.535935523483;8469.32245420365;8559.614817333111;4828.806847726122;4883.853484395474;4888.9755551222015;4997.800087996512;5011.473795251519;2043.1725151313742;2064.2465500092358;2090.393785802131;2108.15673730506;2176.62997290461;932.8320902237526;1011.3729487717515;1023.5547536821507;1067.754416484213;1108.0415440643785;19111.33110341159;19118.426447206606;19837.40487785369;19839.107240174228;19976.90011549962;993.3344659078434;998.930074894765;1003.2776400991274;1023.2428003277521;1107.5791199344199;10903.618373357052;11080.390578518098;11206.775864482828;11226.382548959886;11286.830697539543;498097;505998;516664;524372;544580;97493.5125324383;101688.49155754174;101709;101710;101750;1052.1372474570778;1060.0777323728405;1066.1044722433194;1078.9352638841694;1082.09644946469;17442.563935901704;17763.644727105642;17808.55478612993;17931.641367172324;18059.458216253533;41191.7940410296;42033.36949945692;42745;43697.126057479305;43713.78143109264;59872.40127598668;60051.39948600458;60747;61011;61486.69256653688;7202.96398518004;7775.92224077752;7778.533288002738;7819.218078192135;7994.120646728971;9332.20676242527;12158.513659453876;12595.11834171636;12785.36073196318;12888.162269452456;10713.625023124154;11173.385463799244;11353.772924541297;11505.712357191138;11635.47640356169;10421.739456513647;11044.447777611247;11241.55033798639;11411.942940285577;11815.172937894265;11098.944505277423;11465.14011449128;11467.426628668367;11590.88409115898;11716.121290903046;7804.570748608654;7845.176256492986;7905.802354941173;7981.281684648409;8016.358691304798;10687.198460115367;10724.088452481627;10850.728731781768;11037.922555624502;11263.26788758728 09:21:25 INFO - PROCESS | 13403 | |3;mootools.html;1535.14799286396;1557.4704600435853;1723.8189990051044;1798.2267624921278;1847.0303090877287;8627.611757470913;9333.5799889005;9405.435673859572;10024.699259022233;10056.648017319396;9396.624135034608;9627.518624068804;9692.27307951903;9733.902660973388;9745;2473.233297677721;2506.749325067497;2509.29739672891;2509.6110102934076;2509.8870550825163;2374.489484760776;2469.09877894569;2472.2830379190104;2472.3695457658364;2482.453860150764;2434.914777982771;2443.609022556391;2476.2199907029317;2478.0583378316214;2485.391079185602;2404.386881345263;2437.3297343230665;2447.3147518694796;2466;2497.962530562043;2465.2111324376206;2476.2818782553036;2489.240781561623;2494.5260400523844;2502.962455563168;9574;9603.903960960371;9637.662681806103;9663.226941844636;9678.17735492484;5716.256886604757;5717.542596592304;5725.6278341908055;5753.223314852525;5760.53915686744;3534.2578058607464;3619.9683090319395;3661.9929519382117;3667.7799332040163;3703.6481534254203;1203.127732394016;1221.450347343699;1239.1883316427754;1254.9184303020274;1279.852816926047;13987.65030874226;14011.71976560463;14027.71944561103;14030.088044277192;14033.228172450512;4887.95112048882;4898.608111351084;4984.40187177541;4995.625328100407;5012.1980483122525;11614.941925290319;11672.88327116735;11694.239874408137;11700.414979251003;11714.180007399571;5808.273965754281;5808.5353171747;5811.041178205549;5820.912686309709;5831.358550559435;4636.466806317249;4968.801247950114;5095.464976177522;5127.102757017507;5190.8961820764125;4328.026194106364;4360.367746676714;4392.857856957214;4401.889952751143;4416.138852923713;1361.7821148616174;1362.3188405797102;1386.202933313349;1389.8401683806492;1391.5755694513068;917.3853518142861;1032.8244198486275;1034.0486752188006;1041.8853926068127;1041.9218558607984;6473.255575608865;6603;6667.833304167435;6685.832854178684;6724.529282950147;475.2016612091719;475.8881662809237;482.85755702067974;488.66282265236873;493.87406211415856;4455.710378825366;4545.568171023748;4571.817127314936;4622;4700.788464519105;11974.281543107441;12329;12355.25868447896;12469.189502682297;12518.687032824253;11913.22564033335;12298.20061695987;12304.507819687113;12413.44139513724;12424.130310878332;8829.911700883038;8975.057618950046;9073.364864459425;9085.954570227106;9291.396059256262;6436.274093572322;6543.378379053982;6689.46484281266;6696.83257918556;6699;11280.153988451064;11342.716432089264;11431.256968297033;11595.942020289845;11631.88368116308;11658.708532286422;11693.181477296508;11764.70588235301;11772.234804738007;11784.351860647746;8394.24451799341;8920.776980575538;9165.083491650781;9255.814883702424;9375.484348360906;9260.212881905114;9355;9393.154616084585;9430.52847357643;9464.432134071978;8270.875936860832;8468.195521425454;8529.786755331166;8624.956875215585;8710.608022639124;8213.3429325655;8305.46014509055;8435.156484351515;8534.146585341416;8623.353248506262;7710.498817576839;7712.421568382281;7738.535687858746;7772.961135194514;7798.064232292161;5557.833265002057;5600.35595906476;5682.6306290091015;5688.943110569007;5735.71321433935;5539.695316757617;5630.0991841305195;5665.971670141623;5691.943080569307;5697.686627235542 09:21:25 INFO - PROCESS | 13403 | |4;prototype.html;351.35526309222575;354.6205560050745;358.06187787995447;358.20835952544877;358.51958375776456;5820.301563812343;5840.766369345227;5883.823235352925;5914.290285165781;5958.79144229952;5747.885042299152;5798.217240672508;5814.331351894533;5821.970890145554;5835.708214589265;4529.388532548113;4530.411046563959;4542.364069030338;4543.523354909659;4551.954480455186;4539.319102134673;4550.431196100488;4574.1080489304595;4592.471865735433;4602.516735742749;4498.752568608726;4513.007138429541;4539;4562.931556026662;4570.13167498176;4347.60871521563;4461.442319710036;4470.982087091201;4475.418195634563;4488.596026357611;3978.204359128157;4003.11931375097;4007.5591684914634;4015.7791321477307;4025.5169379674626;5548.223248745179;5552.972235138798;5563.471470210324;5605.2713147291;5637.887242255132;5082.390113186404;5085.898282034375;5110.565601923841;5134.074721979257;5188.377394712658;6017.826523827855;6049.667268300242;6056.06131049688;6065.302490213638;6069.302030266532;4324.9135017299795;4410.977945110286;4411.426514553087;4413.757243351614;4467.173572889026;6097.237845269341;6265.185525881606;6283.8743225135695;6291.6854157291955;6299.37006299371;4404.405405270248;4435.600795928382;4446.977765111218;4455.6212721918355;4467.843625473093;4469.664775141878;4489.820407183742;4494.303382975644;4499.3251012347755;4522.276435770261;5073.492650734897;5076.340075790124;5108.208227724708;5183.222516622537;5189.8202754842305;6045.186444066762;6057.454829065317;6073.878522429527;6114.938850611526;6121.4490695837585;1531.6170957260686;1555.199072477675;1560.54744124205;1562.960925976837;1565.622252417865;948.3219498058783;975.2831668723483;995.3082607587802;1001.5392919257223;1006.2754816532085;5274.789008439696;5369.301990741257;5385.946140538545;5385.946140538623;5455.426695514444;5528.502434780889;5563.248961390242;5601.7759289628775;5656.575756818255;5657.878295639135;5328.600354973315;5363.624546281801;5626.437356264422;6079.331273559905;6092;3349.782264152871;3368.949465758016;3369.258763072169;3384.1708781348234;3386.745994050456;6353.8729225416155;6605.339466053452;6618.172728408949;6630.336966303331;6659.86680266392;6458.418742313121;6482.222133344029;6490.805275841638;6507.219133703986;6508.9023664645065;6388.488920886318;6624.701888415033;6628.5691430056895;6636.402723754885;6651.26836048044;6302.1492098566105;6321.557490975588;6365.490760739222;6389.137466442156;6389.2652344980925;5974.342822289632;6258.5591619269435;6270.184875966095;6333.809985700436;6347.714352854225;6396.776112836028;6546.476281897532;6573.3426657333885;6599.208095028627;6609.173853268341;4482.731036137842;4534.841280555164;4535.6371490280035;4551.089782043538;4557.5442455754155;6212.782552610637;6346.9682651586445;6387;6394.962392863353;6427.228732551936;6135.423122288738;6200;6204.534659900435;6223.0354295084335;6247;5906.0255057914965;6144.723487443165;6172.197614310111;6179.412955769195;6198.752049918133;5969.791057312973;6077.604955677867;6138;6152.415520525543;6153.338598578269;6236.220472440945;6236.968815155895;6264.874702506016;6289;6307.936920630918;5699.572532060195;6053.909191362045;6119.3268740437625;6163.414475624809;6205.441510264098 09:21:25 INFO - PROCESS | 13403 | |5;yui.html;778.7157687444085;794.7297918707642;808.0505406147777;873.7859224489999;886.9955650221748;14092.506762263323;14915.25423728812;15060.171690557016;15573.221338933037;15693.921530392361;16241.187940602953;16295.185240737976;16360.672786544292;16522.42171523997;16533.090680012596;831.418007394823;860.513809697522;860.802015536427;861.0657436681178;862.5859587398053;875.155474966657;882.1399135842566;882.9690960816373;885.3669626217253;887.2502735188755;915.7161280003187;918.7060140754961;919.1314208073373;919.1406035356963;919.4345477531303;908.0556221529635;908.913653202948;913.2465715784471;917.7705573606598;918.1048477734222;665.930077341877;669.2136739331315;671.3219648155398;674.9628770417625;676.0569006236273;14742.11547307165;14749.557513274618;14794.186319752409;14884.181370024644;14904.478343257933;15743.291551880078;15855.52433426999;15933.760993585105;15940.681186376207;15988.680226395523;12292.938535307356;12397.318147501885;12440.377981100908;12493.437795299233;12610.558630447891;4058.3506638937924;4067.2678917794783;4103.179364127186;4120.690948178899;4177.039280965365;68813;71052.6447367765;71058.28941710568;80503;80637.19362806356;12638.684032899251;12712.936435317764;13141.934290328487;13152.868471315356;13361.73276534464;22692.338245223775;22737.658935115654;22775.544489110125;22934.541309173725;23049.88475057614;9684.70945871625;9741.123298903132;9810.852837207447;9821.607135714492;9917.30578859473;5129.307543481582;5174.818881339135;5255.684658920477;5282.894342113136;5337.172738225581;3829.4447305140598;3900.063984643665;3938.1139243669945;3949.150932549516;3973.8609148679657;667.1627107979455;670.4468813229008;686.9587824730532;686.9793906182822;687.9346462086094;642.9003504456816;741.9814504637427;765.5253742679463;774.9690012399441;775.6238224461132;10083.546240419199;10659.307145035547;11403.828942565868;11474.827877581843;11905.940470297766;775.1279810213509;779.111812533712;781.839722856813;813.5525460996547;822.5722624235364;4903.41159060915;5264.947350526522;5305.814296499604;5306.8938621228135;5327.493888080626;73929.26070739224;74666;74667;86997;110323.44838275758;77207.61396192983;99599.50200248952;101245;102044.48977755064;102242;89750;89776.10223897677;89863.10136898547;91304.54347728351;92050.53974730083;10017.248706346907;10058;10139.797204056025;10171.847422288523;10176.796464070529;48501.514984851114;51254.74372628113;51279.743601281756;53160;53438.465615343346;49267;72453.637731811;72674.27325726674;73677.26322736705;75806.62096689481;13943.58169254924;13962.58112256634;14253;14479.131252124906;14486.710265794836;15591.922040389725;15721.292541835874;16734.4142954996;16795.496135115965;16816.495505134866;14449.338335978062;14806.925965370105;14916.701665966402;15712.76430853561;16028.278727457526;14667.266636667911;14761.630959226106;14819.110853348833;15283.083015019134;15401.76897346563;14519.419223230952;14564.344604493035;14642.056612381592;14644.41422343137;14672;11889.583864564698;11915.642530723746;12352.197107188364;12451.25292482454;12668;12449.564265250672;12531.373431328579;12591.811122832982;12823.422945967268;12919.22484650924 09:21:25 INFO - PROCESS | 13403 | __end_tp_report 09:21:25 INFO - PROCESS | 13403 | __start_cc_report 09:21:25 INFO - PROCESS | 13403 | _x_x_mozilla_cycle_collect,336 09:21:25 INFO - PROCESS | 13403 | __end_cc_report 09:21:25 INFO - PROCESS | 13403 | __startTimestamp1467649285933__endTimestamp 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | ------- Summary: start ------- 09:21:25 INFO - PROCESS | 13403 | Number of tests: 6 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#0] dojo.html Cycles:165 Average:5786.46 Median:6051.85 stddev:666.04 (11.0%) stddev-sans-first:639.92 09:21:25 INFO - PROCESS | 13403 | Values: 3343.5 3421.3 3443.3 3449.6 3464.3 5775.4 5799.3 5839.7 5874.9 5915.7 5823.9 5851.4 5875.6 5906.0 5911.4 5235.0 5287.4 5308.4 5320.2 5329.3 5151.7 5166.3 5325.7 5349.2 5358.7 5176.4 5184.3 5209.1 5280.7 5285.8 5220.5 5257.9 5267.9 5269.9 5275.9 5201.8 5273.8 5290.8 5324.6 5327.6 5497.2 5498.8 5526.9 5549.2 5726.9 6164.4 6167.3 6183.7 6186.8 6201.7 6209.4 6214.8 6222.5 6225.8 6243.8 5626.4 5715.5 5786.1 5809.5 5858.9 6369.6 6390.9 6401.4 6403.4 6418.8 5940.5 6107.7 6144.8 6183.2 6188.7 6163.4 6179.1 6230.6 6344.5 6365.0 6220.7 6251.5 6283.1 6297.0 6321.9 5924.9 6121.6 6265.4 6272.4 6293.9 4679.8 4734.6 4741.8 4743.5 4754.8 4213.5 4249.7 4254.2 4256.6 4267.6 5887.0 5892.8 5921.1 6105.2 6124.1 6103.0 6140.1 6164.5 6219.0 6297.8 6069.9 6070.8 6073.4 6082.0 6115.5 5164.3 5211.4 5338.4 5399.2 5401.5 6333.1 6509.2 6518.2 6535.9 6553.1 6319.0 6322.3 6328.1 6329.9 6336.6 6252.4 6364.2 6392.6 6567.7 6571.9 6172.0 6177.1 6183.0 6187.2 6230.6 6276.2 6277.4 6283.8 6285.5 6294.5 5905.8 5999.6 6032.2 6060.9 6137.0 6036.2 6115.4 6122.2 6127.6 6162.9 5958.2 6035.4 6037.4 6039.8 6051.8 5874.1 6031.6 6072.3 6121.7 6209.6 6024.6 6038.4 6066.8 6074.0 6077.1 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#1] ext.html Cycles:180 Average:65505.76 Median:42871.18 stddev:142330.22 (332.0%) stddev-sans-first:142646.04 09:21:25 INFO - PROCESS | 13403 | Values: 592.3 632.8 639.4 653.9 677.8 42877.4 46029.3 46134.3 46471.0 46534.8 46845.3 47305.0 47491.5 47675.3 47699.0 8964.0 9059.0 9071.0 9098.9 9107.5 8935.1 8937.2 9004.7 9059.3 9059.6 9007.9 9072.1 9074.7 9086.0 9131.8 8944.0 8966.0 9027.5 9029.5 9038.2 8915.2 8945.6 9029.5 9038.2 9038.2 42555.6 42759.6 42865.0 43205.4 43410.0 3860.3 3948.0 4493.4 4506.0 4587.3 34159.7 34364.5 34713.0 34934.8 34936.7 4693.4 4770.3 4840.2 4856.5 4860.7 367189.0 367235.0 370176.0 370176.0 370714.0 35610.8 64412.7 65241.3 65297.7 65456.3 37475.1 39165.2 39184.0 39199.8 39298.0 16589.9 16949.9 16950.9 16959.7 17065.1 15015.7 15037.7 15054.3 15076.8 15099.0 9042.7 9093.8 9094.3 9167.4 9234.0 3482.7 3503.6 3506.5 3531.7 3557.4 966.3 1038.2 1042.3 1106.2 1157.4 33251.0 33308.2 33702.0 34052.5 34254.1 1126.5 1131.6 1222.7 1236.8 1246.1 17582.4 17678.6 17734.8 17819.6 17847.6 575366.0 649322.0 652139.0 653811.0 984850.0 60841.7 61521.4 61667.7 61849.7 61896.7 1417.6 1423.4 1423.6 1424.6 1441.0 31627.2 32459.4 32566.5 33097.7 33141.0 53377.7 53608.0 53702.2 54067.7 54155.2 435924.0 440326.0 442008.0 443501.0 443752.0 29791.1 30810.0 30889.7 30995.1 31057.2 48867.0 50193.7 50297.2 50324.7 50493.7 41195.6 41858.4 42720.0 43009.6 43742.3 41587.0 41638.8 42384.7 42459.2 42946.6 41911.8 42339.2 42354.8 42792.4 42998.0 36000.0 36227.0 36577.1 37636.4 37766.6 28645.1 28761.9 29021.0 29110.3 29356.3 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#2] jquery.html Cycles:180 Average:30187.53 Median:2115.10 stddev:85629.36 (4048.5%) stddev-sans-first:85840.40 09:21:25 INFO - PROCESS | 13403 | Values: 416.5 424.7 428.7 428.8 448.6 18531.0 19636.8 20167.4 20308.2 20521.0 19409.6 19419.6 19470.0 20232.0 20240.2 5799.2 6002.6 6003.9 6026.8 6043.2 4666.6 5919.8 5980.4 6257.0 6317.1 5988.3 6196.3 6322.1 6376.4 6440.6 6074.0 6092.7 6100.8 6106.1 6114.7 5816.8 5858.4 5904.9 5948.4 5950.0 14386.2 14628.4 14717.1 14811.0 14954.4 2300.4 2329.4 2437.0 2508.7 2534.5 10653.9 11308.8 11699.2 14130.2 15379.2 2039.7 2109.8 2120.4 2166.2 2209.0 84601.0 87324.1 87659.0 87881.0 88255.0 11170.9 11271.1 11493.2 11620.5 11670.8 15792.4 15830.4 15901.5 15938.1 15986.3 8476.3 8705.6 8724.5 8736.4 8755.7 8295.1 8376.5 8437.5 8469.3 8559.6 4828.8 4883.9 4889.0 4997.8 5011.5 2043.2 2064.2 2090.4 2108.2 2176.6 932.8 1011.4 1023.6 1067.8 1108.0 19111.3 19118.4 19837.4 19839.1 19976.9 993.3 998.9 1003.3 1023.2 1107.6 10903.6 11080.4 11206.8 11226.4 11286.8 498097.0 505998.0 516664.0 524372.0 544580.0 97493.5 101688.5 101709.0 101710.0 101750.0 1052.1 1060.1 1066.1 1078.9 1082.1 17442.6 17763.6 17808.6 17931.6 18059.5 41191.8 42033.4 42745.0 43697.1 43713.8 59872.4 60051.4 60747.0 61011.0 61486.7 7203.0 7775.9 7778.5 7819.2 7994.1 9332.2 12158.5 12595.1 12785.4 12888.2 10713.6 11173.4 11353.8 11505.7 11635.5 10421.7 11044.4 11241.6 11411.9 11815.2 11098.9 11465.1 11467.4 11590.9 11716.1 7804.6 7845.2 7905.8 7981.3 8016.4 10687.2 10724.1 10850.7 11037.9 11263.3 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#3] mootools.html Cycles:180 Average:6422.34 Median:4668.63 stddev:3775.00 (80.9%) stddev-sans-first:3767.72 09:21:25 INFO - PROCESS | 13403 | Values: 1535.1 1557.5 1723.8 1798.2 1847.0 8627.6 9333.6 9405.4 10024.7 10056.6 9396.6 9627.5 9692.3 9733.9 9745.0 2473.2 2506.7 2509.3 2509.6 2509.9 2374.5 2469.1 2472.3 2472.4 2482.5 2434.9 2443.6 2476.2 2478.1 2485.4 2404.4 2437.3 2447.3 2466.0 2498.0 2465.2 2476.3 2489.2 2494.5 2503.0 9574.0 9603.9 9637.7 9663.2 9678.2 5716.3 5717.5 5725.6 5753.2 5760.5 3534.3 3620.0 3662.0 3667.8 3703.6 1203.1 1221.5 1239.2 1254.9 1279.9 13987.7 14011.7 14027.7 14030.1 14033.2 4888.0 4898.6 4984.4 4995.6 5012.2 11614.9 11672.9 11694.2 11700.4 11714.2 5808.3 5808.5 5811.0 5820.9 5831.4 4636.5 4968.8 5095.5 5127.1 5190.9 4328.0 4360.4 4392.9 4401.9 4416.1 1361.8 1362.3 1386.2 1389.8 1391.6 917.4 1032.8 1034.0 1041.9 1041.9 6473.3 6603.0 6667.8 6685.8 6724.5 475.2 475.9 482.9 488.7 493.9 4455.7 4545.6 4571.8 4622.0 4700.8 11974.3 12329.0 12355.3 12469.2 12518.7 11913.2 12298.2 12304.5 12413.4 12424.1 8829.9 8975.1 9073.4 9086.0 9291.4 6436.3 6543.4 6689.5 6696.8 6699.0 11280.2 11342.7 11431.3 11595.9 11631.9 11658.7 11693.2 11764.7 11772.2 11784.4 8394.2 8920.8 9165.1 9255.8 9375.5 9260.2 9355.0 9393.2 9430.5 9464.4 8270.9 8468.2 8529.8 8625.0 8710.6 8213.3 8305.5 8435.2 8534.1 8623.4 7710.5 7712.4 7738.5 7773.0 7798.1 5557.8 5600.4 5682.6 5688.9 5735.7 5539.7 5630.1 5666.0 5691.9 5697.7 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#4] prototype.html Cycles:180 Average:5130.31 Median:5723.73 stddev:1521.69 (26.6%) stddev-sans-first:1483.08 09:21:25 INFO - PROCESS | 13403 | Values: 351.4 354.6 358.1 358.2 358.5 5820.3 5840.8 5883.8 5914.3 5958.8 5747.9 5798.2 5814.3 5822.0 5835.7 4529.4 4530.4 4542.4 4543.5 4552.0 4539.3 4550.4 4574.1 4592.5 4602.5 4498.8 4513.0 4539.0 4562.9 4570.1 4347.6 4461.4 4471.0 4475.4 4488.6 3978.2 4003.1 4007.6 4015.8 4025.5 5548.2 5553.0 5563.5 5605.3 5637.9 5082.4 5085.9 5110.6 5134.1 5188.4 6017.8 6049.7 6056.1 6065.3 6069.3 4324.9 4411.0 4411.4 4413.8 4467.2 6097.2 6265.2 6283.9 6291.7 6299.4 4404.4 4435.6 4447.0 4455.6 4467.8 4469.7 4489.8 4494.3 4499.3 4522.3 5073.5 5076.3 5108.2 5183.2 5189.8 6045.2 6057.5 6073.9 6114.9 6121.4 1531.6 1555.2 1560.5 1563.0 1565.6 948.3 975.3 995.3 1001.5 1006.3 5274.8 5369.3 5385.9 5385.9 5455.4 5528.5 5563.2 5601.8 5656.6 5657.9 5328.6 5363.6 5626.4 6079.3 6092.0 3349.8 3368.9 3369.3 3384.2 3386.7 6353.9 6605.3 6618.2 6630.3 6659.9 6458.4 6482.2 6490.8 6507.2 6508.9 6388.5 6624.7 6628.6 6636.4 6651.3 6302.1 6321.6 6365.5 6389.1 6389.3 5974.3 6258.6 6270.2 6333.8 6347.7 6396.8 6546.5 6573.3 6599.2 6609.2 4482.7 4534.8 4535.6 4551.1 4557.5 6212.8 6347.0 6387.0 6395.0 6427.2 6135.4 6200.0 6204.5 6223.0 6247.0 5906.0 6144.7 6172.2 6179.4 6198.8 5969.8 6077.6 6138.0 6152.4 6153.3 6236.2 6237.0 6264.9 6289.0 6307.9 5699.6 6053.9 6119.3 6163.4 6205.4 09:21:25 INFO - PROCESS | 13403 | 09:21:25 INFO - PROCESS | 13403 | [#5] yui.html Cycles:180 Average:20370.32 Median:4085.22 stddev:27288.14 (668.0%) stddev-sans-first:27325.03 09:21:25 INFO - PROCESS | 13403 | Values: 778.7 794.7 808.1 873.8 887.0 14092.5 14915.3 15060.2 15573.2 15693.9 16241.2 16295.2 16360.7 16522.4 16533.1 831.4 860.5 860.8 861.1 862.6 875.2 882.1 883.0 885.4 887.3 915.7 918.7 919.1 919.1 919.4 908.1 908.9 913.2 917.8 918.1 665.9 669.2 671.3 675.0 676.1 14742.1 14749.6 14794.2 14884.2 14904.5 15743.3 15855.5 15933.8 15940.7 15988.7 12292.9 12397.3 12440.4 12493.4 12610.6 4058.4 4067.3 4103.2 4120.7 4177.0 68813.0 71052.6 71058.3 80503.0 80637.2 12638.7 12712.9 13141.9 13152.9 13361.7 22692.3 22737.7 22775.5 22934.5 23049.9 9684.7 9741.1 9810.9 9821.6 9917.3 5129.3 5174.8 5255.7 5282.9 5337.2 3829.4 3900.1 3938.1 3949.2 3973.9 667.2 670.4 687.0 687.0 687.9 642.9 742.0 765.5 775.0 775.6 10083.5 10659.3 11403.8 11474.8 11905.9 775.1 779.1 781.8 813.6 822.6 4903.4 5264.9 5305.8 5306.9 5327.5 73929.3 74666.0 74667.0 86997.0 110323.4 77207.6 99599.5 101245.0 102044.5 102242.0 89750.0 89776.1 89863.1 91304.5 92050.5 10017.2 10058.0 10139.8 10171.8 10176.8 48501.5 51254.7 51279.7 53160.0 53438.5 49267.0 72453.6 72674.3 73677.3 75806.6 13943.6 13962.6 14253.0 14479.1 14486.7 15591.9 15721.3 16734.4 16795.5 16816.5 14449.3 14806.9 14916.7 15712.8 16028.3 14667.3 14761.6 14819.1 15283.1 15401.8 14519.4 14564.3 14642.1 14644.4 14672.0 11889.6 11915.6 12352.2 12451.3 12668.0 12449.6 12531.4 12591.8 12823.4 12919.2 09:21:25 INFO - PROCESS | 13403 | -------- Summary: end -------- 09:21:25 INFO - PROCESS | 13403 | 09:21:26 INFO - TEST-INFO | 13403: exit 0 09:21:26 INFO - TEST-OK | dromaeo_css | took 1109913ms 09:21:26 INFO - TEST-START | kraken 09:21:26 INFO - operating with platform_type : linux_ 09:21:26 INFO - Initialising browser for kraken test... 09:21:26 INFO - TEST-INFO | started process 13649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbR29sS/profile http://localhost:53435/getInfo.html) 09:21:30 INFO - PROCESS | 13649 | __metrics Screen width/height:1600/1200 09:21:30 INFO - PROCESS | 13649 | colorDepth:24 09:21:30 INFO - PROCESS | 13649 | Browser inner width/height: 1024/697 09:21:30 INFO - PROCESS | 13649 | __metrics 09:21:31 ERROR - PROCESS | 13649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:21:32 INFO - TEST-INFO | 13649: exit 0 09:21:32 INFO - Browser initialized. 09:21:32 INFO - Running cycle 1/1 for kraken test... 09:21:32 INFO - TEST-INFO | started process 13778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbR29sS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:44 INFO - PROCESS | 13778 | RSS: Main: 156094464 09:21:44 INFO - PROCESS | 13778 | 09:21:46 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53435/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:47 INFO - PROCESS | 13778 | RSS: Main: 161173504 09:21:47 INFO - PROCESS | 13778 | 09:21:50 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53435/tests/kraken/driver.html?testName=audio-dft) 09:21:50 INFO - PROCESS | 13778 | RSS: Main: 160370688 09:21:50 INFO - PROCESS | 13778 | 09:21:53 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53435/tests/kraken/driver.html?testName=audio-fft) 09:21:54 INFO - PROCESS | 13778 | RSS: Main: 161288192 09:21:54 INFO - PROCESS | 13778 | 09:21:56 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53435/tests/kraken/driver.html?testName=audio-oscillator) 09:21:57 INFO - PROCESS | 13778 | RSS: Main: 160636928 09:21:57 INFO - PROCESS | 13778 | 09:21:59 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:59 INFO - PROCESS | 13778 | RSS: Main: 160354304 09:21:59 INFO - PROCESS | 13778 | 09:22:02 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53435/tests/kraken/driver.html?testName=imaging-darkroom) 09:22:03 INFO - PROCESS | 13778 | RSS: Main: 159899648 09:22:03 INFO - PROCESS | 13778 | 09:22:06 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53435/tests/kraken/driver.html?testName=imaging-desaturate) 09:22:07 INFO - PROCESS | 13778 | RSS: Main: 160600064 09:22:07 INFO - PROCESS | 13778 | 09:22:10 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53435/tests/kraken/driver.html?testName=json-parse-financial) 09:22:11 INFO - PROCESS | 13778 | RSS: Main: 160886784 09:22:11 INFO - PROCESS | 13778 | 09:22:12 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:22:13 INFO - PROCESS | 13778 | RSS: Main: 160542720 09:22:13 INFO - PROCESS | 13778 | 09:22:14 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:22:15 INFO - PROCESS | 13778 | RSS: Main: 160215040 09:22:15 INFO - PROCESS | 13778 | 09:22:17 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:22:18 INFO - PROCESS | 13778 | RSS: Main: 161013760 09:22:18 INFO - PROCESS | 13778 | 09:22:20 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:22:21 INFO - PROCESS | 13778 | RSS: Main: 161710080 09:22:21 INFO - PROCESS | 13778 | 09:22:24 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:24 INFO - PROCESS | 13778 | RSS: Main: 160751616 09:22:24 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | Cycle 1(1): loaded http://localhost:53435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53435/tests/kraken/driver.html?testName=ai-astar) 09:22:26 INFO - PROCESS | 13778 | RSS: Main: 161533952 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | __start_tp_report 09:22:26 INFO - PROCESS | 13778 | _x_x_mozilla_page_load 09:22:26 INFO - PROCESS | 13778 | _x_x_mozilla_page_load_details 09:22:26 INFO - PROCESS | 13778 | |i|pagename|runs| 09:22:26 INFO - PROCESS | 13778 | |0;ai-astar;111;106;111;110;111;111;110;109;111;110 09:22:26 INFO - PROCESS | 13778 | |1;audio-beat-detection;154;131;154;175;134;148;155;126;187;125 09:22:26 INFO - PROCESS | 13778 | |2;audio-dft;165;166;167;161;162;162;163;170;161;163 09:22:26 INFO - PROCESS | 13778 | |3;audio-fft;75;75;75;181;75;77;75;76;164;75 09:22:26 INFO - PROCESS | 13778 | |4;audio-oscillator;84;85;149;84;85;86;147;86;85;140 09:22:26 INFO - PROCESS | 13778 | |5;imaging-gaussian-blur;117;117;117;117;117;120;121;119;118;117 09:22:26 INFO - PROCESS | 13778 | |6;imaging-darkroom;147;148;147;146;148;148;147;147;146;147 09:22:26 INFO - PROCESS | 13778 | |7;imaging-desaturate;95;96;95;96;96;95;96;97;96;95 09:22:26 INFO - PROCESS | 13778 | |8;json-parse-financial;52;55;53;51;53;58;52;52;55;54 09:22:26 INFO - PROCESS | 13778 | |9;json-stringify-tinderbox;59;60;59;60;61;59;58;59;64;59 09:22:26 INFO - PROCESS | 13778 | |10;stanford-crypto-aes;76;77;79;76;79;80;78;78;118;78 09:22:26 INFO - PROCESS | 13778 | |11;stanford-crypto-ccm;120;119;128;126;125;124;123;120;131;128 09:22:26 INFO - PROCESS | 13778 | |12;stanford-crypto-pbkdf2;157;157;163;162;157;154;161;159;153;161 09:22:26 INFO - PROCESS | 13778 | |13;stanford-crypto-sha256-iterative;70;63;63;67;63;67;64;62;63;60 09:22:26 INFO - PROCESS | 13778 | __end_tp_report 09:22:26 INFO - PROCESS | 13778 | __start_cc_report 09:22:26 INFO - PROCESS | 13778 | _x_x_mozilla_cycle_collect,856 09:22:26 INFO - PROCESS | 13778 | __end_cc_report 09:22:26 INFO - PROCESS | 13778 | __startTimestamp1467649346612__endTimestamp 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | ------- Summary: start ------- 09:22:26 INFO - PROCESS | 13778 | Number of tests: 14 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:1.62 09:22:26 INFO - PROCESS | 13778 | Values: 111.0 106.0 111.0 110.0 111.0 111.0 110.0 109.0 111.0 110.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.00 stddev:20.71 (13.4%) stddev-sans-first:21.89 09:22:26 INFO - PROCESS | 13778 | Values: 154.0 131.0 154.0 175.0 134.0 148.0 155.0 126.0 187.0 125.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.94 (1.8%) stddev-sans-first:3.10 09:22:26 INFO - PROCESS | 13778 | Values: 165.0 166.0 167.0 161.0 162.0 162.0 163.0 170.0 161.0 163.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:41.15 (54.9%) stddev-sans-first:43.02 09:22:26 INFO - PROCESS | 13778 | Values: 75.0 75.0 75.0 181.0 75.0 77.0 75.0 76.0 164.0 75.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:29.24 (34.4%) stddev-sans-first:30.18 09:22:26 INFO - PROCESS | 13778 | Values: 84.0 85.0 149.0 84.0 85.0 86.0 147.0 86.0 85.0 140.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:117.50 stddev:1.49 (1.3%) stddev-sans-first:1.54 09:22:26 INFO - PROCESS | 13778 | Values: 117.0 117.0 117.0 117.0 117.0 120.0 121.0 119.0 118.0 117.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:22:26 INFO - PROCESS | 13778 | Values: 147.0 148.0 147.0 146.0 148.0 148.0 147.0 147.0 146.0 147.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:22:26 INFO - PROCESS | 13778 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 97.0 96.0 95.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:2.07 (3.9%) stddev-sans-first:2.12 09:22:26 INFO - PROCESS | 13778 | Values: 52.0 55.0 53.0 51.0 53.0 58.0 52.0 52.0 55.0 54.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:1.69 (2.8%) stddev-sans-first:1.76 09:22:26 INFO - PROCESS | 13778 | Values: 59.0 60.0 59.0 60.0 61.0 59.0 58.0 59.0 64.0 59.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.00 stddev:12.75 (16.3%) stddev-sans-first:13.34 09:22:26 INFO - PROCESS | 13778 | Values: 76.0 77.0 79.0 76.0 79.0 80.0 78.0 78.0 118.0 78.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.50 stddev:3.98 (3.2%) stddev-sans-first:3.89 09:22:26 INFO - PROCESS | 13778 | Values: 120.0 119.0 128.0 126.0 125.0 124.0 123.0 120.0 131.0 128.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:160.00 stddev:3.37 (2.1%) stddev-sans-first:3.54 09:22:26 INFO - PROCESS | 13778 | Values: 157.0 157.0 163.0 162.0 157.0 154.0 161.0 159.0 153.0 161.0 09:22:26 INFO - PROCESS | 13778 | 09:22:26 INFO - PROCESS | 13778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:63.50 stddev:2.94 (4.6%) stddev-sans-first:2.24 09:22:26 INFO - PROCESS | 13778 | Values: 70.0 63.0 63.0 67.0 63.0 67.0 64.0 62.0 63.0 60.0 09:22:26 INFO - PROCESS | 13778 | -------- Summary: end -------- 09:22:26 INFO - PROCESS | 13778 | 09:22:27 INFO - TEST-INFO | 13778: exit 0 09:22:27 INFO - TEST-OK | kraken | took 60903ms 09:22:27 INFO - SUITE-END | took 1170s 09:22:27 INFO - Completed test suite (00:19:31) 09:22:27 INFO - javascript benchmark 09:22:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7653.472589893904, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.515190297406, 3421.31573685263, 3443.345764304782, 3449.603295621003, 3464.3417750627364, 5775.364709881909, 5799.2750906136735, 5839.737211825467, 5874.853128671774, 5915.674637894914, 5823.883522329562, 5851.3563508014195, 5875.559333050017, 5906.025505791539, 5911.438413350736, 5235.031519168956, 5287.444818294081, 5308.416074231832, 5320.228566857803, 5329.280547126146, 5151.6908985460805, 5166.328377310944, 5325.680459172443, 5349.197620356958, 5358.705271210082, 5176.352955880515, 5184.300119483878, 5209.062368773619, 5280.656757310762, 5285.814996475124, 5220.504052115062, 5257.894842103136, 5267.947320526784, 5269.920951185735, 5275.86810329741, 5201.765920533585, 5273.839755253876, 5290.761915713802, 5324.627276090675, 5327.627066105335, 5497.202905578669, 5498.80754173606, 5526.889462210734, 5549.19536667185, 5726.942730572682, 6164.4143806338325, 6167.259928808527, 6183.6598987055695, 6186.783462578788, 6201.72092255845, 6209.429577992627, 6214.813555593294, 6222.533310001768, 6225.785971735513, 6243.751249750068, 5626.381098079208, 5715.485606295411, 5786.103154011135, 5809.477147056785, 5858.912116318259, 6369.554131210771, 6390.8721825563225, 6401.391867772554, 6403.359664033559, 6418.775342862978, 5940.524758019435, 6107.6640784757265, 6144.846378840565, 6183.165272688219, 6188.721507532172, 6163.414475624809, 6179.104029915637, 6230.563860529719, 6344.524160687967, 6365.013422919455, 6220.657863817443, 6251.499880009588, 6283.088952102011, 6297.0, 6321.8735625288155, 5924.911126333109, 6121.632702037892, 6265.4361107499635, 6272.40412160844, 6293.874122517524, 4679.789409476582, 4734.573888350065, 4741.810327586858, 4743.478217396084, 4754.833580824724, 4213.494380674278, 4249.702520823575, 4254.234237837219, 4256.574342565718, 4267.637250833714, 5886.970565147232, 5892.823215303548, 5921.052631578927, 6105.175801266772, 6124.11200375943, 6103.0, 6140.083460356295, 6164.537659675542, 6219.0, 6297.811065668037, 6069.939300606938, 6070.817875463743, 6073.423024812724, 6082.0, 6115.480184184395, 5164.25118357836, 5211.374635043819, 5338.412774594792, 5399.217113518518, 5401.459854014645, 6333.081703153109, 6509.153810004764, 6518.217813862367, 6535.8692826143215, 6553.148090748172, 6318.968405158037, 6322.336154703874, 6328.114064030948, 6329.936700632935, 6336.58812177207, 6252.437280644764, 6364.236291645032, 6392.584482008655, 6567.671616419256, 6571.901421478586, 6172.043333283348, 6177.135201071764, 6183.041628547582, 6187.16473276102, 6230.59501132425, 6276.215473065867, 6277.435030847246, 6283.842903927439, 6285.528585356208, 6294.5279104068295, 5905.793297234576, 5999.640021598718, 6032.245969253843, 6060.878782424415, 6136.9873970794315, 6036.215292012011, 6115.388461153849, 6122.173506576555, 6127.571070025056, 6162.876742465215, 5958.19564358806, 6035.39646035393, 6037.366076561898, 6039.761848820894, 6051.848703782441, 5874.118882167709, 6031.638101713911, 6072.271327440735, 6121.666376154749, 6209.627422354673, 6024.638521688713, 6038.426349496791, 6066.817995460143, 6074.0, 6077.149199112217], "value": 5741.574292629682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3336246722437, 632.8006677896462, 639.4404895716249, 653.9051837483563, 677.7526202935929, 42877.35683964739, 46029.30956035662, 46134.30798538025, 46471.0, 46534.767326163324, 46845.297320540216, 47305.0, 47491.52508474914, 47675.28487072688, 47699.0, 8964.01395846458, 9059.048799876016, 9071.0, 9098.909010909905, 9107.453552786854, 8935.106489351077, 8937.240334571537, 9004.68483603074, 9059.320550958671, 9059.59231834569, 9007.864882026775, 9072.092790720908, 9074.682386116487, 9086.04596517366, 9131.771705707377, 8943.95528022359, 8965.95517022414, 9027.45835249887, 9029.548522573878, 9038.186563209343, 8915.242204412632, 8945.64217431302, 9029.503377314246, 9038.186563209343, 9038.231750301233, 42555.57444425547, 42759.57240427618, 42865.0, 43205.35191972123, 43410.0, 3860.343741563941, 3947.980260098681, 4493.41585593874, 4505.954940450619, 4587.288970209623, 34159.65840341614, 34364.48453273203, 34713.0, 34934.82532587346, 34936.65063349359, 4693.389859318267, 4770.260609605517, 4840.249761287007, 4856.490068542823, 4860.684055536379, 367189.0, 367235.0, 370176.0, 370176.0, 370714.0, 35610.821945890624, 64412.677936610016, 65241.347586524476, 65297.673511632136, 65456.34543654598, 37475.06312342159, 39165.21669566593, 39184.0, 39199.80400098038, 39298.01754956149, 16589.91705041491, 16949.915250423917, 16950.915245423694, 16959.660806784043, 17065.06142162168, 15015.699686006219, 15037.699246015018, 15054.322555485029, 15076.849231507764, 15099.0, 9042.683506077386, 9093.77265568366, 9094.272458203328, 9167.44995300284, 9234.0, 3482.7387945904156, 3503.579570451562, 3506.50908872758, 3531.7351198660203, 3557.4130268505405, 966.3090890013533, 1038.1953985661023, 1042.2704107125044, 1106.2201148190507, 1157.4039369724599, 33251.0, 33308.167295817315, 33702.0, 34052.48921266183, 34254.14364640854, 1126.4536699700639, 1131.603938621476, 1222.6515443098851, 1236.7650146472142, 1246.052999720219, 17582.38461653836, 17678.558036049202, 17734.822651773575, 17819.643607128044, 17847.643047138983, 575366.0, 649322.0, 652139.0, 653811.0, 984850.0, 60841.69579152076, 61521.38478615157, 61667.69166154141, 61849.69075154595, 61896.69051654803, 1417.6101572067557, 1423.3879431844407, 1423.5800438870558, 1424.5583869000436, 1441.0489077208993, 31627.20931976719, 32459.350812983135, 32566.511502327012, 33097.669023309456, 33141.0, 53377.73311133419, 53608.0, 53702.194467083806, 54067.72966135144, 54155.18767218573, 435924.0, 440326.0, 442008.0, 443501.0, 443752.0, 29791.106266812032, 30810.0, 30889.69110308868, 30995.0701478956, 31057.223569410944, 48867.0, 50193.74903125461, 50297.24554131618, 50324.66235115585, 50493.74753126211, 41195.58804411918, 41858.37212441755, 42720.0, 43009.56990430056, 43742.343864841416, 41587.0, 41638.791806040776, 42384.7284581463, 42459.15081698287, 42946.57053429426, 41911.7904410476, 42339.1532169361, 42354.78822605991, 42792.358114627685, 42998.0, 36000.0, 36227.0, 36577.050360431436, 37636.435453468766, 37766.62233377631, 28645.140645779826, 28761.856190718914, 29021.0, 29110.27224319409, 29356.266093347836], "value": 20081.882487564864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.46692233940564, 424.7005860868088, 428.72133113476235, 428.7941787941788, 448.55368907936605, 18531.0, 19636.803631963692, 20167.39497815064, 20308.18767249308, 20521.0, 19409.611807763835, 19419.611607767834, 19470.0, 20232.0, 20240.190392384324, 5799.217105690741, 6002.609830361012, 6003.909941350883, 6026.819195424122, 6043.244594425697, 4666.580007799297, 5919.763209471616, 5980.431858973412, 6256.968715156418, 6317.1156038154695, 5988.341282458926, 6196.285624397608, 6322.1149039134325, 6376.39424254695, 6440.581362211465, 6073.969630151821, 6092.6953652317425, 6100.786472473486, 6106.084087386883, 6114.663693496856, 5816.796412125597, 5858.443447872445, 5904.911426328608, 5948.405159484017, 5949.9702501487645, 14386.208758518382, 14628.41486340545, 14717.116972981548, 14811.0, 14954.40182392703, 2300.3559003479054, 2329.417645588586, 2437.0, 2508.7240403555593, 2534.4677617700304, 10653.946730266376, 11308.830367544493, 11699.18105732599, 14130.22283774392, 15379.154146521936, 2039.7246371739773, 2109.789021097893, 2120.416885356524, 2166.155199472207, 2208.9558208835733, 84601.0, 87324.12675873288, 87659.0, 87880.99999999936, 88255.0, 11170.944145279222, 11271.09831213501, 11493.195476316578, 11620.53517859293, 11670.824937625943, 15792.447264345692, 15830.44593439224, 15901.52295431139, 15938.123403212934, 15986.280617372246, 8476.321894248445, 8705.608247628872, 8724.520151391735, 8736.388452808242, 8755.693550725695, 8295.12901145371, 8376.49741015541, 8437.535935523483, 8469.32245420365, 8559.614817333111, 4828.806847726122, 4883.853484395474, 4888.9755551222015, 4997.800087996512, 5011.473795251519, 2043.1725151313742, 2064.2465500092358, 2090.393785802131, 2108.15673730506, 2176.62997290461, 932.8320902237526, 1011.3729487717515, 1023.5547536821507, 1067.754416484213, 1108.0415440643785, 19111.33110341159, 19118.426447206606, 19837.40487785369, 19839.107240174228, 19976.90011549962, 993.3344659078434, 998.930074894765, 1003.2776400991274, 1023.2428003277521, 1107.5791199344199, 10903.618373357052, 11080.390578518098, 11206.775864482828, 11226.382548959886, 11286.830697539543, 498097.0, 505998.0, 516664.0, 524372.0, 544580.0, 97493.5125324383, 101688.49155754174, 101709.0, 101710.0, 101750.0, 1052.1372474570778, 1060.0777323728405, 1066.1044722433194, 1078.9352638841694, 1082.09644946469, 17442.563935901704, 17763.644727105642, 17808.55478612993, 17931.641367172324, 18059.458216253533, 41191.7940410296, 42033.36949945692, 42745.0, 43697.126057479305, 43713.78143109264, 59872.40127598668, 60051.39948600458, 60747.0, 61011.0, 61486.69256653688, 7202.96398518004, 7775.92224077752, 7778.533288002738, 7819.218078192135, 7994.120646728971, 9332.20676242527, 12158.513659453876, 12595.11834171636, 12785.36073196318, 12888.162269452456, 10713.625023124154, 11173.385463799244, 11353.772924541297, 11505.712357191138, 11635.47640356169, 10421.739456513647, 11044.447777611247, 11241.55033798639, 11411.942940285577, 11815.172937894265, 11098.944505277423, 11465.14011449128, 11467.426628668367, 11590.88409115898, 11716.121290903046, 7804.570748608654, 7845.176256492986, 7905.802354941173, 7981.281684648409, 8016.358691304798, 10687.198460115367, 10724.088452481627, 10850.728731781768, 11037.922555624502, 11263.26788758728], "value": 9389.266652059707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.14799286396, 1557.4704600435853, 1723.8189990051044, 1798.2267624921278, 1847.0303090877287, 8627.611757470913, 9333.5799889005, 9405.435673859572, 10024.699259022233, 10056.648017319396, 9396.624135034608, 9627.518624068804, 9692.27307951903, 9733.902660973388, 9745.0, 2473.233297677721, 2506.749325067497, 2509.29739672891, 2509.6110102934076, 2509.8870550825163, 2374.489484760776, 2469.09877894569, 2472.2830379190104, 2472.3695457658364, 2482.453860150764, 2434.914777982771, 2443.609022556391, 2476.2199907029317, 2478.0583378316214, 2485.391079185602, 2404.386881345263, 2437.3297343230665, 2447.3147518694796, 2466.0, 2497.962530562043, 2465.2111324376206, 2476.2818782553036, 2489.240781561623, 2494.5260400523844, 2502.962455563168, 9574.0, 9603.903960960371, 9637.662681806103, 9663.226941844636, 9678.17735492484, 5716.256886604757, 5717.542596592304, 5725.6278341908055, 5753.223314852525, 5760.53915686744, 3534.2578058607464, 3619.9683090319395, 3661.9929519382117, 3667.7799332040163, 3703.6481534254203, 1203.127732394016, 1221.450347343699, 1239.1883316427754, 1254.9184303020274, 1279.852816926047, 13987.65030874226, 14011.71976560463, 14027.71944561103, 14030.088044277192, 14033.228172450512, 4887.95112048882, 4898.608111351084, 4984.40187177541, 4995.625328100407, 5012.1980483122525, 11614.941925290319, 11672.88327116735, 11694.239874408137, 11700.414979251003, 11714.180007399571, 5808.273965754281, 5808.5353171747, 5811.041178205549, 5820.912686309709, 5831.358550559435, 4636.466806317249, 4968.801247950114, 5095.464976177522, 5127.102757017507, 5190.8961820764125, 4328.026194106364, 4360.367746676714, 4392.857856957214, 4401.889952751143, 4416.138852923713, 1361.7821148616174, 1362.3188405797102, 1386.202933313349, 1389.8401683806492, 1391.5755694513068, 917.3853518142861, 1032.8244198486275, 1034.0486752188006, 1041.8853926068127, 1041.9218558607984, 6473.255575608865, 6603.0, 6667.833304167435, 6685.832854178684, 6724.529282950147, 475.2016612091719, 475.8881662809237, 482.85755702067974, 488.66282265236873, 493.87406211415856, 4455.710378825366, 4545.568171023748, 4571.817127314936, 4622.0, 4700.788464519105, 11974.281543107441, 12329.0, 12355.25868447896, 12469.189502682297, 12518.687032824253, 11913.22564033335, 12298.20061695987, 12304.507819687113, 12413.44139513724, 12424.130310878332, 8829.911700883038, 8975.057618950046, 9073.364864459425, 9085.954570227106, 9291.396059256262, 6436.274093572322, 6543.378379053982, 6689.46484281266, 6696.83257918556, 6699.0, 11280.153988451064, 11342.716432089264, 11431.256968297033, 11595.942020289845, 11631.88368116308, 11658.708532286422, 11693.181477296508, 11764.70588235301, 11772.234804738007, 11784.351860647746, 8394.24451799341, 8920.776980575538, 9165.083491650781, 9255.814883702424, 9375.484348360906, 9260.212881905114, 9355.0, 9393.154616084585, 9430.52847357643, 9464.432134071978, 8270.875936860832, 8468.195521425454, 8529.786755331166, 8624.956875215585, 8710.608022639124, 8213.3429325655, 8305.46014509055, 8435.156484351515, 8534.146585341416, 8623.353248506262, 7710.498817576839, 7712.421568382281, 7738.535687858746, 7772.961135194514, 7798.064232292161, 5557.833265002057, 5600.35595906476, 5682.6306290091015, 5688.943110569007, 5735.71321433935, 5539.695316757617, 5630.0991841305195, 5665.971670141623, 5691.943080569307, 5697.686627235542], "value": 4992.8175551124705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.35526309222575, 354.6205560050745, 358.06187787995447, 358.20835952544877, 358.51958375776456, 5820.301563812343, 5840.766369345227, 5883.823235352925, 5914.290285165781, 5958.79144229952, 5747.885042299152, 5798.217240672508, 5814.331351894533, 5821.970890145554, 5835.708214589265, 4529.388532548113, 4530.411046563959, 4542.364069030338, 4543.523354909659, 4551.954480455186, 4539.319102134673, 4550.431196100488, 4574.1080489304595, 4592.471865735433, 4602.516735742749, 4498.752568608726, 4513.007138429541, 4539.0, 4562.931556026662, 4570.13167498176, 4347.60871521563, 4461.442319710036, 4470.982087091201, 4475.418195634563, 4488.596026357611, 3978.204359128157, 4003.11931375097, 4007.5591684914634, 4015.7791321477307, 4025.5169379674626, 5548.223248745179, 5552.972235138798, 5563.471470210324, 5605.2713147291, 5637.887242255132, 5082.390113186404, 5085.898282034375, 5110.565601923841, 5134.074721979257, 5188.377394712658, 6017.826523827855, 6049.667268300242, 6056.06131049688, 6065.302490213638, 6069.302030266532, 4324.9135017299795, 4410.977945110286, 4411.426514553087, 4413.757243351614, 4467.173572889026, 6097.237845269341, 6265.185525881606, 6283.8743225135695, 6291.6854157291955, 6299.37006299371, 4404.405405270248, 4435.600795928382, 4446.977765111218, 4455.6212721918355, 4467.843625473093, 4469.664775141878, 4489.820407183742, 4494.303382975644, 4499.3251012347755, 4522.276435770261, 5073.492650734897, 5076.340075790124, 5108.208227724708, 5183.222516622537, 5189.8202754842305, 6045.186444066762, 6057.454829065317, 6073.878522429527, 6114.938850611526, 6121.4490695837585, 1531.6170957260686, 1555.199072477675, 1560.54744124205, 1562.960925976837, 1565.622252417865, 948.3219498058783, 975.2831668723483, 995.3082607587802, 1001.5392919257223, 1006.2754816532085, 5274.789008439696, 5369.301990741257, 5385.946140538545, 5385.946140538623, 5455.426695514444, 5528.502434780889, 5563.248961390242, 5601.7759289628775, 5656.575756818255, 5657.878295639135, 5328.600354973315, 5363.624546281801, 5626.437356264422, 6079.331273559905, 6092.0, 3349.782264152871, 3368.949465758016, 3369.258763072169, 3384.1708781348234, 3386.745994050456, 6353.8729225416155, 6605.339466053452, 6618.172728408949, 6630.336966303331, 6659.86680266392, 6458.418742313121, 6482.222133344029, 6490.805275841638, 6507.219133703986, 6508.9023664645065, 6388.488920886318, 6624.701888415033, 6628.5691430056895, 6636.402723754885, 6651.26836048044, 6302.1492098566105, 6321.557490975588, 6365.490760739222, 6389.137466442156, 6389.2652344980925, 5974.342822289632, 6258.5591619269435, 6270.184875966095, 6333.809985700436, 6347.714352854225, 6396.776112836028, 6546.476281897532, 6573.3426657333885, 6599.208095028627, 6609.173853268341, 4482.731036137842, 4534.841280555164, 4535.6371490280035, 4551.089782043538, 4557.5442455754155, 6212.782552610637, 6346.9682651586445, 6387.0, 6394.962392863353, 6427.228732551936, 6135.423122288738, 6200.0, 6204.534659900435, 6223.0354295084335, 6247.0, 5906.0255057914965, 6144.723487443165, 6172.197614310111, 6179.412955769195, 6198.752049918133, 5969.791057312973, 6077.604955677867, 6138.0, 6152.415520525543, 6153.338598578269, 6236.220472440945, 6236.968815155895, 6264.874702506016, 6289.0, 6307.936920630918, 5699.572532060195, 6053.909191362045, 6119.3268740437625, 6163.414475624809, 6205.441510264098], "value": 4640.261797424753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.7157687444085, 794.7297918707642, 808.0505406147777, 873.7859224489999, 886.9955650221748, 14092.506762263323, 14915.25423728812, 15060.171690557016, 15573.221338933037, 15693.921530392361, 16241.187940602953, 16295.185240737976, 16360.672786544292, 16522.42171523997, 16533.090680012596, 831.418007394823, 860.513809697522, 860.802015536427, 861.0657436681178, 862.5859587398053, 875.155474966657, 882.1399135842566, 882.9690960816373, 885.3669626217253, 887.2502735188755, 915.7161280003187, 918.7060140754961, 919.1314208073373, 919.1406035356963, 919.4345477531303, 908.0556221529635, 908.913653202948, 913.2465715784471, 917.7705573606598, 918.1048477734222, 665.930077341877, 669.2136739331315, 671.3219648155398, 674.9628770417625, 676.0569006236273, 14742.11547307165, 14749.557513274618, 14794.186319752409, 14884.181370024644, 14904.478343257933, 15743.291551880078, 15855.52433426999, 15933.760993585105, 15940.681186376207, 15988.680226395523, 12292.938535307356, 12397.318147501885, 12440.377981100908, 12493.437795299233, 12610.558630447891, 4058.3506638937924, 4067.2678917794783, 4103.179364127186, 4120.690948178899, 4177.039280965365, 68813.0, 71052.6447367765, 71058.28941710568, 80503.0, 80637.19362806356, 12638.684032899251, 12712.936435317764, 13141.934290328487, 13152.868471315356, 13361.73276534464, 22692.338245223775, 22737.658935115654, 22775.544489110125, 22934.541309173725, 23049.88475057614, 9684.70945871625, 9741.123298903132, 9810.852837207447, 9821.607135714492, 9917.30578859473, 5129.307543481582, 5174.818881339135, 5255.684658920477, 5282.894342113136, 5337.172738225581, 3829.4447305140598, 3900.063984643665, 3938.1139243669945, 3949.150932549516, 3973.8609148679657, 667.1627107979455, 670.4468813229008, 686.9587824730532, 686.9793906182822, 687.9346462086094, 642.9003504456816, 741.9814504637427, 765.5253742679463, 774.9690012399441, 775.6238224461132, 10083.546240419199, 10659.307145035547, 11403.828942565868, 11474.827877581843, 11905.940470297766, 775.1279810213509, 779.111812533712, 781.839722856813, 813.5525460996547, 822.5722624235364, 4903.41159060915, 5264.947350526522, 5305.814296499604, 5306.8938621228135, 5327.493888080626, 73929.26070739224, 74666.0, 74667.0, 86997.0, 110323.44838275758, 77207.61396192983, 99599.50200248952, 101245.0, 102044.48977755064, 102242.0, 89750.0, 89776.10223897677, 89863.10136898547, 91304.54347728351, 92050.53974730083, 10017.248706346907, 10058.0, 10139.797204056025, 10171.847422288523, 10176.796464070529, 48501.514984851114, 51254.74372628113, 51279.743601281756, 53160.0, 53438.465615343346, 49267.0, 72453.637731811, 72674.27325726674, 73677.26322736705, 75806.62096689481, 13943.58169254924, 13962.58112256634, 14253.0, 14479.131252124906, 14486.710265794836, 15591.922040389725, 15721.292541835874, 16734.4142954996, 16795.496135115965, 16816.495505134866, 14449.338335978062, 14806.925965370105, 14916.701665966402, 15712.76430853561, 16028.278727457526, 14667.266636667911, 14761.630959226106, 14819.110853348833, 15283.083015019134, 15401.76897346563, 14519.419223230952, 14564.344604493035, 14642.056612381592, 14644.41422343137, 14672.0, 11889.583864564698, 11915.642530723746, 12352.197107188364, 12451.25292482454, 12668.0, 12449.564265250672, 12531.373431328579, 12591.811122832982, 12823.422945967268, 12919.22484650924], "value": 8012.316586125927, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 110.0, 111.0, 111.0, 110.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 154.0, 175.0, 134.0, 148.0, 155.0, 126.0, 187.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 167.0, 161.0, 162.0, 162.0, 163.0, 170.0, 161.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 181.0, 75.0, 77.0, 75.0, 76.0, 164.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 149.0, 84.0, 85.0, 86.0, 147.0, 86.0, 85.0, 140.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 121.0, 119.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 53.0, 51.0, 53.0, 58.0, 52.0, 52.0, 55.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 61.0, 59.0, 58.0, 59.0, 64.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 76.0, 79.0, 80.0, 78.0, 78.0, 118.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 128.0, 126.0, 125.0, 124.0, 123.0, 120.0, 131.0, 128.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 163.0, 162.0, 157.0, 154.0, 161.0, 159.0, 153.0, 161.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 63.0, 67.0, 63.0, 67.0, 64.0, 62.0, 63.0, 60.0], "value": 64.2, "unit": "score"}]}]} 09:22:27 INFO - Return code: 0 09:22:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:22:27 ERROR - # TBPL SUCCESS # 09:22:27 INFO - Running post-action listener: _resource_record_post_action 09:22:27 INFO - ##### 09:22:27 INFO - ##### Finished run-tests step (success) 09:22:27 INFO - ##### 09:22:27 INFO - Running post-run listener: _resource_record_post_run 09:22:28 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498831360; Read time: 12; Write time: 387416 09:22:28 INFO - TinderboxPrint: CPU usage
13.4% 09:22:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:22:28 INFO - TinderboxPrint: I/O write bytes / time
498,831,360 / 387,416 09:22:28 INFO - TinderboxPrint: CPU idle
8,211.4 (86.6%) 09:22:28 INFO - TinderboxPrint: CPU user
1,212.1 (12.8%) 09:22:28 INFO - TinderboxPrint: Swap in / out
0 / 0 09:22:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 192331776; Read time: 0; Write time: 200580 09:22:28 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252854272; Read time: 12; Write time: 156884 09:22:28 INFO - Running post-run listener: _upload_blobber_files 09:22:28 INFO - Blob upload gear active. 09:22:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:22:28 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 09:22:28 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:22:28 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:32 INFO - (blobuploader) - INFO - Done attempting. 09:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:33 INFO - (blobuploader) - INFO - Done attempting. 09:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:34 INFO - (blobuploader) - INFO - Done attempting. 09:22:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:22:34 INFO - Return code: 0 09:22:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:22:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:22:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd5f674db9b65c8d4691f5bc0b3f389751832d694335371d705935b0d1402e79ba9d5cc5d97acb61a85fcd6390407bd2b45869b3ce7bbbaaca405e4a6a98261b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/423b1fd1ae02f2b68b839b4ce25a92a7a51d9396a8bb86408353a74fdf5991700577067b4a351e5810c55ea3d34f1b68af7a49610424bb84c513f10ad0d414c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b18e0439eb093a374b2d672205aefc0e66e48bc7f1678cb34215736dd9866705552325d7aa4dba62f32d36025df23f5fe38471ee84d6b70ec5129d0b8236103"} 09:22:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:22:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:22:34 INFO - Contents: 09:22:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd5f674db9b65c8d4691f5bc0b3f389751832d694335371d705935b0d1402e79ba9d5cc5d97acb61a85fcd6390407bd2b45869b3ce7bbbaaca405e4a6a98261b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/423b1fd1ae02f2b68b839b4ce25a92a7a51d9396a8bb86408353a74fdf5991700577067b4a351e5810c55ea3d34f1b68af7a49610424bb84c513f10ad0d414c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b18e0439eb093a374b2d672205aefc0e66e48bc7f1678cb34215736dd9866705552325d7aa4dba62f32d36025df23f5fe38471ee84d6b70ec5129d0b8236103"} 09:22:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:22:34 INFO - Copying logs to upload dir... 09:22:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:22:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.326363 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-04 09:22:33.579718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:33.582952) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 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/Mozilla-Aurora/sha512/fd5f674db9b65c8d4691f5bc0b3f389751832d694335371d705935b0d1402e79ba9d5cc5d97acb61a85fcd6390407bd2b45869b3ce7bbbaaca405e4a6a98261b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/423b1fd1ae02f2b68b839b4ce25a92a7a51d9396a8bb86408353a74fdf5991700577067b4a351e5810c55ea3d34f1b68af7a49610424bb84c513f10ad0d414c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b18e0439eb093a374b2d672205aefc0e66e48bc7f1678cb34215736dd9866705552325d7aa4dba62f32d36025df23f5fe38471ee84d6b70ec5129d0b8236103"} build_url:https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/BYGrB0b_T7OUobX4gf_Q4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd5f674db9b65c8d4691f5bc0b3f389751832d694335371d705935b0d1402e79ba9d5cc5d97acb61a85fcd6390407bd2b45869b3ce7bbbaaca405e4a6a98261b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/423b1fd1ae02f2b68b839b4ce25a92a7a51d9396a8bb86408353a74fdf5991700577067b4a351e5810c55ea3d34f1b68af7a49610424bb84c513f10ad0d414c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b18e0439eb093a374b2d672205aefc0e66e48bc7f1678cb34215736dd9866705552325d7aa4dba62f32d36025df23f5fe38471ee84d6b70ec5129d0b8236103"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:33.608429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:33.608801) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467647648.862482-1044519736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:33.693476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:22:33.693832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:22:33.694189) ========= ========= Total master_lag: 0.17 =========