builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1465389856.85 results: success (0) buildid: 20160608030219 builduid: 0c11aa9677234146964981c620c0c4de revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.847709) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.848161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.848455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.862854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.863132) ========= 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-1465388797.827742-538176825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 05:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.9M=0.001s 2016-06-08 05:44:17 (19.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.981942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.982221) ========= 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-1465388797.827742-538176825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014940 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.066798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.067129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --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-1465388797.827742-538176825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 05:44:17,378 truncating revision to first 12 chars 2016-06-08 05:44:17,378 Setting DEBUG logging. 2016-06-08 05:44:17,378 attempt 1/10 2016-06-08 05:44:17,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8ad071a6e14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 05:44:17,697 unpacking tar archive at: mozilla-central-f8ad071a6e14/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.731180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.731528) ========= script_repo_revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.732010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.732310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:17.744804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-08 05:44:17.745161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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-1465388797.827742-538176825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:18 INFO - MultiFileLogger online at 20160608 05:44:18 in /builds/slave/test 05:44:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:18 INFO - {'append_to_log': False, 05:44:18 INFO - 'base_work_dir': '/builds/slave/test', 05:44:18 INFO - 'blob_upload_branch': 'Firefox', 05:44:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:18 INFO - 'branch': 'Firefox', 05:44:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:18 INFO - 'config_files': ('talos/linux_config.py',), 05:44:18 INFO - 'default_actions': ('clobber', 05:44:18 INFO - 'read-buildbot-config', 05:44:18 INFO - 'download-and-extract', 05:44:18 INFO - 'populate-webroot', 05:44:18 INFO - 'create-virtualenv', 05:44:18 INFO - 'install', 05:44:18 INFO - 'run-tests'), 05:44:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:18 INFO - 'download_minidump_stackwalk': True, 05:44:18 INFO - 'download_symbols': 'ondemand', 05:44:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:18 INFO - 'installer_path': 'installer.exe', 05:44:18 INFO - 'log_level': 'info', 05:44:18 INFO - 'log_name': 'talos', 05:44:18 INFO - 'log_to_console': True, 05:44:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:18 INFO - 'opt_config_files': (), 05:44:18 INFO - 'pip_index': False, 05:44:18 INFO - 'sps_profile': False, 05:44:18 INFO - 'sps_profile_interval': 0, 05:44:18 INFO - 'suite': 'dromaeojs-e10s', 05:44:18 INFO - 'system_bits': '32', 05:44:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:18 INFO - 'title': 'talos-linux64-ix-041', 05:44:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:18 INFO - 'use_talos_json': True, 05:44:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:18 INFO - 'work_dir': 'build'} 05:44:18 INFO - ##### 05:44:18 INFO - ##### Running clobber step. 05:44:18 INFO - ##### 05:44:18 INFO - Running pre-action listener: _resource_record_pre_action 05:44:18 INFO - Running main action method: clobber 05:44:18 INFO - rmtree: /builds/slave/test/build 05:44:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - ##### 05:44:19 INFO - ##### Finished clobber step (success) 05:44:19 INFO - ##### 05:44:19 INFO - ##### 05:44:19 INFO - ##### Running read-buildbot-config step. 05:44:19 INFO - ##### 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: read_buildbot_config 05:44:19 INFO - Using buildbot properties: 05:44:19 INFO - { 05:44:19 INFO - "project": "", 05:44:19 INFO - "product": "firefox", 05:44:19 INFO - "script_repo_revision": "production", 05:44:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:44:19 INFO - "repository": "", 05:44:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:44:19 INFO - "buildid": "20160608030219", 05:44:19 INFO - "stage_platform": "linux64-pgo", 05:44:19 INFO - "basedir": "/builds/slave/test", 05:44:19 INFO - "nightly_build": "True", 05:44:19 INFO - "buildnumber": 62, 05:44:19 INFO - "slavename": "talos-linux64-ix-041", 05:44:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:44:19 INFO - "platform": "ubuntu64_hw", 05:44:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:19 INFO - "branch": "mozilla-central", 05:44:19 INFO - "repo_path": "mozilla-central", 05:44:19 INFO - "revision": "f8ad071a6e14331d73fa44c8d3108bc2b66b2174", 05:44:19 INFO - "pgo_build": "True", 05:44:19 INFO - "builduid": "0c11aa9677234146964981c620c0c4de", 05:44:19 INFO - "slavebuilddir": "test" 05:44:19 INFO - } 05:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - ##### 05:44:19 INFO - ##### Finished read-buildbot-config step (success) 05:44:19 INFO - ##### 05:44:19 INFO - ##### 05:44:19 INFO - ##### Running download-and-extract step. 05:44:19 INFO - ##### 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: download_and_extract 05:44:19 INFO - mkdir: /builds/slave/test/build/tests 05:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:19 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:44:30 INFO - Downloaded 1361 bytes. 05:44:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:30 INFO - Using the following test package requirements: 05:44:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:44:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'jsshell-linux-x86_64.zip'], 05:44:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:30 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:37 INFO - Downloaded 24450077 bytes. 05:44:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:38 INFO - Return code: 0 05:44:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:44:38 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')]} 05:44:38 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:44 INFO - Downloaded 24450077 bytes. 05:44:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:45 INFO - Return code: 0 05:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:45 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:44:47 INFO - Downloaded 10833369 bytes. 05:44:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:44:47 INFO - Return code: 0 05:44:47 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')]} 05:44:47 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:44:51 INFO - Downloaded 59230935 bytes. 05:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:51 INFO - mkdir: /builds/slave/test/properties 05:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:44:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:44:51 INFO - Contents: 05:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:52 INFO - Running post-action listener: _resource_record_post_action 05:44:52 INFO - Running post-action listener: set_extra_try_arguments 05:44:52 INFO - ##### 05:44:52 INFO - ##### Finished download-and-extract step (success) 05:44:52 INFO - ##### 05:44:52 INFO - ##### 05:44:52 INFO - ##### Running populate-webroot step. 05:44:52 INFO - ##### 05:44:52 INFO - Running pre-action listener: _resource_record_pre_action 05:44:52 INFO - Running main action method: populate_webroot 05:44:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:52 INFO - '--tppagecycles', 05:44:52 INFO - '7'], 05:44:52 INFO - 'tests': ['tsvgm']}}, 05:44:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:44:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:44:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:44:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['damp', 'tps']}, 05:44:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'tests': ['damp', 'tps']}, 05:44:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['dromaeo_dom']}, 05:44:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['a11yr', 05:44:52 INFO - 'ts_paint', 05:44:52 INFO - 'tpaint', 05:44:52 INFO - 'sessionrestore', 05:44:52 INFO - 'sessionrestore_no_auto_restore', 05:44:52 INFO - 'tabpaint']}, 05:44:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['tsvgx', 05:44:52 INFO - 'tsvgr_opacity', 05:44:52 INFO - 'tart', 05:44:52 INFO - 'tscrollx', 05:44:52 INFO - 'cart']}, 05:44:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:44:52 INFO - 'tsvgr_opacity', 05:44:52 INFO - 'tart', 05:44:52 INFO - 'tscrollx', 05:44:52 INFO - 'cart']}, 05:44:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'talos_options': ['--disable-e10s'], 05:44:52 INFO - 'tests': ['tp5o']}, 05:44:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'tests': ['tp5o']}, 05:44:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'talos_options': ['--disable-e10s', 05:44:52 INFO - '--xperf_path', 05:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:52 INFO - 'tests': ['tp5n']}, 05:44:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:52 INFO - 'talos_options': ['--xperf_path', 05:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:52 INFO - 'tests': ['tp5n']}}, 05:44:52 INFO - 'talos.zip': {'path': '', 05:44:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:52 INFO - Running post-action listener: _resource_record_post_action 05:44:52 INFO - ##### 05:44:52 INFO - ##### Finished populate-webroot step (success) 05:44:52 INFO - ##### 05:44:52 INFO - ##### 05:44:52 INFO - ##### Running create-virtualenv step. 05:44:52 INFO - ##### 05:44:52 INFO - Running pre-action listener: _resource_record_pre_action 05:44:52 INFO - Running main action method: create_virtualenv 05:44:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:44:52 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 05:44:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:44:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:52 INFO - Using real prefix '/usr' 05:44:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:44:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:55 INFO - Installing pip.................done. 05:44:55 INFO - Return code: 0 05:44:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:44:55 INFO - Using env: {'DISPLAY': ':0', 05:44:55 INFO - 'HOME': '/home/cltbld', 05:44:55 INFO - 'LANG': 'en_US.UTF-8', 05:44:55 INFO - 'LANGUAGE': 'en_US:en', 05:44:55 INFO - 'LOGNAME': 'cltbld', 05:44:55 INFO - 'MAIL': '/var/mail/cltbld', 05:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:55 INFO - 'MOZ_NO_REMOTE': '1', 05:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:55 INFO - 'NO_EM_RESTART': '1', 05:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:55 INFO - 'PWD': '/builds/slave/test', 05:44:55 INFO - 'SHELL': '/bin/bash', 05:44:55 INFO - 'SHLVL': '1', 05:44:55 INFO - 'TERM': 'linux', 05:44:55 INFO - 'TMOUT': '86400', 05:44:55 INFO - 'USER': 'cltbld', 05:44:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:55 INFO - '_': '/tools/buildbot/bin/python'} 05:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:55 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 05:44:55 INFO - Cleaning up... 05:44:55 INFO - Return code: 0 05:44:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:44:55 INFO - Using env: {'DISPLAY': ':0', 05:44:55 INFO - 'HOME': '/home/cltbld', 05:44:55 INFO - 'LANG': 'en_US.UTF-8', 05:44:55 INFO - 'LANGUAGE': 'en_US:en', 05:44:55 INFO - 'LOGNAME': 'cltbld', 05:44:55 INFO - 'MAIL': '/var/mail/cltbld', 05:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:55 INFO - 'MOZ_NO_REMOTE': '1', 05:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:55 INFO - 'NO_EM_RESTART': '1', 05:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:55 INFO - 'PWD': '/builds/slave/test', 05:44:55 INFO - 'SHELL': '/bin/bash', 05:44:55 INFO - 'SHLVL': '1', 05:44:55 INFO - 'TERM': 'linux', 05:44:55 INFO - 'TMOUT': '86400', 05:44:55 INFO - 'USER': 'cltbld', 05:44:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:55 INFO - '_': '/tools/buildbot/bin/python'} 05:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:55 INFO - Downloading/unpacking psutil>=3.1.1 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:57 INFO - Installing collected packages: psutil 05:44:57 INFO - Running setup.py install for psutil 05:44:57 INFO - building 'psutil._psutil_linux' extension 05:44:57 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 05:44:57 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 05:44:57 INFO - building 'psutil._psutil_posix' extension 05:44:57 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 05:44:57 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 05:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:58 INFO - Successfully installed psutil 05:44:58 INFO - Cleaning up... 05:44:58 INFO - Return code: 0 05:44:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:44:58 INFO - Using env: {'DISPLAY': ':0', 05:44:58 INFO - 'HOME': '/home/cltbld', 05:44:58 INFO - 'LANG': 'en_US.UTF-8', 05:44:58 INFO - 'LANGUAGE': 'en_US:en', 05:44:58 INFO - 'LOGNAME': 'cltbld', 05:44:58 INFO - 'MAIL': '/var/mail/cltbld', 05:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:58 INFO - 'MOZ_NO_REMOTE': '1', 05:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:58 INFO - 'NO_EM_RESTART': '1', 05:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:58 INFO - 'PWD': '/builds/slave/test', 05:44:58 INFO - 'SHELL': '/bin/bash', 05:44:58 INFO - 'SHLVL': '1', 05:44:58 INFO - 'TERM': 'linux', 05:44:58 INFO - 'TMOUT': '86400', 05:44:58 INFO - 'USER': 'cltbld', 05:44:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:58 INFO - '_': '/tools/buildbot/bin/python'} 05:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:00 INFO - Installing collected packages: mozsystemmonitor 05:45:00 INFO - Running setup.py install for mozsystemmonitor 05:45:00 INFO - Successfully installed mozsystemmonitor 05:45:00 INFO - Cleaning up... 05:45:00 INFO - Return code: 0 05:45:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:00 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')]} 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 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')]} 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:00 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 05:45:00 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 05:45:00 INFO - Using env: {'DISPLAY': ':0', 05:45:00 INFO - 'HOME': '/home/cltbld', 05:45:00 INFO - 'LANG': 'en_US.UTF-8', 05:45:00 INFO - 'LANGUAGE': 'en_US:en', 05:45:00 INFO - 'LOGNAME': 'cltbld', 05:45:00 INFO - 'MAIL': '/var/mail/cltbld', 05:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:00 INFO - 'MOZ_NO_REMOTE': '1', 05:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:00 INFO - 'NO_EM_RESTART': '1', 05:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:00 INFO - 'PWD': '/builds/slave/test', 05:45:00 INFO - 'SHELL': '/bin/bash', 05:45:00 INFO - 'SHLVL': '1', 05:45:00 INFO - 'TERM': 'linux', 05:45:00 INFO - 'TMOUT': '86400', 05:45:00 INFO - 'USER': 'cltbld', 05:45:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:00 INFO - '_': '/tools/buildbot/bin/python'} 05:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:02 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 05:45:02 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 05:45:02 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 05:45:02 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 05:45:02 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 05:45:02 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 05:45:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:02 INFO - warning: no files found matching '*.txt' 05:45:02 INFO - no previously-included directories found matching 'build' 05:45:02 INFO - no previously-included directories found matching 'dist' 05:45:02 INFO - no previously-included directories found matching '.git*' 05:45:02 INFO - Installing collected packages: jsonschema, functools32 05:45:02 INFO - Running setup.py install for functools32 05:45:02 INFO - warning: no files found matching '*.txt' 05:45:02 INFO - no previously-included directories found matching 'build' 05:45:02 INFO - no previously-included directories found matching 'dist' 05:45:02 INFO - no previously-included directories found matching '.git*' 05:45:02 INFO - Successfully installed jsonschema functools32 05:45:02 INFO - Cleaning up... 05:45:02 INFO - Return code: 0 05:45:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:02 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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:02 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 05:45:02 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 05:45:02 INFO - Using env: {'DISPLAY': ':0', 05:45:02 INFO - 'HOME': '/home/cltbld', 05:45:02 INFO - 'LANG': 'en_US.UTF-8', 05:45:02 INFO - 'LANGUAGE': 'en_US:en', 05:45:02 INFO - 'LOGNAME': 'cltbld', 05:45:02 INFO - 'MAIL': '/var/mail/cltbld', 05:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:02 INFO - 'MOZ_NO_REMOTE': '1', 05:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:02 INFO - 'NO_EM_RESTART': '1', 05:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:02 INFO - 'PWD': '/builds/slave/test', 05:45:02 INFO - 'SHELL': '/bin/bash', 05:45:02 INFO - 'SHLVL': '1', 05:45:02 INFO - 'TERM': 'linux', 05:45:02 INFO - 'TMOUT': '86400', 05:45:02 INFO - 'USER': 'cltbld', 05:45:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:02 INFO - '_': '/tools/buildbot/bin/python'} 05:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 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 05:45:05 INFO - Downloading docopt-0.6.1.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:05 INFO - Running setup.py install for blobuploader 05:45:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:05 INFO - Running setup.py install for requests 05:45:06 INFO - Running setup.py install for docopt 05:45:06 INFO - Successfully installed blobuploader requests docopt 05:45:06 INFO - Cleaning up... 05:45:06 INFO - Return code: 0 05:45:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:06 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')]} 05:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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')]} 05:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:06 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 05:45:06 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 05:45:06 INFO - Using env: {'DISPLAY': ':0', 05:45:06 INFO - 'HOME': '/home/cltbld', 05:45:06 INFO - 'LANG': 'en_US.UTF-8', 05:45:06 INFO - 'LANGUAGE': 'en_US:en', 05:45:06 INFO - 'LOGNAME': 'cltbld', 05:45:06 INFO - 'MAIL': '/var/mail/cltbld', 05:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:06 INFO - 'MOZ_NO_REMOTE': '1', 05:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:06 INFO - 'NO_EM_RESTART': '1', 05:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:06 INFO - 'PWD': '/builds/slave/test', 05:45:06 INFO - 'SHELL': '/bin/bash', 05:45:06 INFO - 'SHLVL': '1', 05:45:06 INFO - 'TERM': 'linux', 05:45:06 INFO - 'TMOUT': '86400', 05:45:06 INFO - 'USER': 'cltbld', 05:45:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:06 INFO - '_': '/tools/buildbot/bin/python'} 05:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:06 INFO - Running setup.py (path:/tmp/pip-VnfoDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:06 INFO - Running setup.py (path:/tmp/pip-wZQQvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:06 INFO - Running setup.py (path:/tmp/pip-Zg4KUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:06 INFO - Running setup.py (path:/tmp/pip-XnT76S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:07 INFO - Running setup.py (path:/tmp/pip-gmXJYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:07 INFO - Running setup.py (path:/tmp/pip-6JKDjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:07 INFO - Running setup.py (path:/tmp/pip-wflgwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:07 INFO - Running setup.py (path:/tmp/pip-y4PVzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:07 INFO - Running setup.py (path:/tmp/pip-Nggp3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:07 INFO - Running setup.py (path:/tmp/pip-Slv3DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:07 INFO - Running setup.py (path:/tmp/pip-DzhX7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:07 INFO - Running setup.py (path:/tmp/pip-kvBWMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:07 INFO - Running setup.py (path:/tmp/pip-Xar3xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:07 INFO - Running setup.py (path:/tmp/pip-w_Pfm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:07 INFO - Running setup.py (path:/tmp/pip-Kt2ndS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:07 INFO - Running setup.py (path:/tmp/pip-WVhsl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:07 INFO - Running setup.py (path:/tmp/pip-U1RJhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:07 INFO - Running setup.py install for manifestparser 05:45:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for mozcrash 05:45:08 INFO - Running setup.py install for mozdebug 05:45:08 INFO - Running setup.py install for mozdevice 05:45:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for mozfile 05:45:08 INFO - Running setup.py install for mozhttpd 05:45:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for mozinfo 05:45:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for mozInstall 05:45:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for mozleak 05:45:08 INFO - Running setup.py install for mozlog 05:45:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:08 INFO - Running setup.py install for moznetwork 05:45:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Running setup.py install for mozprocess 05:45:09 INFO - Running setup.py install for mozprofile 05:45:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Running setup.py install for mozrunner 05:45:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Running setup.py install for mozscreenshot 05:45:09 INFO - Running setup.py install for moztest 05:45:09 INFO - Running setup.py install for mozversion 05:45:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:09 INFO - Cleaning up... 05:45:09 INFO - Return code: 0 05:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:09 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 05:45:09 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 05:45:09 INFO - Using env: {'DISPLAY': ':0', 05:45:09 INFO - 'HOME': '/home/cltbld', 05:45:09 INFO - 'LANG': 'en_US.UTF-8', 05:45:09 INFO - 'LANGUAGE': 'en_US:en', 05:45:09 INFO - 'LOGNAME': 'cltbld', 05:45:09 INFO - 'MAIL': '/var/mail/cltbld', 05:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:09 INFO - 'MOZ_NO_REMOTE': '1', 05:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:09 INFO - 'NO_EM_RESTART': '1', 05:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:09 INFO - 'PWD': '/builds/slave/test', 05:45:09 INFO - 'SHELL': '/bin/bash', 05:45:09 INFO - 'SHLVL': '1', 05:45:09 INFO - 'TERM': 'linux', 05:45:09 INFO - 'TMOUT': '86400', 05:45:09 INFO - 'USER': 'cltbld', 05:45:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:09 INFO - '_': '/tools/buildbot/bin/python'} 05:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:09 INFO - Running setup.py (path:/tmp/pip-TuJX6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:10 INFO - Running setup.py (path:/tmp/pip-rulssm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:10 INFO - Running setup.py (path:/tmp/pip-o0M4mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:10 INFO - Running setup.py (path:/tmp/pip-ZoeAQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:10 INFO - Running setup.py (path:/tmp/pip-75g39W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:10 INFO - Running setup.py (path:/tmp/pip-wFLP2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:10 INFO - Running setup.py (path:/tmp/pip-MM6uQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:10 INFO - Running setup.py (path:/tmp/pip-QhqDt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:10 INFO - Running setup.py (path:/tmp/pip-VdJ4MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:10 INFO - Running setup.py (path:/tmp/pip-L9sS65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:10 INFO - Running setup.py (path:/tmp/pip-Xjk5bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:10 INFO - Running setup.py (path:/tmp/pip-rlgpiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:10 INFO - Running setup.py (path:/tmp/pip-W_cwSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:10 INFO - Running setup.py (path:/tmp/pip-R3M3jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:10 INFO - Running setup.py (path:/tmp/pip-KGOlBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:11 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)) 05:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:11 INFO - Running setup.py (path:/tmp/pip-VhFgiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:11 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)) 05:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:11 INFO - Running setup.py (path:/tmp/pip-DctGMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:13 INFO - Downloading blessings-1.6.tar.gz 05:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:13 INFO - Installing collected packages: blessings 05:45:13 INFO - Running setup.py install for blessings 05:45:13 INFO - Successfully installed blessings 05:45:13 INFO - Cleaning up... 05:45:13 INFO - Return code: 0 05:45:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Current package versions: 05:45:13 INFO - argparse == 1.2.1 05:45:13 INFO - blessings == 1.6 05:45:13 INFO - blobuploader == 1.2.4 05:45:13 INFO - docopt == 0.6.1 05:45:13 INFO - functools32 == 3.2.3-2 05:45:13 INFO - jsonschema == 2.5.1 05:45:13 INFO - manifestparser == 1.1 05:45:13 INFO - mozInstall == 1.12 05:45:13 INFO - mozcrash == 0.17 05:45:13 INFO - mozdebug == 0.1 05:45:13 INFO - mozdevice == 0.48 05:45:13 INFO - mozfile == 1.2 05:45:13 INFO - mozhttpd == 0.7 05:45:13 INFO - mozinfo == 0.9 05:45:13 INFO - mozleak == 0.1 05:45:13 INFO - mozlog == 3.2 05:45:13 INFO - moznetwork == 0.27 05:45:13 INFO - mozprocess == 0.22 05:45:13 INFO - mozprofile == 0.28 05:45:13 INFO - mozrunner == 6.11 05:45:13 INFO - mozscreenshot == 0.1 05:45:13 INFO - mozsystemmonitor == 0.3 05:45:13 INFO - moztest == 0.7 05:45:13 INFO - mozversion == 1.4 05:45:13 INFO - psutil == 3.1.1 05:45:13 INFO - requests == 1.2.3 05:45:13 INFO - wsgiref == 0.1.2 05:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 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 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:13 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 05:45:13 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 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 INFO - Cleaning up... 05:45:13 INFO - Return code: 0 05:45:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:13 INFO - Cleaning up... 05:45:13 INFO - Return code: 0 05:45:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3550799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, '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-1465388797.827742-538176825', '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 05:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:14 INFO - Downloading/unpacking flake8 05:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:16 INFO - no previously-included directories found matching 'docs/_build' 05:45:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:16 INFO - Running setup.py install for pep8 05:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:16 INFO - no previously-included directories found matching 'docs/_build' 05:45:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:45:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:17 INFO - Cleaning up... 05:45:17 INFO - Return code: 0 05:45:17 INFO - Running post-action listener: _resource_record_post_action 05:45:17 INFO - Running post-action listener: _start_resource_monitoring 05:45:17 INFO - Starting resource monitoring. 05:45:17 INFO - ##### 05:45:17 INFO - ##### Finished create-virtualenv step (success) 05:45:17 INFO - ##### 05:45:17 INFO - ##### 05:45:17 INFO - ##### Running install step. 05:45:17 INFO - ##### 05:45:17 INFO - Running pre-action listener: _resource_record_pre_action 05:45:17 INFO - Running main action method: install 05:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:17 INFO - Reading from file tmpfile_stdout 05:45:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:17 INFO - Reading from file tmpfile_stdout 05:45:17 INFO - Output received: 05:45:17 INFO - Usage: mozinstall [options] installer 05:45:17 INFO - Options: 05:45:17 INFO - -h, --help show this help message and exit 05:45:17 INFO - -d DEST, --destination=DEST 05:45:17 INFO - Directory to install application into. [default: 05:45:17 INFO - "/builds/slave/test"] 05:45:17 INFO - --app=APP Application being installed. [default: firefox] 05:45:17 INFO - mkdir: /builds/slave/test/build/application 05:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:45:34 INFO - Reading from file tmpfile_stdout 05:45:34 INFO - Output received: 05:45:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:45:34 INFO - Running post-action listener: _resource_record_post_action 05:45:34 INFO - ##### 05:45:34 INFO - ##### Finished install step (success) 05:45:34 INFO - ##### 05:45:34 INFO - ##### 05:45:34 INFO - ##### Running run-tests step. 05:45:34 INFO - ##### 05:45:34 INFO - Running pre-action listener: _resource_record_pre_action 05:45:34 INFO - Running main action method: run_tests 05:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:45:34 INFO - Python 2.7.3 05:45:34 INFO - Return code: 0 05:45:34 INFO - grabbing minidump binary from tooltool 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31c0>, '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 0x10a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:45:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:45:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:45:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:45:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:34 INFO - Return code: 0 05:45:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:45:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:45:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:45:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:45:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:45:35 INFO - Return code: 0 05:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.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 05:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.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 05:45:35 INFO - Using env: {'DISPLAY': ':0', 05:45:35 INFO - 'HOME': '/home/cltbld', 05:45:35 INFO - 'LANG': 'en_US.UTF-8', 05:45:35 INFO - 'LANGUAGE': 'en_US:en', 05:45:35 INFO - 'LOGNAME': 'cltbld', 05:45:35 INFO - 'MAIL': '/var/mail/cltbld', 05:45:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:35 INFO - 'MOZ_NO_REMOTE': '1', 05:45:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:35 INFO - 'NO_EM_RESTART': '1', 05:45:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:35 INFO - 'PWD': '/builds/slave/test', 05:45:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:35 INFO - 'SHELL': '/bin/bash', 05:45:35 INFO - 'SHLVL': '1', 05:45:35 INFO - 'TERM': 'linux', 05:45:35 INFO - 'TMOUT': '86400', 05:45:35 INFO - 'USER': 'cltbld', 05:45:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465388797.827742-538176825', 05:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:35 INFO - '_': '/tools/buildbot/bin/python'} 05:45:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.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 05:45:35 INFO - mozversion application_buildid: 20160608030219 05:45:35 INFO - mozversion application_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 05:45:35 INFO - mozversion application_display_name: Nightly 05:45:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:35 INFO - mozversion application_name: Firefox 05:45:35 INFO - mozversion application_remotingname: firefox 05:45:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:45:35 INFO - mozversion application_vendor: Mozilla 05:45:35 INFO - mozversion application_version: 50.0a1 05:45:35 INFO - mozversion platform_buildid: 20160608030219 05:45:35 INFO - mozversion platform_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 05:45:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:45:35 INFO - mozversion platform_version: 50.0a1 05:45:35 INFO - using testdate: 1465389935 05:45:35 INFO - actual date: 1465389935 05:45:35 INFO - starting webserver on 'localhost:50439' 05:45:35 INFO - SUITE-START | Running 2 tests 05:45:35 INFO - TEST-START | dromaeo_css 05:45:35 INFO - operating with platform_type : linux_ 05:45:35 INFO - Initialising browser for dromaeo_css test... 05:45:35 INFO - TEST-INFO | started process 7694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppcbGgg/profile http://localhost:50439/getInfo.html) 05:45:40 INFO - PROCESS | 7694 | __metrics Screen width/height:1600/1200 05:45:40 INFO - PROCESS | 7694 | colorDepth:24 05:45:40 INFO - PROCESS | 7694 | Browser inner width/height: 1024/697 05:45:40 INFO - PROCESS | 7694 | __metrics 05:45:41 ERROR - PROCESS | 7694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:45:42 INFO - TEST-INFO | 7694: exit 0 05:45:42 INFO - Browser initialized. 05:45:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:42 INFO - TEST-INFO | started process 7817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppcbGgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:54 INFO - PROCESS | 7817 | RSS: Main: 166887424 05:45:54 INFO - PROCESS | 7817 | 05:46:43 INFO - PROCESS | 7817 | 1465390003733 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] 05:48:51 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50439/tests/dromaeo/cssquery-ext.html) 05:48:52 INFO - PROCESS | 7817 | RSS: Main: 170782720 05:48:52 INFO - PROCESS | 7817 | 05:51:54 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-ext.html (next: http://localhost:50439/tests/dromaeo/cssquery-jquery.html) 05:51:55 INFO - PROCESS | 7817 | RSS: Main: 170180608 05:51:55 INFO - PROCESS | 7817 | 05:54:56 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50439/tests/dromaeo/cssquery-mootools.html) 05:54:57 INFO - PROCESS | 7817 | RSS: Main: 171606016 05:54:57 INFO - PROCESS | 7817 | 05:57:59 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50439/tests/dromaeo/cssquery-prototype.html) 05:57:59 INFO - PROCESS | 7817 | RSS: Main: 168914944 05:57:59 INFO - PROCESS | 7817 | 06:01:02 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50439/tests/dromaeo/cssquery-yui.html) 06:01:02 INFO - PROCESS | 7817 | RSS: Main: 170319872 06:01:02 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | Cycle 1(1): loaded http://localhost:50439/tests/dromaeo/cssquery-yui.html (next: http://localhost:50439/tests/dromaeo/cssquery-dojo.html) 06:04:05 INFO - PROCESS | 7817 | RSS: Main: 171982848 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | __start_tp_report 06:04:05 INFO - PROCESS | 7817 | _x_x_mozilla_page_load 06:04:05 INFO - PROCESS | 7817 | _x_x_mozilla_page_load_details 06:04:05 INFO - PROCESS | 7817 | |i|pagename|runs| 06:04:05 INFO - PROCESS | 7817 | |0;dojo.html;3100.395422892536;3176.571162893009;3183.8248896310693;3194.8562314695864;3227.7417806575477;5305.681659100456;5306.124489459235;5361.705106219157;5418.9458105418935;5458.9454105458935;5168.121419358708;5332.440093790145;5371.75827087781;5393.973030134854;5403.945960540394;4809.4469136049365;4834.7824347904425;4847.5394837490385;4974.303597496353;4991.725455099986;4824.686395384307;5005.499450054984;5041.621878359119;5046.192609182532;5055.545000949914;4785.976070119662;4859.805607775685;4866.075445665312;4935.5064493550535;4951.975240123795;4858.392700912386;4878.609711223094;4879.194932836078;4906.681065730716;4936.90126197474;4894.706317620954;4895.069936712013;4902.48523904992;4904.852854414374;4928.383952005999;5076.64463487556;5231.581473482112;5244.8688782780355;5271.947280527184;5297.841064768063;5753.280839895013;5781.421857814227;5787.074068149118;5794.68129252891;5797.420257974211;5581.05122129239;5725.370209276976;5752.050911599623;5758.769649214027;5769.740361683735;5312.893742125175;5314.4951229633125;5338.332708411449;5366.973165134188;5377.542908852753;5806.187133801272;5814.970925145347;5824.388439213906;5825.766969321265;5829.950608890441;5434.972825135849;5551.195076713854;5633.830985070373;5642;5643.80246691372;5629.831105066854;5686.175504551899;5686.545076393879;5696.943030569724;5737.569682273846;5479;5625.296837895263;5659.745311460994;5677.318721753333;5727.513161381329;5766.192733017381;5790.942090579125;5814.505767009767;5815.476607105381;5856.150858125633;4379.9781001095425;4414.779261036935;4419.160359531678;4427.69006169565;4455.064436468313;3876.8643097491454;3893.766374017568;3910.6089391061237;3944.9408258876138;4007.438958545806;5464.207689885024;5496.890062198733;5529.640573362719;5529.640573362719;5586.720663966786;5783.652980821164;5790.044642633919;5812.680302583314;5818.5636077294375;5847.649141051551;5274.789008439696;5456.154296084113;5500.1749737538885;5550.139728342114;5567.972160139255;4828.517148285214;4844.2007068833955;4876.366072410564;4877.902441951142;4882.5605695487575;5965.403459654;5980.700964951735;6010.429009244115;6018.337982821886;6025.849353766191;5559.861003474864;5775.133729940542;5778.56660750437;5795.94204057954;5861.736221870111;5987.491063259497;5989.850253743692;5992.43071908168;5998.670073145844;6001.219841420762;5463.863403414946;5722.484976352148;5724.198612194213;5732.082866741302;5733.799317024051;5755.1942728017275;5771.769129234952;5792.247007888947;5838.649681019152;5869.53043756507;5641.266635337544;5697.7151142443545;5703.201551782837;5705.971470142623;5713.457221563945;5438.347398312228;5542.889142217214;5638.351589567253;5657.8019769307875;5662.745176466987;5320.388155362183;5386.326709161355;5475.780968761364;5503.697296648723;5569.220309156803;5632.690202038927;5641.379448260606;5643.238162847963;5646.040173170489;5668.801591944262;5281.313429254173;5494.780208791603;5517.2551705519245;5531.446855314597;5551.417101204477 06:04:05 INFO - PROCESS | 7817 | |1;ext.html;585.7071464267866;634.6858305138957;637.1207733328007;641.249737806766;658.3844105761113;42093.57906420935;43369.13261734767;43580.346294805604;43609.78195109028;47657.76171119148;45710;46360.304595431095;46476;46482.302765458546;46580.06839863201;8771.166739159786;8913.598888050054;8940.731778046636;8982.236509896667;8984.8652270216;8840.8673869892;8870.778230544223;8902.599383027748;8908.910910890905;8914.153155450254;8876.600552975131;8883.378163528556;8924.8661270081;9010.729678109634;9013.233875120623;8720;8732.607032683545;8751.12488751123;8756.956215218883;8771.429857059271;8698.608562614698;8826.823463530758;8842.823143537093;8850.557472126433;8857.468551886843;42045.789771051255;42228.36657450141;42344;42382.57617423848;42498;3478.339115568034;3525.4888041233876;3562.679358857715;3594.3889538778208;3851.229754049173;30507.847460762776;32246;32282.677173228436;32703.83648081768;33970.49044264338;4379.562043795627;4393.890152746175;4415.100694410057;4455.1535208310315;4489.73061616304;353488;353774;354462;354904.22547887353;355548;58722.18305810109;58992.705036474545;59069.40930590725;59236.40763592395;59274.40725592689;35374;62867.6856615714;63240.367596324366;63316.68341658262;63597.364026359144;16336.428225012305;16647.084410357547;16701.49895503137;16708.49874503767;16863.662726745642;12411.255324680547;12472;12545.93727031359;12592.370381480889;12593.181443206162;19714.60570788605;19898.801011989985;19921;19997.300094496622;20081.196752130043;7121.928780712126;7158.2125966143685;7297.087864016998;7342.743003994835;7352.301531354513;956.5026186383042;989.1592146675268;1009.1926458833051;1065.8667666541683;1093.1801149138146;32922.67077329244;33320.50019249713;33429;33449.49825752616;33881.32237355239;1132.1904838040675;1184.8743693491217;1195.5158160944832;1215.428748488209;1246.0654509118162;16806.831931680772;17378.826211737975;17401.91299043497;17460.301587936596;17478.825211747975;510505;516019;520753;521623;521743;58003;59592.40407595955;59709;59727;59863;1353.8916886649044;1408.978865317021;1410.3864818803854;1419.6734751007325;1420.609332433589;31075.533866992464;32470.837645811618;32592;32620.83689581537;32768.67231327656;51143.48856511536;51746.223806643684;52197;52266;52342.47657523376;437840;439024;439926;443561;444044;27828.582571261042;27915.44169116647;28077;28220;28228.294292642848;43252.351214732436;43273.3508997359;43304.133917322106;46345.536544634124;49544.75227623839;40507.59492405038;40706.59293407028;41608.791956040026;41939.7903010483;42192.36711449392;40097.39853902136;41545;41659.1668166641;41901.580984189764;42260.36609450922;40508.79745601253;41043;41561.58438415698;41604;41667;35380;36714.8164259177;37030.8148459256;37168.25663486661;37223;28161.43677126487;28174.85912570506;28178.85910570434;28290.151295461168;28390 06:04:05 INFO - PROCESS | 7817 | |2;jquery.html;389.83432041382423;397.47334781414634;401.7609522334211;402.1133400851124;416.2736025635267;13757;17783.73324400135;18516.629667406643;19274.32539861105;19339.129739161737;18328.35850745224;18475;18594.53513662159;19726.309579164732;19955.301564445246;5450.482204190605;5490.560755139599;5674.773009079632;5724.169995350671;5751.079827227644;5625.774969001235;5632.943670563303;5640.661560306375;5642.605017648766;5654.915176272339;5412.864678383033;5570.303712035996;5598.636088654245;5671.574631902603;5678.034734095214;5638.830835074913;5656.151577263402;5657.999999999979;5670.319561652607;5670.6390466288;4822.156122678517;5060.822871199491;5116.616253780944;5140.126178549655;5168.173092305213;18071.548211294823;18435;22020.779792202033;22120;22240.666390004164;2155;2172.3374370816896;2172.717546718932;2232.3972527417504;2326.8720220387872;9425.151736343762;9709.126178643884;9812.313138080337;9889.703308900744;9928.205743540499;1865.337805079191;1874.7187921811837;1927.267638297438;1934.3616606519956;1963.6072785442968;54248.72875635636;77783.6110819448;80124.19875801283;81766.9999999994;82361;9574.234061275081;10873.891261087447;11150.553977840795;11600.071994240441;11647;15040.398384064734;15060.171690557125;15082.095074295577;15124.319405626773;15126.546203613689;8018.919810801934;8019.1579884111325;8091.1504292048485;8130.837383252302;8354.373421993374;7699.884501732478;7772.300492955661;7835.216478352233;8030.277275045274;8103.270705636521;4311.741295522279;4458.882031035232;4501.257292546758;4738.691985020962;4746.335513028179;1936.1577713694587;1961.4507937777446;1970.7930667280016;1971.3001884331143;1980.5642758593374;866.332923648787;1006.5369929832212;1061.830107182847;1129.5820546397886;1137.5449820071872;16950.915245423694;18886.43340699781;19180.904095479433;19804;20771.169153233703;1026.97432564185;1050.7898420315814;1053.6786280184617;1056.334509259162;1068.5458680060942;9402;11017.614383496699;11166.944165279285;11226.7193320166;11231.494582743797;481853;495110;497658;504316;538880;78414;89193;97069;98796.50601746945;100853;1033.4987531047436;1089.1776708584969;1094.6059418609295;1105.9723506912392;1115.0800589513522;17486.213120409357;17499;17812;17983.820161798216;18024.188911499277;35054;39504.407433887936;41697.583024170584;43448;43466;57369.42630573641;60207.69896150491;60361.39638603558;60893;60905.390946089974;8541.914580854113;8639.524826134622;8749.387542871938;8751.64993400257;9038.593263303299;9929.404235745878;13016.93491532574;13138.605841824761;13365.599032029055;13666.658333541343;11631.185816992729;11677.76644467123;11816.645500634995;11925.642230733092;11957.880421195676;11403.657890263305;11615.361155136548;11667.708307292385;11708.590199342982;11908.702282443008;11323.32060076398;11754.941225293818;11756.059515238589;11858.11064170208;11903.583374581847;8515.957420212859;8574.742757717278;8653.69712060075;8699.347548933729;8805.295576354005;11027.503762330554;11803.291802491878;11873.406329683308;12278.079144064051;12478.5008599655 06:04:05 INFO - PROCESS | 7817 | |3;mootools.html;1460.9838422976295;1489.5084622074717;1620.5948512871782;1792.2203841329015;1800.3968670495383;7188;8127.593620318975;8333.749987500378;8903.643854245822;8918.955405222972;8170.6323215455295;8451.239388455038;8495.702650407236;8535.48787072776;8541.231289183972;2153.9030743616577;2183.3559100065518;2200.5378870437225;2201.8458707890454;2208.867467951928;2136.166894910986;2145.3242228697986;2149.355193441969;2193.4406726284774;2256.2103263857684;2147.6456384696507;2157.7916366834625;2257.604919139144;2263.852849564781;2268.3081660093667;2137.914483420669;2162.7296587926508;2164.3723320237114;2164.5779073080757;2166.4150679316576;2053.938381848547;2056.7017782421467;2064.133064113076;2065.824404925583;2067.648499755045;8424.452410593352;8457.95771021147;8475.49147051179;8482.957585212096;8495.320374370036;4986.052649996525;4995.825146119869;5017;5049.5455409013;5116.232565115262;3145.90797119915;3171.476706343474;3366.8653253869816;3379.5775528058994;3390.6100798408006;1121.3272036777948;1130.491278924479;1152.6168597682731;1182.9585964491287;1198.7842188406084;11998.760024799456;12035.217710848767;12055.156139070268;12065.638030859089;12115.636530904087;4337.132573485315;4353.738775673406;4384.714993525411;4418.690691651618;4471.709338892962;10262.384256944608;10279.94860025695;10302.793944121076;10306;10321.071103600712;4968.701877887338;4970.975145124251;5028;5091.745412729423;5094.923576146287;3973.264945984944;4519.909601807945;4635.582797548237;4725.621950243973;4798.5441383068555;3819.5989421110385;3822.3119838429348;3880.9805950970062;3955.3473676843573;3958.5051868516434;1181.1141643767176;1182.1724792645011;1197.6107764976243;1203.284045992633;1211.7031327324862;855.9786005349791;957.8563215517728;983.5180761426849;1005.6228914157191;1022.6625213679467;6076.574639775262;6132.872255081203;6157.599756015845;6188.350223226586;6274.717637706314;432.06458018390464;439.8900274931267;442.1312121680912;1058.2909450668071;1073.6778966310076;4235.470566179228;4257.787110644455;4266.722663026893;4282.036541778075;4336.76147811867;10670.839937400946;10980.450977451095;10991.340519568852;10995.560177592806;11014.889851101387;10887.237893347548;10901.182411319025;10966.06788422993;10995.230333876712;11018.944905275423;7724.7682569523;7958.960205198937;7980.521168729895;8121.4721043132;8140.104588495261;5965.373635768182;6183.96908015457;6191.318954915046;6212.099245609271;6340.461060809883;9749.463779492196;10006.549705263134;10272.691819245434;10288.228382871164;10299.845502317321;9884.604615815288;10164.0344167304;10209.38743675382;10213.846792297973;10494.947525262325;6781.38967492928;7361;7394.963025184839;7546.886796697944;7547.471676982558;8568.914310856811;8581.742547723577;8647.654093836176;8650.91349086501;8682.305415566865;7341.889871651822;7423.517471364344;7436.307323408759;7575.6969721210535;7662.616869156408;7295;7397.963010184914;7405.111386633638;7542;7552.546847189186;6971.407430368476;6983.336583024605;7025.437964962893;7091.60996145217;7119.110111236096;5166.199239117943;5210.5831533477985;5306.363236411656;5404.891902161856;5414.729263536886;5361.195820626781;5382.3541175059245;5418.756155973069;5430.484104010113;5433.266509021231 06:04:05 INFO - PROCESS | 7817 | |4;prototype.html;333.78971248113686;336.9174552234703;336.94440417331134;347.40940401317766;349.0244765879367;5508.917366239504;5589.077802162648;5616.5787565932515;5691.8007869724515;5705.459525927997;5533.335999680034;5562.221289019541;5567.415421380758;5590.049691552445;5593.62956075761;4137.81379837908;4211.8525851595205;4292.14157168566;4303.419038429804;4318.784060796963;4246.490421149451;4292.227399068166;4324.762138082404;4334.804933777988;4342.71889792512;4271.124419494012;4303.117860838536;4310.418093557377;4311.762853043081;4311.935320970188;4038.5557588665224;4227.915441691149;4239.872803815891;4242.215190189794;4350.36919646651;3653.995151333378;3662.1577037281572;3697.759645623026;3702.38910579754;3706.4440333949856;5295.437845835488;5311.521963023308;5336.332958380202;5339.305890234284;5369.167778994223;4702.388689470381;4831.154547954129;4911.312416261726;4927.433345165316;4939;5715.942550628147;5805.245318108661;5835.824925252249;5844.678542680151;5847.44449277318;4138.52406973199;4141.668666506703;4144.585541445861;4155.148194620096;4157.5010998680045;5843.678597677126;5930.466258036798;5970.313413957407;5985.281766188085;6152.446279834791;4140.358244472111;4174.603412675791;4176.31090870003;4179.477565304337;4212.53662097169;4264.424302719155;4276.957230427656;4287;4314.417553630283;4319.222539942778;4635.837745678885;4907.601333619972;4927.1131196384995;4942.184539550934;4943.5508042761085;5784.1902133701315;5795.666996590808;5836.562257830679;5871.324797648325;5903.7565725024215;1463.1659953826218;1478.9482368117278;1482.3181336585076;1483.509073381245;1492.2613306413177;939.3049143633798;951.45766912859;978.2467500024941;979.774651830083;995.2038369304528;5564.8330550083565;5574.358948720868;5588.832335029955;5619.494245517923;5630.155476678531;5911.3201981772645;5918;5932.317783454958;5962.314333851576;5986.461218490357;5398.352197736297;5653.152027195953;5717.799877004368;5723.198752174699;5740;3206.0862654143457;3216.7587430942303;3232.3535292941506;3239.935201296008;3243.2702641905385;6060.272767267956;6078.209832721718;6204.13142160089;6232.532560058014;6247.812565623039;6108.51131909455;6150.3849615039035;6155.938440615537;6162.5378096642935;6180.381961803873;6076.3012253591405;6105.755769769248;6163.630182189083;6187.659678717714;6214.067889816563;5907.232059832194;5949.672767997802;5978.701064946822;6013.548983826318;6042.546808989256;5912.881742365214;5973.850653733692;5982.850428739316;5991.970040149771;5995.310539288038;6055.818325450244;6117.694115294128;6120.938790612036;6143.017117261216;6274.623522588659;4183.707140500257;4227.513835908787;4228.302330115496;4234;4253.95746042548;5763.33721622002;5968.582199246011;6004.699765011819;6030.246219222598;6050.515958723204;5669.461401167047;5739.167820666064;5747.166660834239;5787.826365209051;5822.272215973004;5724.227229324155;5769.653820770767;5777;5819.854503637443;5836.678982655994;5543.307086614173;5691.4877661010705;5719.597768937139;5725.482747072113;5741.942580574141;5847.181394604674;5857.9121313179485;5866.2960444746905;5909.172715819875;5923.970380148072;5514.448555144453;5699.8860022800145;5747.36778954323;5786.623869448473;5826.533877289722 06:04:05 INFO - PROCESS | 7817 | |5;yui.html;792.1247022040645;798.6725442568546;817.333872893592;819.2790344496842;842.5660784695883;14906.180160091191;15817;15821.920890395546;15871.76192357114;16191.109488978102;13419.731605367886;13745.106568073094;13789.862101378983;13808;13840;827.9917200827974;837.2924878477708;839.2069494327862;839.3620848155415;843.527624530265;794.3922898982283;820.2248874813304;835.6907944060706;840.3445312656107;840.3907167303687;863.4905405810571;864.1099667342647;864.2524216552669;864.6454953469079;870.0733718589713;855.7389996051202;857.4426622695236;859.0807835615893;860.7245681381929;863.8920134983127;626.8965620672584;626.9498440124779;629.5939119268093;630.1902055858246;631.3307893632764;15106.39574417022;15159.924200378928;15169.24153792306;15188.46840360582;15221.086734795948;14081.718365632732;14355;14370.20963846988;14500.347484363228;14517.128972261698;12248.142630015902;12312.630621081382;12423.75152496954;12575.622731318075;12744.171628844188;3788.5264341957254;3866.735028099521;3915.256101340736;3927.8428862845453;4018.578049304839;61248.69375653138;64512.67743661298;64944.02583961197;73221.26778732198;75448.62275688641;11102.61140860066;11192.720181995515;11319.886801131883;11322.547098115983;11346.602868899714;21145.365639030853;21218.893905530374;21249.150033998776;21281.042353094148;21360.465988350417;8684.522351270742;8741.781455463664;8753.037165911745;8756.912430875736;8762.38663293576;4711.128441238382;4783.282507623884;4783.6651434399955;4810.42274927011;5154.278401023859;3618.4029635110437;3734.7945862977253;3735.589085200626;3738.4579236010627;3745.194783121642;634.955553111287;649.3928177154281;655.1941112431736;656.1896058367912;657.454312920275;626.5989766549412;748.805310619243;765.8626938995587;804.4529719790481;825.5707032343148;9706;9933.205343572497;10087.49562521871;10244.180465562737;10263.692089237335;650.7136859781681;705.5378726933867;705.9294070592899;717.2253965717013;750.557171268954;4703.717776933395;4752.334673145762;4789.808407663654;4792.616590672737;4996.325496057985;93302;110450.44774776236;111630;113362;114590;96832.51583742036;97934;99874.00125998793;99973;100162.49918750359;54819.17771233435;75983.62008190034;82225.58887205526;85945.14054859497;86330.5683471566;9191.678291259774;9775.462349570842;9862.852057219005;9865.950670246602;9877.209823213982;50602.49397505978;51039;51092.23361649652;53088.469115308355;53610;68179.65910170418;73685.6315718418;74036.25963740294;74077.62961185159;74586;11333.206675532634;11508.136889733136;11593.59422420245;11806.645800625995;11933.880661193278;13057.28184949837;13214.537491187762;13264.53574124901;13830.308484575933;14686.706265874836;13161.60515184546;13265.867341326462;13281.136726112773;13303.334833258492;13710.52013179534;12708.87291127077;12903;13123.278219698008;13175.802362964754;13566.38951247216;12892.613221603367;13324.467021319426;13445.529406470727;13463.865361346261;13736.381862815997;10359.741006474596;10488.475576221312;10538.578456861946;10569.365838049434;11003.284786488852;10233.897661023295;10583.94708026455;11161.860976463075;11363.602273920704;11382.601608943647 06:04:05 INFO - PROCESS | 7817 | __end_tp_report 06:04:05 INFO - PROCESS | 7817 | __start_cc_report 06:04:05 INFO - PROCESS | 7817 | _x_x_mozilla_cycle_collect,353 06:04:05 INFO - PROCESS | 7817 | __end_cc_report 06:04:05 INFO - PROCESS | 7817 | __startTimestamp1465391045802__endTimestamp 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | ------- Summary: start ------- 06:04:05 INFO - PROCESS | 7817 | Number of tests: 6 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#0] dojo.html Cycles:165 Average:5337.40 Median:5529.64 stddev:600.13 (10.9%) stddev-sans-first:575.74 06:04:05 INFO - PROCESS | 7817 | Values: 3100.4 3176.6 3183.8 3194.9 3227.7 5305.7 5306.1 5361.7 5418.9 5458.9 5168.1 5332.4 5371.8 5394.0 5403.9 4809.4 4834.8 4847.5 4974.3 4991.7 4824.7 5005.5 5041.6 5046.2 5055.5 4786.0 4859.8 4866.1 4935.5 4952.0 4858.4 4878.6 4879.2 4906.7 4936.9 4894.7 4895.1 4902.5 4904.9 4928.4 5076.6 5231.6 5244.9 5271.9 5297.8 5753.3 5781.4 5787.1 5794.7 5797.4 5581.1 5725.4 5752.1 5758.8 5769.7 5312.9 5314.5 5338.3 5367.0 5377.5 5806.2 5815.0 5824.4 5825.8 5830.0 5435.0 5551.2 5633.8 5642.0 5643.8 5629.8 5686.2 5686.5 5696.9 5737.6 5479.0 5625.3 5659.7 5677.3 5727.5 5766.2 5790.9 5814.5 5815.5 5856.2 4380.0 4414.8 4419.2 4427.7 4455.1 3876.9 3893.8 3910.6 3944.9 4007.4 5464.2 5496.9 5529.6 5529.6 5586.7 5783.7 5790.0 5812.7 5818.6 5847.6 5274.8 5456.2 5500.2 5550.1 5568.0 4828.5 4844.2 4876.4 4877.9 4882.6 5965.4 5980.7 6010.4 6018.3 6025.8 5559.9 5775.1 5778.6 5795.9 5861.7 5987.5 5989.9 5992.4 5998.7 6001.2 5463.9 5722.5 5724.2 5732.1 5733.8 5755.2 5771.8 5792.2 5838.6 5869.5 5641.3 5697.7 5703.2 5706.0 5713.5 5438.3 5542.9 5638.4 5657.8 5662.7 5320.4 5386.3 5475.8 5503.7 5569.2 5632.7 5641.4 5643.2 5646.0 5668.8 5281.3 5494.8 5517.3 5531.4 5551.4 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#1] ext.html Cycles:180 Average:60132.75 Median:42244.37 stddev:117264.87 (277.6%) stddev-sans-first:117508.60 06:04:05 INFO - PROCESS | 7817 | Values: 585.7 634.7 637.1 641.2 658.4 42093.6 43369.1 43580.3 43609.8 47657.8 45710.0 46360.3 46476.0 46482.3 46580.1 8771.2 8913.6 8940.7 8982.2 8984.9 8840.9 8870.8 8902.6 8908.9 8914.2 8876.6 8883.4 8924.9 9010.7 9013.2 8720.0 8732.6 8751.1 8757.0 8771.4 8698.6 8826.8 8842.8 8850.6 8857.5 42045.8 42228.4 42344.0 42382.6 42498.0 3478.3 3525.5 3562.7 3594.4 3851.2 30507.8 32246.0 32282.7 32703.8 33970.5 4379.6 4393.9 4415.1 4455.2 4489.7 353488.0 353774.0 354462.0 354904.2 355548.0 58722.2 58992.7 59069.4 59236.4 59274.4 35374.0 62867.7 63240.4 63316.7 63597.4 16336.4 16647.1 16701.5 16708.5 16863.7 12411.3 12472.0 12545.9 12592.4 12593.2 19714.6 19898.8 19921.0 19997.3 20081.2 7121.9 7158.2 7297.1 7342.7 7352.3 956.5 989.2 1009.2 1065.9 1093.2 32922.7 33320.5 33429.0 33449.5 33881.3 1132.2 1184.9 1195.5 1215.4 1246.1 16806.8 17378.8 17401.9 17460.3 17478.8 510505.0 516019.0 520753.0 521623.0 521743.0 58003.0 59592.4 59709.0 59727.0 59863.0 1353.9 1409.0 1410.4 1419.7 1420.6 31075.5 32470.8 32592.0 32620.8 32768.7 51143.5 51746.2 52197.0 52266.0 52342.5 437840.0 439024.0 439926.0 443561.0 444044.0 27828.6 27915.4 28077.0 28220.0 28228.3 43252.4 43273.4 43304.1 46345.5 49544.8 40507.6 40706.6 41608.8 41939.8 42192.4 40097.4 41545.0 41659.2 41901.6 42260.4 40508.8 41043.0 41561.6 41604.0 41667.0 35380.0 36714.8 37030.8 37168.3 37223.0 28161.4 28174.9 28178.9 28290.2 28390.0 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#2] jquery.html Cycles:180 Average:29110.55 Median:2279.63 stddev:83011.43 (3641.4%) stddev-sans-first:83216.29 06:04:05 INFO - PROCESS | 7817 | Values: 389.8 397.5 401.8 402.1 416.3 13757.0 17783.7 18516.6 19274.3 19339.1 18328.4 18475.0 18594.5 19726.3 19955.3 5450.5 5490.6 5674.8 5724.2 5751.1 5625.8 5632.9 5640.7 5642.6 5654.9 5412.9 5570.3 5598.6 5671.6 5678.0 5638.8 5656.2 5658.0 5670.3 5670.6 4822.2 5060.8 5116.6 5140.1 5168.2 18071.5 18435.0 22020.8 22120.0 22240.7 2155.0 2172.3 2172.7 2232.4 2326.9 9425.2 9709.1 9812.3 9889.7 9928.2 1865.3 1874.7 1927.3 1934.4 1963.6 54248.7 77783.6 80124.2 81767.0 82361.0 9574.2 10873.9 11150.6 11600.1 11647.0 15040.4 15060.2 15082.1 15124.3 15126.5 8018.9 8019.2 8091.2 8130.8 8354.4 7699.9 7772.3 7835.2 8030.3 8103.3 4311.7 4458.9 4501.3 4738.7 4746.3 1936.2 1961.5 1970.8 1971.3 1980.6 866.3 1006.5 1061.8 1129.6 1137.5 16950.9 18886.4 19180.9 19804.0 20771.2 1027.0 1050.8 1053.7 1056.3 1068.5 9402.0 11017.6 11166.9 11226.7 11231.5 481853.0 495110.0 497658.0 504316.0 538880.0 78414.0 89193.0 97069.0 98796.5 100853.0 1033.5 1089.2 1094.6 1106.0 1115.1 17486.2 17499.0 17812.0 17983.8 18024.2 35054.0 39504.4 41697.6 43448.0 43466.0 57369.4 60207.7 60361.4 60893.0 60905.4 8541.9 8639.5 8749.4 8751.6 9038.6 9929.4 13016.9 13138.6 13365.6 13666.7 11631.2 11677.8 11816.6 11925.6 11957.9 11403.7 11615.4 11667.7 11708.6 11908.7 11323.3 11754.9 11756.1 11858.1 11903.6 8516.0 8574.7 8653.7 8699.3 8805.3 11027.5 11803.3 11873.4 12278.1 12478.5 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#3] mootools.html Cycles:180 Average:5710.83 Median:4369.23 stddev:3287.28 (75.2%) stddev-sans-first:3280.99 06:04:05 INFO - PROCESS | 7817 | Values: 1461.0 1489.5 1620.6 1792.2 1800.4 7188.0 8127.6 8333.7 8903.6 8919.0 8170.6 8451.2 8495.7 8535.5 8541.2 2153.9 2183.4 2200.5 2201.8 2208.9 2136.2 2145.3 2149.4 2193.4 2256.2 2147.6 2157.8 2257.6 2263.9 2268.3 2137.9 2162.7 2164.4 2164.6 2166.4 2053.9 2056.7 2064.1 2065.8 2067.6 8424.5 8458.0 8475.5 8483.0 8495.3 4986.1 4995.8 5017.0 5049.5 5116.2 3145.9 3171.5 3366.9 3379.6 3390.6 1121.3 1130.5 1152.6 1183.0 1198.8 11998.8 12035.2 12055.2 12065.6 12115.6 4337.1 4353.7 4384.7 4418.7 4471.7 10262.4 10279.9 10302.8 10306.0 10321.1 4968.7 4971.0 5028.0 5091.7 5094.9 3973.3 4519.9 4635.6 4725.6 4798.5 3819.6 3822.3 3881.0 3955.3 3958.5 1181.1 1182.2 1197.6 1203.3 1211.7 856.0 957.9 983.5 1005.6 1022.7 6076.6 6132.9 6157.6 6188.4 6274.7 432.1 439.9 442.1 1058.3 1073.7 4235.5 4257.8 4266.7 4282.0 4336.8 10670.8 10980.5 10991.3 10995.6 11014.9 10887.2 10901.2 10966.1 10995.2 11018.9 7724.8 7959.0 7980.5 8121.5 8140.1 5965.4 6184.0 6191.3 6212.1 6340.5 9749.5 10006.5 10272.7 10288.2 10299.8 9884.6 10164.0 10209.4 10213.8 10494.9 6781.4 7361.0 7395.0 7546.9 7547.5 8568.9 8581.7 8647.7 8650.9 8682.3 7341.9 7423.5 7436.3 7575.7 7662.6 7295.0 7398.0 7405.1 7542.0 7552.5 6971.4 6983.3 7025.4 7091.6 7119.1 5166.2 5210.6 5306.4 5404.9 5414.7 5361.2 5382.4 5418.8 5430.5 5433.3 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#4] prototype.html Cycles:180 Average:4889.74 Median:5641.65 stddev:1451.81 (25.7%) stddev-sans-first:1415.04 06:04:05 INFO - PROCESS | 7817 | Values: 333.8 336.9 336.9 347.4 349.0 5508.9 5589.1 5616.6 5691.8 5705.5 5533.3 5562.2 5567.4 5590.0 5593.6 4137.8 4211.9 4292.1 4303.4 4318.8 4246.5 4292.2 4324.8 4334.8 4342.7 4271.1 4303.1 4310.4 4311.8 4311.9 4038.6 4227.9 4239.9 4242.2 4350.4 3654.0 3662.2 3697.8 3702.4 3706.4 5295.4 5311.5 5336.3 5339.3 5369.2 4702.4 4831.2 4911.3 4927.4 4939.0 5715.9 5805.2 5835.8 5844.7 5847.4 4138.5 4141.7 4144.6 4155.1 4157.5 5843.7 5930.5 5970.3 5985.3 6152.4 4140.4 4174.6 4176.3 4179.5 4212.5 4264.4 4277.0 4287.0 4314.4 4319.2 4635.8 4907.6 4927.1 4942.2 4943.6 5784.2 5795.7 5836.6 5871.3 5903.8 1463.2 1478.9 1482.3 1483.5 1492.3 939.3 951.5 978.2 979.8 995.2 5564.8 5574.4 5588.8 5619.5 5630.2 5911.3 5918.0 5932.3 5962.3 5986.5 5398.4 5653.2 5717.8 5723.2 5740.0 3206.1 3216.8 3232.4 3239.9 3243.3 6060.3 6078.2 6204.1 6232.5 6247.8 6108.5 6150.4 6155.9 6162.5 6180.4 6076.3 6105.8 6163.6 6187.7 6214.1 5907.2 5949.7 5978.7 6013.5 6042.5 5912.9 5973.9 5982.9 5992.0 5995.3 6055.8 6117.7 6120.9 6143.0 6274.6 4183.7 4227.5 4228.3 4234.0 4254.0 5763.3 5968.6 6004.7 6030.2 6050.5 5669.5 5739.2 5747.2 5787.8 5822.3 5724.2 5769.7 5777.0 5819.9 5836.7 5543.3 5691.5 5719.6 5725.5 5741.9 5847.2 5857.9 5866.3 5909.2 5924.0 5514.4 5699.9 5747.4 5786.6 5826.5 06:04:05 INFO - PROCESS | 7817 | 06:04:05 INFO - PROCESS | 7817 | [#5] yui.html Cycles:180 Average:20017.07 Median:4767.81 stddev:28465.35 (597.0%) stddev-sans-first:28508.60 06:04:05 INFO - PROCESS | 7817 | Values: 792.1 798.7 817.3 819.3 842.6 14906.2 15817.0 15821.9 15871.8 16191.1 13419.7 13745.1 13789.9 13808.0 13840.0 828.0 837.3 839.2 839.4 843.5 794.4 820.2 835.7 840.3 840.4 863.5 864.1 864.3 864.6 870.1 855.7 857.4 859.1 860.7 863.9 626.9 626.9 629.6 630.2 631.3 15106.4 15159.9 15169.2 15188.5 15221.1 14081.7 14355.0 14370.2 14500.3 14517.1 12248.1 12312.6 12423.8 12575.6 12744.2 3788.5 3866.7 3915.3 3927.8 4018.6 61248.7 64512.7 64944.0 73221.3 75448.6 11102.6 11192.7 11319.9 11322.5 11346.6 21145.4 21218.9 21249.2 21281.0 21360.5 8684.5 8741.8 8753.0 8756.9 8762.4 4711.1 4783.3 4783.7 4810.4 5154.3 3618.4 3734.8 3735.6 3738.5 3745.2 635.0 649.4 655.2 656.2 657.5 626.6 748.8 765.9 804.5 825.6 9706.0 9933.2 10087.5 10244.2 10263.7 650.7 705.5 705.9 717.2 750.6 4703.7 4752.3 4789.8 4792.6 4996.3 93302.0 110450.4 111630.0 113362.0 114590.0 96832.5 97934.0 99874.0 99973.0 100162.5 54819.2 75983.6 82225.6 85945.1 86330.6 9191.7 9775.5 9862.9 9866.0 9877.2 50602.5 51039.0 51092.2 53088.5 53610.0 68179.7 73685.6 74036.3 74077.6 74586.0 11333.2 11508.1 11593.6 11806.6 11933.9 13057.3 13214.5 13264.5 13830.3 14686.7 13161.6 13265.9 13281.1 13303.3 13710.5 12708.9 12903.0 13123.3 13175.8 13566.4 12892.6 13324.5 13445.5 13463.9 13736.4 10359.7 10488.5 10538.6 10569.4 11003.3 10233.9 10583.9 11161.9 11363.6 11382.6 06:04:05 INFO - PROCESS | 7817 | -------- Summary: end -------- 06:04:05 INFO - PROCESS | 7817 | 06:04:06 INFO - TEST-INFO | 7817: exit 0 06:04:06 INFO - TEST-OK | dromaeo_css | took 1111167ms 06:04:06 INFO - TEST-START | kraken 06:04:06 INFO - operating with platform_type : linux_ 06:04:06 INFO - Initialising browser for kraken test... 06:04:06 INFO - TEST-INFO | started process 8056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8uFdT/profile http://localhost:50439/getInfo.html) 06:04:11 INFO - PROCESS | 8056 | __metrics Screen width/height:1600/1200 06:04:11 INFO - PROCESS | 8056 | colorDepth:24 06:04:11 INFO - PROCESS | 8056 | Browser inner width/height: 1024/697 06:04:11 INFO - PROCESS | 8056 | __metrics 06:04:12 ERROR - PROCESS | 8056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:04:13 INFO - TEST-INFO | 8056: exit 0 06:04:13 INFO - Browser initialized. 06:04:13 INFO - Running cycle 1/1 for kraken test... 06:04:13 INFO - TEST-INFO | started process 8178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8uFdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:25 INFO - PROCESS | 8178 | RSS: Main: 167079936 06:04:25 INFO - PROCESS | 8178 | 06:04:27 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50439/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:28 INFO - PROCESS | 8178 | RSS: Main: 172445696 06:04:28 INFO - PROCESS | 8178 | 06:04:31 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50439/tests/kraken/driver.html?testName=audio-dft) 06:04:31 INFO - PROCESS | 8178 | RSS: Main: 172318720 06:04:31 INFO - PROCESS | 8178 | 06:04:34 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50439/tests/kraken/driver.html?testName=audio-fft) 06:04:35 INFO - PROCESS | 8178 | RSS: Main: 167018496 06:04:35 INFO - PROCESS | 8178 | 06:04:37 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50439/tests/kraken/driver.html?testName=audio-oscillator) 06:04:38 INFO - PROCESS | 8178 | RSS: Main: 167645184 06:04:38 INFO - PROCESS | 8178 | 06:04:40 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:40 INFO - PROCESS | 8178 | RSS: Main: 167985152 06:04:40 INFO - PROCESS | 8178 | 06:04:43 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50439/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:44 INFO - PROCESS | 8178 | RSS: Main: 168054784 06:04:44 INFO - PROCESS | 8178 | 06:04:47 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50439/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:48 INFO - PROCESS | 8178 | RSS: Main: 166227968 06:04:48 INFO - PROCESS | 8178 | 06:04:51 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50439/tests/kraken/driver.html?testName=json-parse-financial) 06:04:52 INFO - PROCESS | 8178 | RSS: Main: 167976960 06:04:52 INFO - PROCESS | 8178 | 06:04:53 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:54 INFO - PROCESS | 8178 | RSS: Main: 168079360 06:04:54 INFO - PROCESS | 8178 | 06:04:56 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:56 INFO - PROCESS | 8178 | RSS: Main: 168554496 06:04:56 INFO - PROCESS | 8178 | 06:04:58 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:59 INFO - PROCESS | 8178 | RSS: Main: 168910848 06:04:59 INFO - PROCESS | 8178 | 06:05:02 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:02 INFO - PROCESS | 8178 | RSS: Main: 168787968 06:05:02 INFO - PROCESS | 8178 | 06:05:05 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:06 INFO - PROCESS | 8178 | RSS: Main: 168427520 06:05:06 INFO - PROCESS | 8178 | 06:05:07 INFO - PROCESS | 8178 | Cycle 1(1): loaded http://localhost:50439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50439/tests/kraken/driver.html?testName=ai-astar) 06:05:08 INFO - PROCESS | 8178 | RSS: Main: 169459712 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | __start_tp_report 06:05:08 INFO - PROCESS | 8178 | _x_x_mozilla_page_load 06:05:08 INFO - PROCESS | 8178 | _x_x_mozilla_page_load_details 06:05:08 INFO - PROCESS | 8178 | |i|pagename|runs| 06:05:08 INFO - PROCESS | 8178 | |0;ai-astar;113;107;111;110;113;113;112;111;111;111 06:05:08 INFO - PROCESS | 8178 | |1;audio-beat-detection;161;127;155;185;125;151;154;131;185;132 06:05:08 INFO - PROCESS | 8178 | |2;audio-dft;162;164;161;163;165;176;163;163;162;162 06:05:08 INFO - PROCESS | 8178 | |3;audio-fft;76;75;75;173;77;75;79;80;161;76 06:05:08 INFO - PROCESS | 8178 | |4;audio-oscillator;84;85;147;84;84;85;138;85;85;151 06:05:08 INFO - PROCESS | 8178 | |5;imaging-gaussian-blur;118;118;118;117;116;119;118;117;118;118 06:05:08 INFO - PROCESS | 8178 | |6;imaging-darkroom;146;148;146;146;148;146;148;146;147;147 06:05:08 INFO - PROCESS | 8178 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;96;95 06:05:08 INFO - PROCESS | 8178 | |8;json-parse-financial;56;56;57;56;57;54;54;58;54;60 06:05:08 INFO - PROCESS | 8178 | |9;json-stringify-tinderbox;63;62;62;62;63;63;62;63;62;62 06:05:08 INFO - PROCESS | 8178 | |10;stanford-crypto-aes;82;79;80;80;83;87;82;82;106;80 06:05:08 INFO - PROCESS | 8178 | |11;stanford-crypto-ccm;133;131;125;122;122;124;126;143;151;126 06:05:08 INFO - PROCESS | 8178 | |12;stanford-crypto-pbkdf2;165;163;161;163;162;165;169;167;163;161 06:05:08 INFO - PROCESS | 8178 | |13;stanford-crypto-sha256-iterative;64;65;66;64;63;64;66;63;64;61 06:05:08 INFO - PROCESS | 8178 | __end_tp_report 06:05:08 INFO - PROCESS | 8178 | __start_cc_report 06:05:08 INFO - PROCESS | 8178 | _x_x_mozilla_cycle_collect,865 06:05:08 INFO - PROCESS | 8178 | __end_cc_report 06:05:08 INFO - PROCESS | 8178 | __startTimestamp1465391108048__endTimestamp 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | ------- Summary: start ------- 06:05:08 INFO - PROCESS | 8178 | Number of tests: 14 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:1.81 (1.6%) stddev-sans-first:1.80 06:05:08 INFO - PROCESS | 8178 | Values: 113.0 107.0 111.0 110.0 113.0 113.0 112.0 111.0 111.0 111.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:154.50 stddev:22.23 (14.4%) stddev-sans-first:23.26 06:05:08 INFO - PROCESS | 8178 | Values: 161.0 127.0 155.0 185.0 125.0 151.0 154.0 131.0 185.0 132.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.33 (2.7%) stddev-sans-first:4.53 06:05:08 INFO - PROCESS | 8178 | Values: 162.0 164.0 161.0 163.0 165.0 176.0 163.0 163.0 162.0 162.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:38.25 (50.3%) stddev-sans-first:39.96 06:05:08 INFO - PROCESS | 8178 | Values: 76.0 75.0 75.0 173.0 77.0 75.0 79.0 80.0 161.0 76.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.50 stddev:29.52 (34.9%) stddev-sans-first:30.52 06:05:08 INFO - PROCESS | 8178 | Values: 84.0 85.0 147.0 84.0 84.0 85.0 138.0 85.0 85.0 151.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 06:05:08 INFO - PROCESS | 8178 | Values: 118.0 118.0 118.0 117.0 116.0 119.0 118.0 117.0 118.0 118.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:05:08 INFO - PROCESS | 8178 | Values: 146.0 148.0 146.0 146.0 148.0 146.0 148.0 146.0 147.0 147.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:05:08 INFO - PROCESS | 8178 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.93 (3.4%) stddev-sans-first:2.05 06:05:08 INFO - PROCESS | 8178 | Values: 56.0 56.0 57.0 56.0 57.0 54.0 54.0 58.0 54.0 60.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:05:08 INFO - PROCESS | 8178 | Values: 63.0 62.0 62.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:82.00 stddev:8.02 (9.8%) stddev-sans-first:8.47 06:05:08 INFO - PROCESS | 8178 | Values: 82.0 79.0 80.0 80.0 83.0 87.0 82.0 82.0 106.0 80.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:128.50 stddev:9.66 (7.5%) stddev-sans-first:10.20 06:05:08 INFO - PROCESS | 8178 | Values: 133.0 131.0 125.0 122.0 122.0 124.0 126.0 143.0 151.0 126.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:2.60 (1.6%) stddev-sans-first:2.73 06:05:08 INFO - PROCESS | 8178 | Values: 165.0 163.0 161.0 163.0 162.0 165.0 169.0 167.0 163.0 161.0 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - PROCESS | 8178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 06:05:08 INFO - PROCESS | 8178 | Values: 64.0 65.0 66.0 64.0 63.0 64.0 66.0 63.0 64.0 61.0 06:05:08 INFO - PROCESS | 8178 | -------- Summary: end -------- 06:05:08 INFO - PROCESS | 8178 | 06:05:08 INFO - TEST-INFO | 8178: exit 0 06:05:09 INFO - TEST-OK | kraken | took 62462ms 06:05:09 INFO - SUITE-END | took 1173s 06:05:09 INFO - Completed test suite (00:19:33) 06:05:09 INFO - javascript benchmark 06:05:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7269.578524099396, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.395422892536, 3176.571162893009, 3183.8248896310693, 3194.8562314695864, 3227.7417806575477, 5305.681659100456, 5306.124489459235, 5361.705106219157, 5418.9458105418935, 5458.9454105458935, 5168.121419358708, 5332.440093790145, 5371.75827087781, 5393.973030134854, 5403.945960540394, 4809.4469136049365, 4834.7824347904425, 4847.5394837490385, 4974.303597496353, 4991.725455099986, 4824.686395384307, 5005.499450054984, 5041.621878359119, 5046.192609182532, 5055.545000949914, 4785.976070119662, 4859.805607775685, 4866.075445665312, 4935.5064493550535, 4951.975240123795, 4858.392700912386, 4878.609711223094, 4879.194932836078, 4906.681065730716, 4936.90126197474, 4894.706317620954, 4895.069936712013, 4902.48523904992, 4904.852854414374, 4928.383952005999, 5076.64463487556, 5231.581473482112, 5244.8688782780355, 5271.947280527184, 5297.841064768063, 5753.280839895013, 5781.421857814227, 5787.074068149118, 5794.68129252891, 5797.420257974211, 5581.05122129239, 5725.370209276976, 5752.050911599623, 5758.769649214027, 5769.740361683735, 5312.893742125175, 5314.4951229633125, 5338.332708411449, 5366.973165134188, 5377.542908852753, 5806.187133801272, 5814.970925145347, 5824.388439213906, 5825.766969321265, 5829.950608890441, 5434.972825135849, 5551.195076713854, 5633.830985070373, 5642.0, 5643.80246691372, 5629.831105066854, 5686.175504551899, 5686.545076393879, 5696.943030569724, 5737.569682273846, 5479.0, 5625.296837895263, 5659.745311460994, 5677.318721753333, 5727.513161381329, 5766.192733017381, 5790.942090579125, 5814.505767009767, 5815.476607105381, 5856.150858125633, 4379.9781001095425, 4414.779261036935, 4419.160359531678, 4427.69006169565, 4455.064436468313, 3876.8643097491454, 3893.766374017568, 3910.6089391061237, 3944.9408258876138, 4007.438958545806, 5464.207689885024, 5496.890062198733, 5529.640573362719, 5529.640573362719, 5586.720663966786, 5783.652980821164, 5790.044642633919, 5812.680302583314, 5818.5636077294375, 5847.649141051551, 5274.789008439696, 5456.154296084113, 5500.1749737538885, 5550.139728342114, 5567.972160139255, 4828.517148285214, 4844.2007068833955, 4876.366072410564, 4877.902441951142, 4882.5605695487575, 5965.403459654, 5980.700964951735, 6010.429009244115, 6018.337982821886, 6025.849353766191, 5559.861003474864, 5775.133729940542, 5778.56660750437, 5795.94204057954, 5861.736221870111, 5987.491063259497, 5989.850253743692, 5992.43071908168, 5998.670073145844, 6001.219841420762, 5463.863403414946, 5722.484976352148, 5724.198612194213, 5732.082866741302, 5733.799317024051, 5755.1942728017275, 5771.769129234952, 5792.247007888947, 5838.649681019152, 5869.53043756507, 5641.266635337544, 5697.7151142443545, 5703.201551782837, 5705.971470142623, 5713.457221563945, 5438.347398312228, 5542.889142217214, 5638.351589567253, 5657.8019769307875, 5662.745176466987, 5320.388155362183, 5386.326709161355, 5475.780968761364, 5503.697296648723, 5569.220309156803, 5632.690202038927, 5641.379448260606, 5643.238162847963, 5646.040173170489, 5668.801591944262, 5281.313429254173, 5494.780208791603, 5517.2551705519245, 5531.446855314597, 5551.417101204477], "value": 5297.901444308373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.7071464267866, 634.6858305138957, 637.1207733328007, 641.249737806766, 658.3844105761113, 42093.57906420935, 43369.13261734767, 43580.346294805604, 43609.78195109028, 47657.76171119148, 45710.0, 46360.304595431095, 46476.0, 46482.302765458546, 46580.06839863201, 8771.166739159786, 8913.598888050054, 8940.731778046636, 8982.236509896667, 8984.8652270216, 8840.8673869892, 8870.778230544223, 8902.599383027748, 8908.910910890905, 8914.153155450254, 8876.600552975131, 8883.378163528556, 8924.8661270081, 9010.729678109634, 9013.233875120623, 8720.0, 8732.607032683545, 8751.12488751123, 8756.956215218883, 8771.429857059271, 8698.608562614698, 8826.823463530758, 8842.823143537093, 8850.557472126433, 8857.468551886843, 42045.789771051255, 42228.36657450141, 42344.0, 42382.57617423848, 42498.0, 3478.339115568034, 3525.4888041233876, 3562.679358857715, 3594.3889538778208, 3851.229754049173, 30507.847460762776, 32246.0, 32282.677173228436, 32703.83648081768, 33970.49044264338, 4379.562043795627, 4393.890152746175, 4415.100694410057, 4455.1535208310315, 4489.73061616304, 353488.0, 353774.0, 354462.0, 354904.22547887353, 355548.0, 58722.18305810109, 58992.705036474545, 59069.40930590725, 59236.40763592395, 59274.40725592689, 35374.0, 62867.6856615714, 63240.367596324366, 63316.68341658262, 63597.364026359144, 16336.428225012305, 16647.084410357547, 16701.49895503137, 16708.49874503767, 16863.662726745642, 12411.255324680547, 12472.0, 12545.93727031359, 12592.370381480889, 12593.181443206162, 19714.60570788605, 19898.801011989985, 19921.0, 19997.300094496622, 20081.196752130043, 7121.928780712126, 7158.2125966143685, 7297.087864016998, 7342.743003994835, 7352.301531354513, 956.5026186383042, 989.1592146675268, 1009.1926458833051, 1065.8667666541683, 1093.1801149138146, 32922.67077329244, 33320.50019249713, 33429.0, 33449.49825752616, 33881.32237355239, 1132.1904838040675, 1184.8743693491217, 1195.5158160944832, 1215.428748488209, 1246.0654509118162, 16806.831931680772, 17378.826211737975, 17401.91299043497, 17460.301587936596, 17478.825211747975, 510505.0, 516019.0, 520753.0, 521623.0, 521743.0, 58003.0, 59592.40407595955, 59709.0, 59727.0, 59863.0, 1353.8916886649044, 1408.978865317021, 1410.3864818803854, 1419.6734751007325, 1420.609332433589, 31075.533866992464, 32470.837645811618, 32592.0, 32620.83689581537, 32768.67231327656, 51143.48856511536, 51746.223806643684, 52197.0, 52266.0, 52342.47657523376, 437840.0, 439024.0, 439926.0, 443561.0, 444044.0, 27828.582571261042, 27915.44169116647, 28077.0, 28220.0, 28228.294292642848, 43252.351214732436, 43273.3508997359, 43304.133917322106, 46345.536544634124, 49544.75227623839, 40507.59492405038, 40706.59293407028, 41608.791956040026, 41939.7903010483, 42192.36711449392, 40097.39853902136, 41545.0, 41659.1668166641, 41901.580984189764, 42260.36609450922, 40508.79745601253, 41043.0, 41561.58438415698, 41604.0, 41667.0, 35380.0, 36714.8164259177, 37030.8148459256, 37168.25663486661, 37223.0, 28161.43677126487, 28174.85912570506, 28178.85910570434, 28290.151295461168, 28390.0], "value": 20301.714141503642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.83432041382423, 397.47334781414634, 401.7609522334211, 402.1133400851124, 416.2736025635267, 13757.0, 17783.73324400135, 18516.629667406643, 19274.32539861105, 19339.129739161737, 18328.35850745224, 18475.0, 18594.53513662159, 19726.309579164732, 19955.301564445246, 5450.482204190605, 5490.560755139599, 5674.773009079632, 5724.169995350671, 5751.079827227644, 5625.774969001235, 5632.943670563303, 5640.661560306375, 5642.605017648766, 5654.915176272339, 5412.864678383033, 5570.303712035996, 5598.636088654245, 5671.574631902603, 5678.034734095214, 5638.830835074913, 5656.151577263402, 5657.999999999979, 5670.319561652607, 5670.6390466288, 4822.156122678517, 5060.822871199491, 5116.616253780944, 5140.126178549655, 5168.173092305213, 18071.548211294823, 18435.0, 22020.779792202033, 22120.0, 22240.666390004164, 2155.0, 2172.3374370816896, 2172.717546718932, 2232.3972527417504, 2326.8720220387872, 9425.151736343762, 9709.126178643884, 9812.313138080337, 9889.703308900744, 9928.205743540499, 1865.337805079191, 1874.7187921811837, 1927.267638297438, 1934.3616606519956, 1963.6072785442968, 54248.72875635636, 77783.6110819448, 80124.19875801283, 81766.9999999994, 82361.0, 9574.234061275081, 10873.891261087447, 11150.553977840795, 11600.071994240441, 11647.0, 15040.398384064734, 15060.171690557125, 15082.095074295577, 15124.319405626773, 15126.546203613689, 8018.919810801934, 8019.1579884111325, 8091.1504292048485, 8130.837383252302, 8354.373421993374, 7699.884501732478, 7772.300492955661, 7835.216478352233, 8030.277275045274, 8103.270705636521, 4311.741295522279, 4458.882031035232, 4501.257292546758, 4738.691985020962, 4746.335513028179, 1936.1577713694587, 1961.4507937777446, 1970.7930667280016, 1971.3001884331143, 1980.5642758593374, 866.332923648787, 1006.5369929832212, 1061.830107182847, 1129.5820546397886, 1137.5449820071872, 16950.915245423694, 18886.43340699781, 19180.904095479433, 19804.0, 20771.169153233703, 1026.97432564185, 1050.7898420315814, 1053.6786280184617, 1056.334509259162, 1068.5458680060942, 9402.0, 11017.614383496699, 11166.944165279285, 11226.7193320166, 11231.494582743797, 481853.0, 495110.0, 497658.0, 504316.0, 538880.0, 78414.0, 89193.0, 97069.0, 98796.50601746945, 100853.0, 1033.4987531047436, 1089.1776708584969, 1094.6059418609295, 1105.9723506912392, 1115.0800589513522, 17486.213120409357, 17499.0, 17812.0, 17983.820161798216, 18024.188911499277, 35054.0, 39504.407433887936, 41697.583024170584, 43448.0, 43466.0, 57369.42630573641, 60207.69896150491, 60361.39638603558, 60893.0, 60905.390946089974, 8541.914580854113, 8639.524826134622, 8749.387542871938, 8751.64993400257, 9038.593263303299, 9929.404235745878, 13016.93491532574, 13138.605841824761, 13365.599032029055, 13666.658333541343, 11631.185816992729, 11677.76644467123, 11816.645500634995, 11925.642230733092, 11957.880421195676, 11403.657890263305, 11615.361155136548, 11667.708307292385, 11708.590199342982, 11908.702282443008, 11323.32060076398, 11754.941225293818, 11756.059515238589, 11858.11064170208, 11903.583374581847, 8515.957420212859, 8574.742757717278, 8653.69712060075, 8699.347548933729, 8805.295576354005, 11027.503762330554, 11803.291802491878, 11873.406329683308, 12278.079144064051, 12478.5008599655], "value": 9132.197789411684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.9838422976295, 1489.5084622074717, 1620.5948512871782, 1792.2203841329015, 1800.3968670495383, 7188.0, 8127.593620318975, 8333.749987500378, 8903.643854245822, 8918.955405222972, 8170.6323215455295, 8451.239388455038, 8495.702650407236, 8535.48787072776, 8541.231289183972, 2153.9030743616577, 2183.3559100065518, 2200.5378870437225, 2201.8458707890454, 2208.867467951928, 2136.166894910986, 2145.3242228697986, 2149.355193441969, 2193.4406726284774, 2256.2103263857684, 2147.6456384696507, 2157.7916366834625, 2257.604919139144, 2263.852849564781, 2268.3081660093667, 2137.914483420669, 2162.7296587926508, 2164.3723320237114, 2164.5779073080757, 2166.4150679316576, 2053.938381848547, 2056.7017782421467, 2064.133064113076, 2065.824404925583, 2067.648499755045, 8424.452410593352, 8457.95771021147, 8475.49147051179, 8482.957585212096, 8495.320374370036, 4986.052649996525, 4995.825146119869, 5017.0, 5049.5455409013, 5116.232565115262, 3145.90797119915, 3171.476706343474, 3366.8653253869816, 3379.5775528058994, 3390.6100798408006, 1121.3272036777948, 1130.491278924479, 1152.6168597682731, 1182.9585964491287, 1198.7842188406084, 11998.760024799456, 12035.217710848767, 12055.156139070268, 12065.638030859089, 12115.636530904087, 4337.132573485315, 4353.738775673406, 4384.714993525411, 4418.690691651618, 4471.709338892962, 10262.384256944608, 10279.94860025695, 10302.793944121076, 10306.0, 10321.071103600712, 4968.701877887338, 4970.975145124251, 5028.0, 5091.745412729423, 5094.923576146287, 3973.264945984944, 4519.909601807945, 4635.582797548237, 4725.621950243973, 4798.5441383068555, 3819.5989421110385, 3822.3119838429348, 3880.9805950970062, 3955.3473676843573, 3958.5051868516434, 1181.1141643767176, 1182.1724792645011, 1197.6107764976243, 1203.284045992633, 1211.7031327324862, 855.9786005349791, 957.8563215517728, 983.5180761426849, 1005.6228914157191, 1022.6625213679467, 6076.574639775262, 6132.872255081203, 6157.599756015845, 6188.350223226586, 6274.717637706314, 432.06458018390464, 439.8900274931267, 442.1312121680912, 1058.2909450668071, 1073.6778966310076, 4235.470566179228, 4257.787110644455, 4266.722663026893, 4282.036541778075, 4336.76147811867, 10670.839937400946, 10980.450977451095, 10991.340519568852, 10995.560177592806, 11014.889851101387, 10887.237893347548, 10901.182411319025, 10966.06788422993, 10995.230333876712, 11018.944905275423, 7724.7682569523, 7958.960205198937, 7980.521168729895, 8121.4721043132, 8140.104588495261, 5965.373635768182, 6183.96908015457, 6191.318954915046, 6212.099245609271, 6340.461060809883, 9749.463779492196, 10006.549705263134, 10272.691819245434, 10288.228382871164, 10299.845502317321, 9884.604615815288, 10164.0344167304, 10209.38743675382, 10213.846792297973, 10494.947525262325, 6781.38967492928, 7361.0, 7394.963025184839, 7546.886796697944, 7547.471676982558, 8568.914310856811, 8581.742547723577, 8647.654093836176, 8650.91349086501, 8682.305415566865, 7341.889871651822, 7423.517471364344, 7436.307323408759, 7575.6969721210535, 7662.616869156408, 7295.0, 7397.963010184914, 7405.111386633638, 7542.0, 7552.546847189186, 6971.407430368476, 6983.336583024605, 7025.437964962893, 7091.60996145217, 7119.110111236096, 5166.199239117943, 5210.5831533477985, 5306.363236411656, 5404.891902161856, 5414.729263536886, 5361.195820626781, 5382.3541175059245, 5418.756155973069, 5430.484104010113, 5433.266509021231], "value": 4519.7001378167915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.78971248113686, 336.9174552234703, 336.94440417331134, 347.40940401317766, 349.0244765879367, 5508.917366239504, 5589.077802162648, 5616.5787565932515, 5691.8007869724515, 5705.459525927997, 5533.335999680034, 5562.221289019541, 5567.415421380758, 5590.049691552445, 5593.62956075761, 4137.81379837908, 4211.8525851595205, 4292.14157168566, 4303.419038429804, 4318.784060796963, 4246.490421149451, 4292.227399068166, 4324.762138082404, 4334.804933777988, 4342.71889792512, 4271.124419494012, 4303.117860838536, 4310.418093557377, 4311.762853043081, 4311.935320970188, 4038.5557588665224, 4227.915441691149, 4239.872803815891, 4242.215190189794, 4350.36919646651, 3653.995151333378, 3662.1577037281572, 3697.759645623026, 3702.38910579754, 3706.4440333949856, 5295.437845835488, 5311.521963023308, 5336.332958380202, 5339.305890234284, 5369.167778994223, 4702.388689470381, 4831.154547954129, 4911.312416261726, 4927.433345165316, 4939.0, 5715.942550628147, 5805.245318108661, 5835.824925252249, 5844.678542680151, 5847.44449277318, 4138.52406973199, 4141.668666506703, 4144.585541445861, 4155.148194620096, 4157.5010998680045, 5843.678597677126, 5930.466258036798, 5970.313413957407, 5985.281766188085, 6152.446279834791, 4140.358244472111, 4174.603412675791, 4176.31090870003, 4179.477565304337, 4212.53662097169, 4264.424302719155, 4276.957230427656, 4287.0, 4314.417553630283, 4319.222539942778, 4635.837745678885, 4907.601333619972, 4927.1131196384995, 4942.184539550934, 4943.5508042761085, 5784.1902133701315, 5795.666996590808, 5836.562257830679, 5871.324797648325, 5903.7565725024215, 1463.1659953826218, 1478.9482368117278, 1482.3181336585076, 1483.509073381245, 1492.2613306413177, 939.3049143633798, 951.45766912859, 978.2467500024941, 979.774651830083, 995.2038369304528, 5564.8330550083565, 5574.358948720868, 5588.832335029955, 5619.494245517923, 5630.155476678531, 5911.3201981772645, 5918.0, 5932.317783454958, 5962.314333851576, 5986.461218490357, 5398.352197736297, 5653.152027195953, 5717.799877004368, 5723.198752174699, 5740.0, 3206.0862654143457, 3216.7587430942303, 3232.3535292941506, 3239.935201296008, 3243.2702641905385, 6060.272767267956, 6078.209832721718, 6204.13142160089, 6232.532560058014, 6247.812565623039, 6108.51131909455, 6150.3849615039035, 6155.938440615537, 6162.5378096642935, 6180.381961803873, 6076.3012253591405, 6105.755769769248, 6163.630182189083, 6187.659678717714, 6214.067889816563, 5907.232059832194, 5949.672767997802, 5978.701064946822, 6013.548983826318, 6042.546808989256, 5912.881742365214, 5973.850653733692, 5982.850428739316, 5991.970040149771, 5995.310539288038, 6055.818325450244, 6117.694115294128, 6120.938790612036, 6143.017117261216, 6274.623522588659, 4183.707140500257, 4227.513835908787, 4228.302330115496, 4234.0, 4253.95746042548, 5763.33721622002, 5968.582199246011, 6004.699765011819, 6030.246219222598, 6050.515958723204, 5669.461401167047, 5739.167820666064, 5747.166660834239, 5787.826365209051, 5822.272215973004, 5724.227229324155, 5769.653820770767, 5777.0, 5819.854503637443, 5836.678982655994, 5543.307086614173, 5691.4877661010705, 5719.597768937139, 5725.482747072113, 5741.942580574141, 5847.181394604674, 5857.9121313179485, 5866.2960444746905, 5909.172715819875, 5923.970380148072, 5514.448555144453, 5699.8860022800145, 5747.36778954323, 5786.623869448473, 5826.533877289722], "value": 4424.1022047627475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.1247022040645, 798.6725442568546, 817.333872893592, 819.2790344496842, 842.5660784695883, 14906.180160091191, 15817.0, 15821.920890395546, 15871.76192357114, 16191.109488978102, 13419.731605367886, 13745.106568073094, 13789.862101378983, 13808.0, 13840.0, 827.9917200827974, 837.2924878477708, 839.2069494327862, 839.3620848155415, 843.527624530265, 794.3922898982283, 820.2248874813304, 835.6907944060706, 840.3445312656107, 840.3907167303687, 863.4905405810571, 864.1099667342647, 864.2524216552669, 864.6454953469079, 870.0733718589713, 855.7389996051202, 857.4426622695236, 859.0807835615893, 860.7245681381929, 863.8920134983127, 626.8965620672584, 626.9498440124779, 629.5939119268093, 630.1902055858246, 631.3307893632764, 15106.39574417022, 15159.924200378928, 15169.24153792306, 15188.46840360582, 15221.086734795948, 14081.718365632732, 14355.0, 14370.20963846988, 14500.347484363228, 14517.128972261698, 12248.142630015902, 12312.630621081382, 12423.75152496954, 12575.622731318075, 12744.171628844188, 3788.5264341957254, 3866.735028099521, 3915.256101340736, 3927.8428862845453, 4018.578049304839, 61248.69375653138, 64512.67743661298, 64944.02583961197, 73221.26778732198, 75448.62275688641, 11102.61140860066, 11192.720181995515, 11319.886801131883, 11322.547098115983, 11346.602868899714, 21145.365639030853, 21218.893905530374, 21249.150033998776, 21281.042353094148, 21360.465988350417, 8684.522351270742, 8741.781455463664, 8753.037165911745, 8756.912430875736, 8762.38663293576, 4711.128441238382, 4783.282507623884, 4783.6651434399955, 4810.42274927011, 5154.278401023859, 3618.4029635110437, 3734.7945862977253, 3735.589085200626, 3738.4579236010627, 3745.194783121642, 634.955553111287, 649.3928177154281, 655.1941112431736, 656.1896058367912, 657.454312920275, 626.5989766549412, 748.805310619243, 765.8626938995587, 804.4529719790481, 825.5707032343148, 9706.0, 9933.205343572497, 10087.49562521871, 10244.180465562737, 10263.692089237335, 650.7136859781681, 705.5378726933867, 705.9294070592899, 717.2253965717013, 750.557171268954, 4703.717776933395, 4752.334673145762, 4789.808407663654, 4792.616590672737, 4996.325496057985, 93302.0, 110450.44774776236, 111630.0, 113362.0, 114590.0, 96832.51583742036, 97934.0, 99874.00125998793, 99973.0, 100162.49918750359, 54819.17771233435, 75983.62008190034, 82225.58887205526, 85945.14054859497, 86330.5683471566, 9191.678291259774, 9775.462349570842, 9862.852057219005, 9865.950670246602, 9877.209823213982, 50602.49397505978, 51039.0, 51092.23361649652, 53088.469115308355, 53610.0, 68179.65910170418, 73685.6315718418, 74036.25963740294, 74077.62961185159, 74586.0, 11333.206675532634, 11508.136889733136, 11593.59422420245, 11806.645800625995, 11933.880661193278, 13057.28184949837, 13214.537491187762, 13264.53574124901, 13830.308484575933, 14686.706265874836, 13161.60515184546, 13265.867341326462, 13281.136726112773, 13303.334833258492, 13710.52013179534, 12708.87291127077, 12903.0, 13123.278219698008, 13175.802362964754, 13566.38951247216, 12892.613221603367, 13324.467021319426, 13445.529406470727, 13463.865361346261, 13736.381862815997, 10359.741006474596, 10488.475576221312, 10538.578456861946, 10569.365838049434, 11003.284786488852, 10233.897661023295, 10583.94708026455, 11161.860976463075, 11363.602273920704, 11382.601608943647], "value": 7513.879208415392, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 110.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 155.0, 185.0, 125.0, 151.0, 154.0, 131.0, 185.0, 132.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 163.0, 165.0, 176.0, 163.0, 163.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 173.0, 77.0, 75.0, 79.0, 80.0, 161.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 147.0, 84.0, 84.0, 85.0, 138.0, 85.0, 85.0, 151.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 116.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 148.0, 146.0, 148.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 57.0, 54.0, 54.0, 58.0, 54.0, 60.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 80.0, 83.0, 87.0, 82.0, 82.0, 106.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 125.0, 122.0, 122.0, 124.0, 126.0, 143.0, 151.0, 126.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 163.0, 162.0, 165.0, 169.0, 167.0, 163.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 63.0, 64.0, 66.0, 63.0, 64.0, 61.0], "value": 64.0, "unit": "score"}]}]} 06:05:09 INFO - Return code: 0 06:05:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:05:09 ERROR - # TBPL SUCCESS # 06:05:09 INFO - Running post-action listener: _resource_record_post_action 06:05:09 INFO - ##### 06:05:09 INFO - ##### Finished run-tests step (success) 06:05:09 INFO - ##### 06:05:09 INFO - Running post-run listener: _resource_record_post_run 06:05:09 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536322048; Read time: 4; Write time: 654648 06:05:09 INFO - TinderboxPrint: CPU usage
13.5% 06:05:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:05:09 INFO - TinderboxPrint: I/O write bytes / time
536,322,048 / 654,648 06:05:09 INFO - TinderboxPrint: CPU idle
8,229.8 (86.5%) 06:05:09 INFO - TinderboxPrint: CPU user
1,223.7 (12.9%) 06:05:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:05:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 163110912; Read time: 0; Write time: 240788 06:05:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286531584; Read time: 4; Write time: 323992 06:05:10 INFO - Running post-run listener: _upload_blobber_files 06:05:10 INFO - Blob upload gear active. 06:05:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:05:10 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 06:05:10 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:05:10 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:05:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:05:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:14 INFO - (blobuploader) - INFO - Done attempting. 06:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:15 INFO - (blobuploader) - INFO - Done attempting. 06:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:05:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:16 INFO - (blobuploader) - INFO - Done attempting. 06:05:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:16 INFO - Return code: 0 06:05:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:05:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4d869bc01f70e0bd9153ec41b6674796b702756af38ff27048ac7ce4c77fb87fe0383b5a3b1628894b945b926f75d1c86ff7ae2b3c8138c3fc4b89c2cb765b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676b36aa4146f4f88543b348f56ce8f25692c7e17cbbcbf8c2d3095b47aa8eca68ddc5572e622e4b5feefc2d6363779db512e5f022df7113adc5c4a85b924cda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2ff8735fd9698d1a4c666fa10e06c7e27fa4d3613228424e3dd45d12b5a06071dc3fbcb10b61853dd0895dc52ce53df4a8b6df7796b0c842f1f6b5ecfbad5c"} 06:05:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:05:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:05:16 INFO - Contents: 06:05:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4d869bc01f70e0bd9153ec41b6674796b702756af38ff27048ac7ce4c77fb87fe0383b5a3b1628894b945b926f75d1c86ff7ae2b3c8138c3fc4b89c2cb765b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676b36aa4146f4f88543b348f56ce8f25692c7e17cbbcbf8c2d3095b47aa8eca68ddc5572e622e4b5feefc2d6363779db512e5f022df7113adc5c4a85b924cda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2ff8735fd9698d1a4c666fa10e06c7e27fa4d3613228424e3dd45d12b5a06071dc3fbcb10b61853dd0895dc52ce53df4a8b6df7796b0c842f1f6b5ecfbad5c"} 06:05:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:05:16 INFO - Copying logs to upload dir... 06:05:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:05:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.562655 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-08 06:05:16.323751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:05:16.327697) ========= 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-1465388797.827742-538176825 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/Firefox/sha512/e4d869bc01f70e0bd9153ec41b6674796b702756af38ff27048ac7ce4c77fb87fe0383b5a3b1628894b945b926f75d1c86ff7ae2b3c8138c3fc4b89c2cb765b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676b36aa4146f4f88543b348f56ce8f25692c7e17cbbcbf8c2d3095b47aa8eca68ddc5572e622e4b5feefc2d6363779db512e5f022df7113adc5c4a85b924cda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2ff8735fd9698d1a4c666fa10e06c7e27fa4d3613228424e3dd45d12b5a06071dc3fbcb10b61853dd0895dc52ce53df4a8b6df7796b0c842f1f6b5ecfbad5c"} build_url:https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4d869bc01f70e0bd9153ec41b6674796b702756af38ff27048ac7ce4c77fb87fe0383b5a3b1628894b945b926f75d1c86ff7ae2b3c8138c3fc4b89c2cb765b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676b36aa4146f4f88543b348f56ce8f25692c7e17cbbcbf8c2d3095b47aa8eca68ddc5572e622e4b5feefc2d6363779db512e5f022df7113adc5c4a85b924cda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2ff8735fd9698d1a4c666fa10e06c7e27fa4d3613228424e3dd45d12b5a06071dc3fbcb10b61853dd0895dc52ce53df4a8b6df7796b0c842f1f6b5ecfbad5c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:05:16.352156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:05:16.352462) ========= 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-1465388797.827742-538176825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:05:16.433933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:05:16.434303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:05:16.434577) ========= ========= Total master_lag: 0.20 =========