builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1467070241.46 results: success (0) buildid: 20160627133055 builduid: 73b85cde579c488f8a1cac2d93dc8e42 revision: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.458521) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.458970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.459270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.473675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.473956) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 16:30:41-- 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% 89.4M=0s 2016-06-27 16:30:42 (89.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.577434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.577767) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019435 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:41.629923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 16:30:41.630729) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 --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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 16:30:42,136 truncating revision to first 12 chars 2016-06-27 16:30:42,136 Setting DEBUG logging. 2016-06-27 16:30:42,136 attempt 1/10 2016-06-27 16:30:42,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/87bbd3f58b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 16:30:43,480 unpacking tar archive at: mozilla-inbound-87bbd3f58b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.689370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 16:30:43.334988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:43.336706) ========= script_repo_revision: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:43.337128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:43.337428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:30:43.350485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 16:30:43.350773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:43 INFO - MultiFileLogger online at 20160627 16:30:43 in /builds/slave/test 16:30:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:30:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:43 INFO - {'append_to_log': False, 16:30:43 INFO - 'base_work_dir': '/builds/slave/test', 16:30:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:30:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:43 INFO - 'branch': 'Mozilla-Inbound', 16:30:43 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:43 INFO - 'config_files': ('talos/linux_config.py',), 16:30:43 INFO - 'default_actions': ('clobber', 16:30:43 INFO - 'read-buildbot-config', 16:30:43 INFO - 'download-and-extract', 16:30:43 INFO - 'populate-webroot', 16:30:43 INFO - 'create-virtualenv', 16:30:43 INFO - 'install', 16:30:43 INFO - 'run-tests'), 16:30:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:43 INFO - 'download_minidump_stackwalk': True, 16:30:43 INFO - 'download_symbols': 'ondemand', 16:30:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:43 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:43 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:43 INFO - 'installer_path': 'installer.exe', 16:30:43 INFO - 'log_level': 'info', 16:30:43 INFO - 'log_name': 'talos', 16:30:43 INFO - 'log_to_console': True, 16:30:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:43 INFO - 'opt_config_files': (), 16:30:43 INFO - 'pip_index': False, 16:30:43 INFO - 'sps_profile': False, 16:30:43 INFO - 'sps_profile_interval': 0, 16:30:43 INFO - 'suite': 'dromaeojs', 16:30:43 INFO - 'system_bits': '32', 16:30:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:43 INFO - 'title': 'talos-linux64-ix-061', 16:30:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:43 INFO - 'use_talos_json': True, 16:30:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:43 INFO - 'work_dir': 'build'} 16:30:43 INFO - ##### 16:30:43 INFO - ##### Running clobber step. 16:30:43 INFO - ##### 16:30:43 INFO - Running pre-action listener: _resource_record_pre_action 16:30:43 INFO - Running main action method: clobber 16:30:43 INFO - rmtree: /builds/slave/test/build 16:30:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:44 INFO - Running post-action listener: _resource_record_post_action 16:30:44 INFO - ##### 16:30:44 INFO - ##### Finished clobber step (success) 16:30:44 INFO - ##### 16:30:44 INFO - ##### 16:30:44 INFO - ##### Running read-buildbot-config step. 16:30:44 INFO - ##### 16:30:44 INFO - Running pre-action listener: _resource_record_pre_action 16:30:44 INFO - Running main action method: read_buildbot_config 16:30:44 INFO - Using buildbot properties: 16:30:44 INFO - { 16:30:44 INFO - "project": "", 16:30:44 INFO - "product": "firefox", 16:30:44 INFO - "script_repo_revision": "production", 16:30:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:30:44 INFO - "repository": "", 16:30:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:30:44 INFO - "buildid": "20160627133055", 16:30:44 INFO - "pgo_build": "True", 16:30:44 INFO - "basedir": "/builds/slave/test", 16:30:44 INFO - "buildnumber": 1246, 16:30:44 INFO - "slavename": "talos-linux64-ix-061", 16:30:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:30:44 INFO - "platform": "ubuntu64_hw", 16:30:44 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:30:44 INFO - "branch": "mozilla-inbound", 16:30:44 INFO - "repo_path": "integration/mozilla-inbound", 16:30:44 INFO - "revision": "87bbd3f58b4b153facdd1a2995105ae28cfbcd21", 16:30:44 INFO - "stage_platform": "linux64-pgo", 16:30:44 INFO - "builduid": "73b85cde579c488f8a1cac2d93dc8e42", 16:30:44 INFO - "slavebuilddir": "test" 16:30:44 INFO - } 16:30:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:30:44 INFO - Running post-action listener: _resource_record_post_action 16:30:44 INFO - ##### 16:30:44 INFO - ##### Finished read-buildbot-config step (success) 16:30:44 INFO - ##### 16:30:44 INFO - ##### 16:30:44 INFO - ##### Running download-and-extract step. 16:30:44 INFO - ##### 16:30:44 INFO - Running pre-action listener: _resource_record_pre_action 16:30:44 INFO - Running main action method: download_and_extract 16:30:44 INFO - mkdir: /builds/slave/test/build/tests 16:30:44 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')]} 16:30:44 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:45 INFO - Downloaded 1361 bytes. 16:30:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:45 INFO - Using the following test package requirements: 16:30:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:30:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:30:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'jsshell-linux-x86_64.zip'], 16:30:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:30:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:30:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:30:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:30:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:30:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:30: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')]} 16:30:45 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:46 INFO - Downloaded 24280496 bytes. 16:30:46 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'] 16:30:46 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 16:30:47 INFO - Return code: 0 16:30:47 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 16:30: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')]} 16:30:47 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:48 INFO - Downloaded 24280496 bytes. 16:30:48 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'] 16:30:48 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 16:30:50 INFO - Return code: 0 16:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:50 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:51 INFO - Downloaded 14405240 bytes. 16:30:51 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'] 16:30:51 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 16:30:51 INFO - Return code: 0 16:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:51 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/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 16:30:52 INFO - Downloaded 60322323 bytes. 16:30:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:52 INFO - mkdir: /builds/slave/test/properties 16:30:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:52 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:52 INFO - Contents: 16:30:52 INFO - build_url:https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:53 INFO - Running post-action listener: _resource_record_post_action 16:30:53 INFO - Running post-action listener: set_extra_try_arguments 16:30:53 INFO - ##### 16:30:53 INFO - ##### Finished download-and-extract step (success) 16:30:53 INFO - ##### 16:30:53 INFO - ##### 16:30:53 INFO - ##### Running populate-webroot step. 16:30:53 INFO - ##### 16:30:53 INFO - Running pre-action listener: _resource_record_pre_action 16:30:53 INFO - Running main action method: populate_webroot 16:30:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:30:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:30:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:30:53 INFO - '--tppagecycles', 16:30:53 INFO - '7'], 16:30:53 INFO - 'tests': ['tsvgm']}}, 16:30:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:30:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:30:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:30:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['damp', 'tps']}, 16:30:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'tests': ['damp', 'tps']}, 16:30:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['dromaeo_dom']}, 16:30:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['basic_compositor_video']}, 16:30:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:30:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'other-e10s': {'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['a11yr', 16:30:53 INFO - 'ts_paint', 16:30:53 INFO - 'tpaint', 16:30:53 INFO - 'sessionrestore', 16:30:53 INFO - 'sessionrestore_no_auto_restore', 16:30:53 INFO - 'tabpaint']}, 16:30:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['tsvgx', 16:30:53 INFO - 'tsvgr_opacity', 16:30:53 INFO - 'tart', 16:30:53 INFO - 'tscrollx', 16:30:53 INFO - 'cart']}, 16:30:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:30:53 INFO - 'tsvgr_opacity', 16:30:53 INFO - 'tart', 16:30:53 INFO - 'tscrollx', 16:30:53 INFO - 'cart']}, 16:30:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'talos_options': ['--disable-e10s'], 16:30:53 INFO - 'tests': ['tp5o']}, 16:30:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'tests': ['tp5o']}, 16:30:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'talos_options': ['--disable-e10s', 16:30:53 INFO - '--xperf_path', 16:30:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:53 INFO - 'tests': ['tp5n']}, 16:30:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:53 INFO - 'talos_options': ['--xperf_path', 16:30:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:53 INFO - 'tests': ['tp5n']}}, 16:30:53 INFO - 'talos.zip': {'path': '', 16:30:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:30:53 INFO - Running post-action listener: _resource_record_post_action 16:30:53 INFO - ##### 16:30:53 INFO - ##### Finished populate-webroot step (success) 16:30:53 INFO - ##### 16:30:53 INFO - ##### 16:30:53 INFO - ##### Running create-virtualenv step. 16:30:53 INFO - ##### 16:30:53 INFO - Running pre-action listener: _resource_record_pre_action 16:30:53 INFO - Running main action method: create_virtualenv 16:30:53 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:53 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 16:30:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:53 INFO - Using real prefix '/usr' 16:30:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:56 INFO - Installing pip.................done. 16:30:56 INFO - Return code: 0 16:30:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:30:56 INFO - Using env: {'DISPLAY': ':0', 16:30:56 INFO - 'HOME': '/home/cltbld', 16:30:56 INFO - 'LANG': 'en_US.UTF-8', 16:30:56 INFO - 'LANGUAGE': 'en_US:en', 16:30:56 INFO - 'LOGNAME': 'cltbld', 16:30:56 INFO - 'MAIL': '/var/mail/cltbld', 16:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:56 INFO - 'MOZ_NO_REMOTE': '1', 16:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:56 INFO - 'NO_EM_RESTART': '1', 16:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:56 INFO - 'PWD': '/builds/slave/test', 16:30:56 INFO - 'SHELL': '/bin/bash', 16:30:56 INFO - 'SHLVL': '1', 16:30:56 INFO - 'TERM': 'linux', 16:30:56 INFO - 'TMOUT': '86400', 16:30:56 INFO - 'USER': 'cltbld', 16:30:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:56 INFO - '_': '/tools/buildbot/bin/python'} 16:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:30:56 INFO - Cleaning up... 16:30:56 INFO - Return code: 0 16:30:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:30:56 INFO - Using env: {'DISPLAY': ':0', 16:30:56 INFO - 'HOME': '/home/cltbld', 16:30:56 INFO - 'LANG': 'en_US.UTF-8', 16:30:56 INFO - 'LANGUAGE': 'en_US:en', 16:30:56 INFO - 'LOGNAME': 'cltbld', 16:30:56 INFO - 'MAIL': '/var/mail/cltbld', 16:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:56 INFO - 'MOZ_NO_REMOTE': '1', 16:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:56 INFO - 'NO_EM_RESTART': '1', 16:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:56 INFO - 'PWD': '/builds/slave/test', 16:30:56 INFO - 'SHELL': '/bin/bash', 16:30:56 INFO - 'SHLVL': '1', 16:30:56 INFO - 'TERM': 'linux', 16:30:56 INFO - 'TMOUT': '86400', 16:30:56 INFO - 'USER': 'cltbld', 16:30:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:56 INFO - '_': '/tools/buildbot/bin/python'} 16:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:56 INFO - Downloading/unpacking psutil>=3.1.1 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:58 INFO - Installing collected packages: psutil 16:30:58 INFO - Running setup.py install for psutil 16:30:58 INFO - building 'psutil._psutil_linux' extension 16:30:58 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 16:30:58 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 16:30:58 INFO - building 'psutil._psutil_posix' extension 16:30:58 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 16:30:58 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 16:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:58 INFO - Successfully installed psutil 16:30:58 INFO - Cleaning up... 16:30:59 INFO - Return code: 0 16:30:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:30:59 INFO - Using env: {'DISPLAY': ':0', 16:30:59 INFO - 'HOME': '/home/cltbld', 16:30:59 INFO - 'LANG': 'en_US.UTF-8', 16:30:59 INFO - 'LANGUAGE': 'en_US:en', 16:30:59 INFO - 'LOGNAME': 'cltbld', 16:30:59 INFO - 'MAIL': '/var/mail/cltbld', 16:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:59 INFO - 'MOZ_NO_REMOTE': '1', 16:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:59 INFO - 'NO_EM_RESTART': '1', 16:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:59 INFO - 'PWD': '/builds/slave/test', 16:30:59 INFO - 'SHELL': '/bin/bash', 16:30:59 INFO - 'SHLVL': '1', 16:30:59 INFO - 'TERM': 'linux', 16:30:59 INFO - 'TMOUT': '86400', 16:30:59 INFO - 'USER': 'cltbld', 16:30:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:59 INFO - '_': '/tools/buildbot/bin/python'} 16:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:01 INFO - Installing collected packages: mozsystemmonitor 16:31:01 INFO - Running setup.py install for mozsystemmonitor 16:31:01 INFO - Successfully installed mozsystemmonitor 16:31:01 INFO - Cleaning up... 16:31:01 INFO - Return code: 0 16:31:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:31:01 INFO - Using env: {'DISPLAY': ':0', 16:31:01 INFO - 'HOME': '/home/cltbld', 16:31:01 INFO - 'LANG': 'en_US.UTF-8', 16:31:01 INFO - 'LANGUAGE': 'en_US:en', 16:31:01 INFO - 'LOGNAME': 'cltbld', 16:31:01 INFO - 'MAIL': '/var/mail/cltbld', 16:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:01 INFO - 'MOZ_NO_REMOTE': '1', 16:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:01 INFO - 'NO_EM_RESTART': '1', 16:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:01 INFO - 'PWD': '/builds/slave/test', 16:31:01 INFO - 'SHELL': '/bin/bash', 16:31:01 INFO - 'SHLVL': '1', 16:31:01 INFO - 'TERM': 'linux', 16:31:01 INFO - 'TMOUT': '86400', 16:31:01 INFO - 'USER': 'cltbld', 16:31:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:01 INFO - '_': '/tools/buildbot/bin/python'} 16:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:01 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:03 INFO - warning: no files found matching '*.txt' 16:31:03 INFO - no previously-included directories found matching 'build' 16:31:03 INFO - no previously-included directories found matching 'dist' 16:31:03 INFO - no previously-included directories found matching '.git*' 16:31:03 INFO - Installing collected packages: jsonschema, functools32 16:31:03 INFO - Running setup.py install for functools32 16:31:03 INFO - warning: no files found matching '*.txt' 16:31:03 INFO - no previously-included directories found matching 'build' 16:31:03 INFO - no previously-included directories found matching 'dist' 16:31:03 INFO - no previously-included directories found matching '.git*' 16:31:03 INFO - Successfully installed jsonschema functools32 16:31:03 INFO - Cleaning up... 16:31:03 INFO - Return code: 0 16:31:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:03 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')]} 16:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 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')]} 16:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:03 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 16:31:03 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 16:31:03 INFO - Using env: {'DISPLAY': ':0', 16:31:03 INFO - 'HOME': '/home/cltbld', 16:31:03 INFO - 'LANG': 'en_US.UTF-8', 16:31:03 INFO - 'LANGUAGE': 'en_US:en', 16:31:03 INFO - 'LOGNAME': 'cltbld', 16:31:03 INFO - 'MAIL': '/var/mail/cltbld', 16:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:03 INFO - 'MOZ_NO_REMOTE': '1', 16:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:03 INFO - 'NO_EM_RESTART': '1', 16:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:03 INFO - 'PWD': '/builds/slave/test', 16:31:03 INFO - 'SHELL': '/bin/bash', 16:31:03 INFO - 'SHLVL': '1', 16:31:03 INFO - 'TERM': 'linux', 16:31:03 INFO - 'TMOUT': '86400', 16:31:03 INFO - 'USER': 'cltbld', 16:31:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:03 INFO - '_': '/tools/buildbot/bin/python'} 16:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 INFO - Downloading docopt-0.6.1.tar.gz 16:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:06 INFO - Running setup.py install for blobuploader 16:31:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:06 INFO - Running setup.py install for requests 16:31:07 INFO - Running setup.py install for docopt 16:31:07 INFO - Successfully installed blobuploader requests docopt 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:07 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 16:31:07 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 16:31:07 INFO - Using env: {'DISPLAY': ':0', 16:31:07 INFO - 'HOME': '/home/cltbld', 16:31:07 INFO - 'LANG': 'en_US.UTF-8', 16:31:07 INFO - 'LANGUAGE': 'en_US:en', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MAIL': '/var/mail/cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SHLVL': '1', 16:31:07 INFO - 'TERM': 'linux', 16:31:07 INFO - 'TMOUT': '86400', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - '_': '/tools/buildbot/bin/python'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:07 INFO - Running setup.py (path:/tmp/pip-Mh5ZDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:07 INFO - Running setup.py (path:/tmp/pip-AyzE6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:07 INFO - Running setup.py (path:/tmp/pip-yNBcaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:07 INFO - Running setup.py (path:/tmp/pip-XblX3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:07 INFO - Running setup.py (path:/tmp/pip-Lx8Gai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:07 INFO - Running setup.py (path:/tmp/pip-njTqrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:08 INFO - Running setup.py (path:/tmp/pip-UVlr7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:08 INFO - Running setup.py (path:/tmp/pip-_d556U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:08 INFO - Running setup.py (path:/tmp/pip-BiojRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:08 INFO - Running setup.py (path:/tmp/pip-vyCb7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:08 INFO - Running setup.py (path:/tmp/pip-jjCf99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:08 INFO - Running setup.py (path:/tmp/pip-X42xxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:08 INFO - Running setup.py (path:/tmp/pip-JpoMqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:08 INFO - Running setup.py (path:/tmp/pip-BvOhHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:08 INFO - Running setup.py (path:/tmp/pip-W1B1xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:08 INFO - Running setup.py (path:/tmp/pip-U2dlCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:08 INFO - Running setup.py (path:/tmp/pip-uSRh0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:08 INFO - Running setup.py install for manifestparser 16:31:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:08 INFO - Running setup.py install for mozcrash 16:31:09 INFO - Running setup.py install for mozdebug 16:31:09 INFO - Running setup.py install for mozdevice 16:31:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for mozfile 16:31:09 INFO - Running setup.py install for mozhttpd 16:31:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for mozinfo 16:31:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for mozInstall 16:31:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for mozleak 16:31:09 INFO - Running setup.py install for mozlog 16:31:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for moznetwork 16:31:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:09 INFO - Running setup.py install for mozprocess 16:31:10 INFO - Running setup.py install for mozprofile 16:31:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:10 INFO - Running setup.py install for mozrunner 16:31:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:10 INFO - Running setup.py install for mozscreenshot 16:31:10 INFO - Running setup.py install for moztest 16:31:10 INFO - Running setup.py install for mozversion 16:31:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:10 INFO - Cleaning up... 16:31:10 INFO - Return code: 0 16:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:10 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:10 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 16:31:10 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 16:31:10 INFO - Using env: {'DISPLAY': ':0', 16:31:10 INFO - 'HOME': '/home/cltbld', 16:31:10 INFO - 'LANG': 'en_US.UTF-8', 16:31:10 INFO - 'LANGUAGE': 'en_US:en', 16:31:10 INFO - 'LOGNAME': 'cltbld', 16:31:10 INFO - 'MAIL': '/var/mail/cltbld', 16:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:10 INFO - 'MOZ_NO_REMOTE': '1', 16:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:10 INFO - 'NO_EM_RESTART': '1', 16:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:10 INFO - 'PWD': '/builds/slave/test', 16:31:10 INFO - 'SHELL': '/bin/bash', 16:31:10 INFO - 'SHLVL': '1', 16:31:10 INFO - 'TERM': 'linux', 16:31:10 INFO - 'TMOUT': '86400', 16:31:10 INFO - 'USER': 'cltbld', 16:31:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:10 INFO - '_': '/tools/buildbot/bin/python'} 16:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:10 INFO - Running setup.py (path:/tmp/pip-xLyffr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31: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)) 16:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:10 INFO - Running setup.py (path:/tmp/pip-a0rIha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31: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)) 16:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:10 INFO - Running setup.py (path:/tmp/pip-H7qov8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:11 INFO - Running setup.py (path:/tmp/pip-jmKPB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:11 INFO - Running setup.py (path:/tmp/pip-JVq6v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:11 INFO - Running setup.py (path:/tmp/pip-WAzicq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:11 INFO - Running setup.py (path:/tmp/pip-v09x1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:11 INFO - Running setup.py (path:/tmp/pip-lS13vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:11 INFO - Running setup.py (path:/tmp/pip-bQIvff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:11 INFO - Running setup.py (path:/tmp/pip-KdzVyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:11 INFO - Running setup.py (path:/tmp/pip-Gb5TuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:11 INFO - Running setup.py (path:/tmp/pip-RUo5qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:11 INFO - Running setup.py (path:/tmp/pip-JyCuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:11 INFO - Running setup.py (path:/tmp/pip-t4mbX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:11 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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:11 INFO - Running setup.py (path:/tmp/pip-C6KUh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31: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)) 16:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:11 INFO - Running setup.py (path:/tmp/pip-jjuj48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:12 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)) 16:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:12 INFO - Running setup.py (path:/tmp/pip-FGmDFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:12 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)) 16:31:12 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)) 16:31:12 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)) 16:31:12 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)) 16:31:12 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)) 16:31:12 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)) 16:31:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:13 INFO - Downloading blessings-1.6.tar.gz 16:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:14 INFO - Installing collected packages: blessings 16:31:14 INFO - Running setup.py install for blessings 16:31:14 INFO - Successfully installed blessings 16:31:14 INFO - Cleaning up... 16:31:14 INFO - Return code: 0 16:31:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:14 INFO - Reading from file tmpfile_stdout 16:31:14 INFO - Current package versions: 16:31:14 INFO - argparse == 1.2.1 16:31:14 INFO - blessings == 1.6 16:31:14 INFO - blobuploader == 1.2.4 16:31:14 INFO - docopt == 0.6.1 16:31:14 INFO - functools32 == 3.2.3-2 16:31:14 INFO - jsonschema == 2.5.1 16:31:14 INFO - manifestparser == 1.1 16:31:14 INFO - mozInstall == 1.12 16:31:14 INFO - mozcrash == 0.17 16:31:14 INFO - mozdebug == 0.1 16:31:14 INFO - mozdevice == 0.48 16:31:14 INFO - mozfile == 1.2 16:31:14 INFO - mozhttpd == 0.7 16:31:14 INFO - mozinfo == 0.9 16:31:14 INFO - mozleak == 0.1 16:31:14 INFO - mozlog == 3.2 16:31:14 INFO - moznetwork == 0.27 16:31:14 INFO - mozprocess == 0.22 16:31:14 INFO - mozprofile == 0.28 16:31:14 INFO - mozrunner == 6.11 16:31:14 INFO - mozscreenshot == 0.1 16:31:14 INFO - mozsystemmonitor == 0.3 16:31:14 INFO - moztest == 0.7 16:31:14 INFO - mozversion == 1.4 16:31:14 INFO - psutil == 3.1.1 16:31:14 INFO - requests == 1.2.3 16:31:14 INFO - wsgiref == 0.1.2 16:31:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:14 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')]} 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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')]} 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:14 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 16:31:14 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 16:31:14 INFO - Using env: {'DISPLAY': ':0', 16:31:14 INFO - 'HOME': '/home/cltbld', 16:31:14 INFO - 'LANG': 'en_US.UTF-8', 16:31:14 INFO - 'LANGUAGE': 'en_US:en', 16:31:14 INFO - 'LOGNAME': 'cltbld', 16:31:14 INFO - 'MAIL': '/var/mail/cltbld', 16:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:14 INFO - 'MOZ_NO_REMOTE': '1', 16:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:14 INFO - 'NO_EM_RESTART': '1', 16:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:14 INFO - 'PWD': '/builds/slave/test', 16:31:14 INFO - 'SHELL': '/bin/bash', 16:31:14 INFO - 'SHLVL': '1', 16:31:14 INFO - 'TERM': 'linux', 16:31:14 INFO - 'TMOUT': '86400', 16:31:14 INFO - 'USER': 'cltbld', 16:31:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:14 INFO - '_': '/tools/buildbot/bin/python'} 16:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 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)) 16:31:14 INFO - Cleaning up... 16:31:14 INFO - Return code: 0 16:31:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:14 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')]} 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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')]} 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:14 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 16:31:14 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 16:31:14 INFO - Using env: {'DISPLAY': ':0', 16:31:14 INFO - 'HOME': '/home/cltbld', 16:31:14 INFO - 'LANG': 'en_US.UTF-8', 16:31:14 INFO - 'LANGUAGE': 'en_US:en', 16:31:14 INFO - 'LOGNAME': 'cltbld', 16:31:14 INFO - 'MAIL': '/var/mail/cltbld', 16:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:14 INFO - 'MOZ_NO_REMOTE': '1', 16:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:14 INFO - 'NO_EM_RESTART': '1', 16:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:14 INFO - 'PWD': '/builds/slave/test', 16:31:14 INFO - 'SHELL': '/bin/bash', 16:31:14 INFO - 'SHLVL': '1', 16:31:14 INFO - 'TERM': 'linux', 16:31:14 INFO - 'TMOUT': '86400', 16:31:14 INFO - 'USER': 'cltbld', 16:31:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:14 INFO - '_': '/tools/buildbot/bin/python'} 16:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:14 INFO - Cleaning up... 16:31:14 INFO - Return code: 0 16:31:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:31:14 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')]} 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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')]} 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:14 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 0x7f806b531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', '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 16:31:14 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 16:31:14 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 16:31:14 INFO - Using env: {'DISPLAY': ':0', 16:31:14 INFO - 'HOME': '/home/cltbld', 16:31:14 INFO - 'LANG': 'en_US.UTF-8', 16:31:14 INFO - 'LANGUAGE': 'en_US:en', 16:31:14 INFO - 'LOGNAME': 'cltbld', 16:31:14 INFO - 'MAIL': '/var/mail/cltbld', 16:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:14 INFO - 'MOZ_NO_REMOTE': '1', 16:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:14 INFO - 'NO_EM_RESTART': '1', 16:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:14 INFO - 'PWD': '/builds/slave/test', 16:31:14 INFO - 'SHELL': '/bin/bash', 16:31:14 INFO - 'SHLVL': '1', 16:31:14 INFO - 'TERM': 'linux', 16:31:14 INFO - 'TMOUT': '86400', 16:31:14 INFO - 'USER': 'cltbld', 16:31:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:14 INFO - '_': '/tools/buildbot/bin/python'} 16:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:15 INFO - Downloading/unpacking flake8 16:31:15 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 16:31:15 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 16:31:15 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 16:31:15 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 16:31:15 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 16:31:15 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 16:31:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:31:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:31:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:17 INFO - no previously-included directories found matching 'docs/_build' 16:31:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:31:17 INFO - Running setup.py install for pep8 16:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:17 INFO - no previously-included directories found matching 'docs/_build' 16:31:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:31:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:31:17 INFO - Cleaning up... 16:31:17 INFO - Return code: 0 16:31:17 INFO - Running post-action listener: _resource_record_post_action 16:31:17 INFO - Running post-action listener: _start_resource_monitoring 16:31:17 INFO - Starting resource monitoring. 16:31:17 INFO - ##### 16:31:17 INFO - ##### Finished create-virtualenv step (success) 16:31:17 INFO - ##### 16:31:17 INFO - ##### 16:31:17 INFO - ##### Running install step. 16:31:17 INFO - ##### 16:31:17 INFO - Running pre-action listener: _resource_record_pre_action 16:31:17 INFO - Running main action method: install 16:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:18 INFO - Reading from file tmpfile_stdout 16:31:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:18 INFO - Reading from file tmpfile_stdout 16:31:18 INFO - Output received: 16:31:18 INFO - Usage: mozinstall [options] installer 16:31:18 INFO - Options: 16:31:18 INFO - -h, --help show this help message and exit 16:31:18 INFO - -d DEST, --destination=DEST 16:31:18 INFO - Directory to install application into. [default: 16:31:18 INFO - "/builds/slave/test"] 16:31:18 INFO - --app=APP Application being installed. [default: firefox] 16:31:18 INFO - mkdir: /builds/slave/test/build/application 16:31:18 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'] 16:31:18 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 16:31:35 INFO - Reading from file tmpfile_stdout 16:31:35 INFO - Output received: 16:31:35 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - ##### 16:31:35 INFO - ##### Finished install step (success) 16:31:35 INFO - ##### 16:31:35 INFO - ##### 16:31:35 INFO - ##### Running run-tests step. 16:31:35 INFO - ##### 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: run_tests 16:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:35 INFO - Python 2.7.3 16:31:35 INFO - Return code: 0 16:31:35 INFO - grabbing minidump binary from tooltool 16:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:35 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 0x26596f0>, '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 0x265a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265aaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:35 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 16:31:35 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 16:31:35 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 16:31:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:35 INFO - Return code: 0 16:31:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:31:36 INFO - Return code: 0 16:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:31:36 INFO - Using env: {'DISPLAY': ':0', 16:31:36 INFO - 'HOME': '/home/cltbld', 16:31:36 INFO - 'LANG': 'en_US.UTF-8', 16:31:36 INFO - 'LANGUAGE': 'en_US:en', 16:31:36 INFO - 'LOGNAME': 'cltbld', 16:31:36 INFO - 'MAIL': '/var/mail/cltbld', 16:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:36 INFO - 'MOZ_NO_REMOTE': '1', 16:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:36 INFO - 'NO_EM_RESTART': '1', 16:31:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:36 INFO - 'PWD': '/builds/slave/test', 16:31:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:36 INFO - 'SHELL': '/bin/bash', 16:31:36 INFO - 'SHLVL': '1', 16:31:36 INFO - 'TERM': 'linux', 16:31:36 INFO - 'TMOUT': '86400', 16:31:36 INFO - 'USER': 'cltbld', 16:31:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039', 16:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:36 INFO - '_': '/tools/buildbot/bin/python'} 16:31:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:31:36 INFO - mozversion application_buildid: 20160627133055 16:31:36 INFO - mozversion application_changeset: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 16:31:36 INFO - mozversion application_display_name: Nightly 16:31:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:36 INFO - mozversion application_name: Firefox 16:31:36 INFO - mozversion application_remotingname: firefox 16:31:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:36 INFO - mozversion application_vendor: Mozilla 16:31:36 INFO - mozversion application_version: 50.0a1 16:31:36 INFO - mozversion platform_buildid: 20160627133055 16:31:36 INFO - mozversion platform_changeset: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 16:31:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:36 INFO - mozversion platform_version: 50.0a1 16:31:36 INFO - using testdate: 1467070296 16:31:36 INFO - actual date: 1467070296 16:31:36 INFO - starting webserver on 'localhost:33390' 16:31:36 INFO - SUITE-START | Running 2 tests 16:31:36 INFO - TEST-START | dromaeo_css 16:31:36 INFO - operating with platform_type : linux_ 16:31:36 INFO - Initialising browser for dromaeo_css test... 16:31:36 INFO - TEST-INFO | started process 21904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5H8IEh/profile http://localhost:33390/getInfo.html) 16:31:40 INFO - PROCESS | 21904 | __metrics Screen width/height:1600/1200 16:31:40 INFO - PROCESS | 21904 | colorDepth:24 16:31:40 INFO - PROCESS | 21904 | Browser inner width/height: 1024/697 16:31:40 INFO - PROCESS | 21904 | __metrics 16:31:41 INFO - PROCESS | 21904 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:42 INFO - TEST-INFO | 21904: exit 0 16:31:42 INFO - Browser initialized. 16:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:31:42 INFO - TEST-INFO | started process 21985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5H8IEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:54 INFO - PROCESS | 21985 | RSS: Main: 156200960 16:31:54 INFO - PROCESS | 21985 | 16:32:46 INFO - PROCESS | 21985 | 1467070366259 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] 16:34:54 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33390/tests/dromaeo/cssquery-ext.html) 16:34:55 INFO - PROCESS | 21985 | RSS: Main: 254783488 16:34:55 INFO - PROCESS | 21985 | 16:37:57 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-ext.html (next: http://localhost:33390/tests/dromaeo/cssquery-jquery.html) 16:37:58 INFO - PROCESS | 21985 | RSS: Main: 243490816 16:37:58 INFO - PROCESS | 21985 | 16:41:00 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33390/tests/dromaeo/cssquery-mootools.html) 16:41:00 INFO - PROCESS | 21985 | RSS: Main: 242520064 16:41:00 INFO - PROCESS | 21985 | 16:44:02 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33390/tests/dromaeo/cssquery-prototype.html) 16:44:03 INFO - PROCESS | 21985 | RSS: Main: 237862912 16:44:03 INFO - PROCESS | 21985 | 16:47:05 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33390/tests/dromaeo/cssquery-yui.html) 16:47:06 INFO - PROCESS | 21985 | RSS: Main: 231055360 16:47:06 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | Cycle 1(1): loaded http://localhost:33390/tests/dromaeo/cssquery-yui.html (next: http://localhost:33390/tests/dromaeo/cssquery-dojo.html) 16:50:09 INFO - PROCESS | 21985 | RSS: Main: 323866624 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | __start_tp_report 16:50:09 INFO - PROCESS | 21985 | _x_x_mozilla_page_load 16:50:09 INFO - PROCESS | 21985 | _x_x_mozilla_page_load_details 16:50:09 INFO - PROCESS | 21985 | |i|pagename|runs| 16:50:09 INFO - PROCESS | 21985 | |0;dojo.html;3058.235441139715;3065.9233519162003;3086.2747254395213;3098.70562296582;3132.8746850125995;5211.973940130299;5220.190870415082;5265.420803711589;5286.9735651321735;5294.444083371243;5228.503292187245;5240.711760853152;5268.209768534722;5303;5351.491608297215;4729.432468103832;4785.952140478603;4822.300766388889;4834.419869615651;5015.724135172564;4908.631852611051;4914.729689867074;4932.136876046696;4976.129177393942;5005.199168133099;4722.716637001774;4781.665283430161;4798.952010479886;4804.543568361;4829.855104346875;4808.014357056795;4812.278158276252;4879.902401951941;4880.2435622478215;4925.408950925876;4716.38686970695;4839.879003024953;4848.951510484885;4867.586255168315;4895.31465594817;5221.634485586011;5270.710110943896;5307.681539107666;5372.946270537323;5386.272853164812;5688.60179787415;5691.971540142315;5713.371529131792;5729.427057294279;5737.39757325479;5533.612647114704;5561.4716601923155;5731.398203188689;5772.105323674838;5775.5668324875805;5190.169572868323;5285.550728188147;5287.339082614673;5289.233061206142;5289.841304760864;5757.65454072757;5785.103308987113;5788.102844059177;5793.304803423532;5801.82594522165;5412.458754124635;5443.374011988672;5492.148716948799;5542.861428464321;5544.251526044013;5634.1830434586755;5640.548756099584;5648.774049037993;5652.717364131777;5653.604247702621;5568.916466253009;5569.526590239875;5570.359408667974;5571.4150014248735;5572.749226284827;5445.128779395278;5558.082916318762;5578.860528486739;5616.887662246814;5631.577631677641;4333.349997500401;4354.172707185625;4357.2592659248;4364.956350436519;4386.210482113251;3874.9418758718643;3881.880077099681;3893.902652433712;3924.156306394139;3943.861964831217;5176.482351764794;5227.059129356752;5309.46905309466;5367.275417818622;5371.3822910365025;5703.828885133453;5712.485876271156;5720.713964301768;5722.141678748221;5761.740721667451;5356.5179133877355;5377.784888604412;5388.784448622089;5394.352677678625;5408.5402740766685;4799.544043315879;4879.658423910292;4906.411230652345;4908.533689299511;4954.256861470808;5897.262842144732;5899.528037756969;5899.793507227227;5906.8818623627285;5916.112583112567;5566.749496272597;5687.857803554944;5704.743286552032;5706.9714651426475;5708.714564271687;5826.592138550261;5857.882842343214;5861.7655293787775;5933.762649493972;5938.703064846827;5627;5627.915581266366;5628.634138780966;5632.098864181711;5636.4927156556105;5555.472230138131;5662.886742265049;5741.569382296261;5741.971290143522;5747.453991870766;5540.69526176048;5615.831525054255;5623.3533143689;5667.943320566742;5669.971650141888;5580.860478487908;5587.5809314302405;5588.441155884379;5593.496585307342;5598.272224610774;5319.760610772447;5435.945640543544;5463.508284254436;5510.3938566758425;5575.804846830341;5580.720963951705;5688.857778555569;5689.487946084707;5690.089585666274;5691.77232910679;5470.562355011669;5519;5520.613557051129;5524.14375771756;5525.640833345819 16:50:09 INFO - PROCESS | 21985 | |1;ext.html;591.6065816232206;607.3167686352853;613.6870196199939;630.7697690343025;640.5932233032026;32536.67463325366;35409.11477213068;46208.768956155174;47245.527544724544;47283;44531;44969.550304496945;45216.54783452165;45238.77380613101;45320.77339613305;8756.430831995916;8962.955185224066;8976.910230897705;8979.551022448884;8988.460692358447;8530.530820804854;8567.785805354853;8587.141285871425;8592.8711069334;8614.698485553006;8607.569621518931;8750.6937257196;8758.211760941515;8763.386562940597;8763.78090547735;8657.95671021644;8698.869516957251;8700.651973921067;8705.608247628872;8706.259967902735;8854.158854908774;8924.241439477652;8926.018138004814;8926.821463570757;8927.687530936386;42720;43170.784146079066;43201.783991080156;43229.567704323184;43247.567524324986;3356.8153751543655;3890.3191941410423;4140.937885931713;4141.64795992338;4243.8090285937205;33073.83463082693;33761.83119084389;34372.312553749034;35657;35758.463623045674;4368.453943257093;4392.253316936129;4453.309736990772;4503.729776213438;4665.160271151191;365177;367668;369382;369985;370106.9999999973;31022.534661980088;31927.361452771278;32037;33562.16094597606;61733.38266617366;33623.15942101467;34013.14967125842;34018.14954626105;34075.488867667;34152.48771268433;13963.650908727363;14025.649358765908;14049;14068.577942661737;14072.648183795487;12660.240385576895;12865.099443038898;12875.549355772502;12889.677758056123;12985.220886746825;7415.1101867776215;7423.294786995227;7459.365953893871;7479.813004674927;7492.737754178577;2813.521701310782;2823.280063583773;2877.8848846046344;2896.420715856837;2922.7661787056986;1025.220832167558;1051.5898799468214;1055.3984228989557;1065.9307145035548;1140.1505878120854;31662.841685791424;31882.840585797385;32242.677573223966;32277.51583726246;32643;1116.6929094498914;1121.063911633795;1126.378015657467;1149.6780901347636;1150.0339714639742;15941.920290398473;16439.506814795575;16572.419965301397;16583.253753581117;16652.084135372428;547260;553100;553125;554135;554259;57696.13455798166;58144.709276454196;58222.41777582255;58269.70865145647;58283.70858145767;1245.7882160032816;1319.3732976835927;1339.2901762066122;1382.9446822127204;1394.114737141902;31960.520592191602;31974;32616.836915815267;32859.17852053718;33408.498872516444;49975.75012124916;50779.49220507748;50846.745766270935;50875.23687144622;50978.49021509737;406705;412698;414009;415503;416786;22354.664680029487;23208.535829283657;23455.06179752791;23458.178963736187;23504.6474302889;44494.3325850119;45220.77389613031;45228.32157517574;45538.54461455343;45995;37851.81074094722;38251.426228607146;38945.41581876331;39009.414858776574;39092.413613795245;38687.41968870413;38732.2253554933;39022.978757370656;39150.6084939147;39151;37604.81197594104;38460.80769596246;38936.52229993474;39004;39010.80494597509;32766.508502372006;33313.333733325686;33793.324133517686;34088.82955585206;34491.31017379588;25847.353816153995;25938.22185334443;26240.8687956559;26331.736682632927;26543.33641658974 16:50:09 INFO - PROCESS | 21985 | |2;jquery.html;379.7114193213157;387.8254785346594;395.95446523649787;403.27611936573845;414.9356849688298;17876.19557119931;18995.52511187221;19531.21875124995;19587.5103122422;20659;18904.77118987265;19009.334673286437;19049.42851714447;19353;19419.611607767834;5539.861503462405;5577.944220557783;5777.393373695764;5793.217915581385;5797.36229014808;5693.373728889819;5697.287839020122;5700.686462244575;5714.628549144292;5717.256756621633;5459.12653975364;5647.09646456567;5649.435056494338;5652.886942261173;5674.432556744313;5663;5672.631278966875;5684.459976302244;5685.800996965107;5686.09022556389;4881.951180488185;5131.794728210867;5131.87170320745;5135.845924622267;5135.897282054338;22431.32706018822;22474.43813904649;22504.32487025392;22919;22940.082396704278;2360.8937597807967;2493.638422428756;2568.203856804378;2606.9478610427873;2975.1669532530927;13739.175649461064;14107.858921410758;14403.78394324086;14837.743186801177;14943.925280373638;1929.807019298073;1932.884026958387;1943.3101249056665;1988.2444671025062;2001.5596568754995;73237.26762732358;74111.62944185245;76113;76990.6150469244;78286.60856695737;9333.160015598492;9497.952510237543;9949.104580587782;10038.196944244442;10178.18574514037;13063.542776002794;13149.342532873317;13159.868401316056;13175.67060823487;13199.67000824987;8159.714409995621;8190.959045204736;8252.587370631445;8271.875921861178;8371.874421883676;7644.961775191088;7785.64964576584;7794.064712234568;7950.920490795133;8477.27943124829;6150.354212807591;6283.905741413882;6285.685715714196;6389.552731308764;6403.871922561522;1744.4504980930967;1766.646670665872;1783.5184500184878;1786.5444311700433;1815.2376002079159;902.5351943748974;1011.7369483934083;1015.1270905179931;1016.9203977865283;1086.2999405929852;19240.903795480932;19393.90303048476;19450.805491945182;19585.216591336186;19683.704744428844;936.8922573904089;994.1748348870565;1019.169376957777;1041.354360296621;1084.5878566144972;10563.154947604173;10634.735551768432;10990.340579565252;11061.557537698402;11088.778224435466;472095;485422;487375;489169;490268;75514.24485755182;75677;75801.62099189579;77625;78889.21110788934;1039.6984874386494;1042.6715584590677;1045.8378951262566;1072.7103682005816;1073.1682945716975;17581.648367032845;17642.735358969883;17836;17844.91077544604;18164.636707266043;36734.44898326474;37759.244815103;38347.2330553393;38827.41758873676;39085.02287442837;51117.23324150215;54341;59212.70393648177;60746.392536074076;60765;7756.689732410866;8058.556779377191;8150.510969341858;8182.304504116979;8263.421560490948;8838.823223535364;11278;11522.827157592475;12202.938985305016;12436.813447798471;10949.343039417661;10989.780204396027;11246.493907774333;11251.606193783178;11338.206325557132;11149.23666020177;11197.328160310408;11290.209685321948;11310.773784524428;11325.32048077118;11121.27711698737;11340.319580825177;11485.712857178638;11531.596394126165;11592;8439.28266097364;8512.40413171072;8529.872051919103;8637.438566493158;8660.523671197892;8728.432651877607;10005.299629025898;10750.784984300426;10869.619563315246;11415.885841141482 16:50:09 INFO - PROCESS | 21985 | |3;mootools.html;1307.8561358250586;1435.2034620785466;1466.3035058347284;1566.4752307976828;1708.9401870934519;8045.637946292416;8445.028821685508;8452.028016778064;8709.303255739542;8711.0417854036;8081.272685458308;8280.792980175484;8285.378596605264;8286.91713082869;8288.627011784469;1962.2935743132462;2260.9095636174616;2305.9077636894544;2331.440454290975;2349.236498138112;2317.2584772872688;2324.8023917966993;2326.5463234669246;2327.0575416956076;2328.2665960222475;2229.2197730794173;2238.473958619723;2275.5335156293004;2275.7951784339407;2279.361778701966;1769.973450398245;2142.046789178816;2202.592520383734;2203.7796220377836;2227.4208705736464;1906.08507916201;1918.1847714721187;1921.8846869187894;1925.8170473804967;1927.633749587574;8644.870326945038;8703.129687031309;8705.608247628808;8710.651573937035;8741;4979.377577802775;5151.536361727425;5151.819686310999;5155.664881782672;5159.664621799571;3082.152408087771;3176.1900715317447;3278.229616040229;3287.309664970359;3301.6533264007176;995.3032876986139;1017.6590842067842;1021.933574317667;1026.2703435580984;1027.825269704152;11291.661250162508;11293.887061129366;11327.433628318551;11344.773104537946;11345.37600431976;4396.252637051709;4424.46906371231;4435.933460998088;4458.7547684877645;4526.388937493462;9514.476703781358;9537.523123843781;9574.904250957541;9579.13787759091;9583.952080239555;4934.605231581537;4945.752712364368;4958.429780575208;4970.304157417964;4970.776315065831;4142.565030671736;4579.084183163381;4702.247640377524;4706.247000479907;4782.378290822171;3822.0635944193295;3880.708946828999;3920.1179734559496;3954.762714237155;3982.064214909494;1210.8002179640262;1224.8224007518859;1238.5169783784331;1243.2043492165021;1248.431963456625;980.1472718734747;984.5077461269366;984.8916619171886;985.6599473181741;995.4375777685584;5557.833265002057;5684;5692.1461780733225;5694.174344719992;5732.914006289909;427.26510402108323;431.0473852785317;432.6236174528118;437.656439694838;987.7579992901785;3990;4060.7969601520394;4063.79681015948;4115.691323150776;4151.896202594899;10438.895611043792;10689.625863094754;10698.893011069946;10721.571137154582;10756.677299681021;10652.094571961316;10656;10664.146868250522;10676.733081672865;10686.625968091235;7400.666969986363;7720.7683769487;7728.961355193188;7903.644336004893;7905.960470197612;5647.7176141193595;5906.586538942404;5907.202527658883;5985.880282394415;5990;9595.376300540442;9653.951730241304;9755.122039016522;9756.902430975599;9769.853452198366;9351.5791789371;9546.570404331684;9811.55847986828;9818.852717209105;9825.754356140867;6827.351401616838;7235.3488186063505;7434.3309102181065;7679.193684663253;7845.960770196112;8201.09787923316;8206.302464290602;8239.794005149919;8280;8283.50298982063;7410.6665200065045;7544.47188696786;7625.923740762521;7706.7687969361;7726.111497177896;7341.853162936818;7393.667284972082;7415.777526674208;7481.064866891638;7581.6209189541405;6406.615603063831;6456.451201647913;6489.675516224264;6490.578112422678;6490.935090649033;4989.151844186425;5052;5072.949270507395;5228.032813929435;5231.241469986754;5133.998870220271;5179.300794392709;5248.029114613809;5326.174442961347;5329.200619907045 16:50:09 INFO - PROCESS | 21985 | |4;prototype.html;334.52664479761137;335.6911641290013;343.5448031358451;345.5525095001973;348.4755443058197;5281.419043905167;5284.762185701643;5370.288004557703;5371.838844834651;5412.350517937848;5257.737113144347;5298.523132918037;5298.894022119565;5303.469653034705;5311.3974152665205;3836.808159592023;3909.8436062557535;3974.642282194602;4043.6360727534516;4168.6665066794585;4154.646855017312;4156.792160391983;4164.750114993095;4165.541790403068;4171.416001759756;4171.353440216756;4171.624553790159;4184.769837658928;4190.506648544111;4200.852970146046;3925.9411108833247;4106.178764247163;4158.6673066154635;4187.225363307798;4208.3687446882905;3711.406175011985;3714.23858109087;3731.869384571527;3737.8131093445218;3742.8689995850013;5133.614978876599;5204.843854684365;5212.218167274901;5212.384160910092;5213.661112027706;4457.576530229623;4718.740469274188;4720.598749106296;4762.738049407281;4773.164696178155;5455.427180146107;5505.6696598204235;5517.282753242052;5527.668339899619;5538.424632545885;3985.8206380712936;3993.7204395692315;4008.498937632796;4014.2172276406113;4016.6585840203616;5495.313085864267;5749;5760.279965004374;5812.825615231508;5821.79623713168;3960.386140148282;3984.7210695251056;4008.819603117867;4058.1477889642915;4063.593640635913;4072.2873497137884;4073.3889916512762;4083.285425050664;4083.530394004668;4086.6730661547003;4545.727256364563;4625.190591646516;4649.511801260886;4652.930206046912;4714.22215334466;5556.888862222733;5563.749631266603;5597.74810133545;5610.775568977277;5625.943740562624;1411.7600007998665;1424.886009119268;1425.337218193545;1428.328685517805;1438.6475313548037;888.2403635224108;913.7304495173939;916.3539704508306;926.5228407370209;932;4741.525847415231;4749.57771536512;4805.261001229266;4827.975860120677;4859.611231101574;5044.2937988681615;5046.34397528319;5070.340855688737;5165.715885626327;5170.586353091744;4695.906081878344;4896.453844001171;4914.950850491521;4915.754212289443;4916.483769204254;2667.8932842686463;2697.662792150981;2717.6331195288776;2763.115802943079;2768.671037901818;5161.638685292069;5261.816091379409;5265.894682106336;5283.735813209324;5287.012837746661;4799.928001079987;5123.897522049613;5176;5243.344581927259;5254.185601231815;5175.955497578436;5181.844544663666;5185.559227465632;5206.214675148777;5292.9470705294;5061.949380506295;5063.493650634907;5140.922886156785;5146.948530514647;5150.304708864255;4733.857984260478;4976.30331753562;5014.373203349582;5015.824446144367;5024.371953505812;5167.302414174038;5172.818951336685;5199.440167949524;5217.426083130928;5223.973880130575;3704.518412606344;3728.7389882709035;3734.79458629778;3736.271427071695;3739.1773809761808;5055.823046193365;5081.8729531762;5426.321709786277;5821.79623713168;5837.182794408871;5649.350324712711;5665.603407761417;5685.175649530877;5687.720262940805;5693.28833895763;5460.515465463284;5648.661080335193;5650.802221922378;5653.014624689667;5661.858453538694;5567.66594004361;5584.804531841529;5591.18927755465;5593.608447408805;5598.832035038955;5661.556303142672;5690.3456102548735;5700.859828034327;5708.343540492897;5710.200571920018;5323.494268044529;5523.834284971457;5529.502344788988;5547.306586676666;5578.219049333015 16:50:09 INFO - PROCESS | 21985 | |5;yui.html;684.411406190676;687.790223981686;719.5790462579391;801.4109629422376;806.8709006558952;14658.560243192722;15398.769018464718;15436.996595221332;16349.427770028036;16365.509034728948;14380.424783008668;14446.422143114289;14556.927215363934;14566.635834104127;14574.562763117097;674.2616834566167;783.8393129408486;815.7308088330851;820.3519219816338;830.393812516863;812.1472453923386;815.3762371785589;816.0248503038871;816.338765599863;818.6643476174739;843.8945131858518;845.1421806866036;845.7927807687095;845.9619317130744;846.2172490446343;700.3731660164176;836.1304243586662;837.1419295222385;867.96528138875;868.674247157316;634.3244444666416;634.8793729191485;635.4058954877205;635.9777407790751;636.0586332228282;15247.16140612266;15247.313870875838;15289.923550382287;15312.540623781193;15316.617084572863;13807.585772426843;13841.30793460323;14143.71712565743;14183.503577374742;14187.290635468185;11852.822207666892;11973.94013029938;12091.093168012434;12255.69360765979;12440.440180191914;4501.819927202941;4516.909661806778;4522.208613492626;4543.840965566189;4658.813647454098;66005.66997164984;70424.29575704229;71669.64165179193;71729;71903.64048179777;10953.233273670767;11324.094072474183;11779.646610601696;12144;12511.311877846623;20620;20877.89561052185;20942.581148376947;20950.161993520393;20999.580008399746;8452.112528184574;8478.44890082155;8490.745277641681;8782.91217087821;8921.553922303989;4779.115863565252;4835.854924352275;4921.975390123026;4986.152354099811;5016.44819069902;3296.6373698893103;3391.6269210386836;3392.2197894484407;3393.5079413484905;3400.472926696366;491.98524044278014;553.8172403106965;591.5326891755551;596.931352894414;598.5570677698558;559.2254727202853;578.8003138917067;679.9426891184157;691.8826095855158;736.0274464435258;9203.40177888435;9319.394239374418;9338.766530836783;9520.523973801282;9751.512424378752;577.151587166864;628.7327885648581;693.1889689063808;713.7252157919238;717.7739012211136;4383.232934236496;4669;4689.20283551797;4938.407391113089;4988.8752781180765;126664;128652;129278;129762;130681;111718;113277;113311.43344283226;113322.43338783253;114277;97468.51265743768;97770.51114744523;99135.99999999856;99377.50311248397;101589.49205253927;8993.235574975939;9512.240235556168;9553.092456216647;9600.567974441306;9719.125278724949;54777;55349.44650553604;55483;56435.71782141063;57929.4207057924;77083.61458192673;80979.59510202648;81357.59321203594;83542.58228709061;84118;12131.514739410324;12310.753784924073;12325.383730813603;12476.750464990831;12744.757500272859;13558.86441135576;13913.304334783423;14035.438582456587;14151.787723184367;14875.256237188314;13219.867801321863;13233.13984591037;13477.25875076841;13539.59381218565;14316.212608306643;13177;13331.466741330238;13432.992525560818;13810.723785524435;13925.651858703613;11995.40022998864;12386;12792.936035319764;12884.420201091161;13309.46762129504;9256.583453744732;9616.663416780379;9627.521960860271;10338.586456541954;10538.947305263731;10222.897771022195;10392.42841643717;10494.632687855888;10629.627963021258;10701 16:50:09 INFO - PROCESS | 21985 | __end_tp_report 16:50:09 INFO - PROCESS | 21985 | __start_cc_report 16:50:09 INFO - PROCESS | 21985 | _x_x_mozilla_cycle_collect,874 16:50:09 INFO - PROCESS | 21985 | __end_cc_report 16:50:09 INFO - PROCESS | 21985 | __startTimestamp1467071409498__endTimestamp 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | ------- Summary: start ------- 16:50:09 INFO - PROCESS | 21985 | Number of tests: 6 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#0] dojo.html Cycles:165 Average:5275.81 Median:5492.15 stddev:592.17 (10.8%) stddev-sans-first:567.86 16:50:09 INFO - PROCESS | 21985 | Values: 3058.2 3065.9 3086.3 3098.7 3132.9 5212.0 5220.2 5265.4 5287.0 5294.4 5228.5 5240.7 5268.2 5303.0 5351.5 4729.4 4786.0 4822.3 4834.4 5015.7 4908.6 4914.7 4932.1 4976.1 5005.2 4722.7 4781.7 4799.0 4804.5 4829.9 4808.0 4812.3 4879.9 4880.2 4925.4 4716.4 4839.9 4849.0 4867.6 4895.3 5221.6 5270.7 5307.7 5372.9 5386.3 5688.6 5692.0 5713.4 5729.4 5737.4 5533.6 5561.5 5731.4 5772.1 5775.6 5190.2 5285.6 5287.3 5289.2 5289.8 5757.7 5785.1 5788.1 5793.3 5801.8 5412.5 5443.4 5492.1 5542.9 5544.3 5634.2 5640.5 5648.8 5652.7 5653.6 5568.9 5569.5 5570.4 5571.4 5572.7 5445.1 5558.1 5578.9 5616.9 5631.6 4333.3 4354.2 4357.3 4365.0 4386.2 3874.9 3881.9 3893.9 3924.2 3943.9 5176.5 5227.1 5309.5 5367.3 5371.4 5703.8 5712.5 5720.7 5722.1 5761.7 5356.5 5377.8 5388.8 5394.4 5408.5 4799.5 4879.7 4906.4 4908.5 4954.3 5897.3 5899.5 5899.8 5906.9 5916.1 5566.7 5687.9 5704.7 5707.0 5708.7 5826.6 5857.9 5861.8 5933.8 5938.7 5627.0 5627.9 5628.6 5632.1 5636.5 5555.5 5662.9 5741.6 5742.0 5747.5 5540.7 5615.8 5623.4 5667.9 5670.0 5580.9 5587.6 5588.4 5593.5 5598.3 5319.8 5435.9 5463.5 5510.4 5575.8 5580.7 5688.9 5689.5 5690.1 5691.8 5470.6 5519.0 5520.6 5524.1 5525.6 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#1] ext.html Cycles:180 Average:58294.13 Median:38974.71 stddev:120165.11 (308.3%) stddev-sans-first:120424.11 16:50:09 INFO - PROCESS | 21985 | Values: 591.6 607.3 613.7 630.8 640.6 32536.7 35409.1 46208.8 47245.5 47283.0 44531.0 44969.6 45216.5 45238.8 45320.8 8756.4 8963.0 8976.9 8979.6 8988.5 8530.5 8567.8 8587.1 8592.9 8614.7 8607.6 8750.7 8758.2 8763.4 8763.8 8658.0 8698.9 8700.7 8705.6 8706.3 8854.2 8924.2 8926.0 8926.8 8927.7 42720.0 43170.8 43201.8 43229.6 43247.6 3356.8 3890.3 4140.9 4141.6 4243.8 33073.8 33761.8 34372.3 35657.0 35758.5 4368.5 4392.3 4453.3 4503.7 4665.2 365177.0 367668.0 369382.0 369985.0 370107.0 31022.5 31927.4 32037.0 33562.2 61733.4 33623.2 34013.1 34018.1 34075.5 34152.5 13963.7 14025.6 14049.0 14068.6 14072.6 12660.2 12865.1 12875.5 12889.7 12985.2 7415.1 7423.3 7459.4 7479.8 7492.7 2813.5 2823.3 2877.9 2896.4 2922.8 1025.2 1051.6 1055.4 1065.9 1140.2 31662.8 31882.8 32242.7 32277.5 32643.0 1116.7 1121.1 1126.4 1149.7 1150.0 15941.9 16439.5 16572.4 16583.3 16652.1 547260.0 553100.0 553125.0 554135.0 554259.0 57696.1 58144.7 58222.4 58269.7 58283.7 1245.8 1319.4 1339.3 1382.9 1394.1 31960.5 31974.0 32616.8 32859.2 33408.5 49975.8 50779.5 50846.7 50875.2 50978.5 406705.0 412698.0 414009.0 415503.0 416786.0 22354.7 23208.5 23455.1 23458.2 23504.6 44494.3 45220.8 45228.3 45538.5 45995.0 37851.8 38251.4 38945.4 39009.4 39092.4 38687.4 38732.2 39023.0 39150.6 39151.0 37604.8 38460.8 38936.5 39004.0 39010.8 32766.5 33313.3 33793.3 34088.8 34491.3 25847.4 25938.2 26240.9 26331.7 26543.3 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#2] jquery.html Cycles:180 Average:28096.90 Median:2791.06 stddev:79582.81 (2851.3%) stddev-sans-first:79778.85 16:50:09 INFO - PROCESS | 21985 | Values: 379.7 387.8 396.0 403.3 414.9 17876.2 18995.5 19531.2 19587.5 20659.0 18904.8 19009.3 19049.4 19353.0 19419.6 5539.9 5577.9 5777.4 5793.2 5797.4 5693.4 5697.3 5700.7 5714.6 5717.3 5459.1 5647.1 5649.4 5652.9 5674.4 5663.0 5672.6 5684.5 5685.8 5686.1 4882.0 5131.8 5131.9 5135.8 5135.9 22431.3 22474.4 22504.3 22919.0 22940.1 2360.9 2493.6 2568.2 2606.9 2975.2 13739.2 14107.9 14403.8 14837.7 14943.9 1929.8 1932.9 1943.3 1988.2 2001.6 73237.3 74111.6 76113.0 76990.6 78286.6 9333.2 9498.0 9949.1 10038.2 10178.2 13063.5 13149.3 13159.9 13175.7 13199.7 8159.7 8191.0 8252.6 8271.9 8371.9 7645.0 7785.6 7794.1 7950.9 8477.3 6150.4 6283.9 6285.7 6389.6 6403.9 1744.5 1766.6 1783.5 1786.5 1815.2 902.5 1011.7 1015.1 1016.9 1086.3 19240.9 19393.9 19450.8 19585.2 19683.7 936.9 994.2 1019.2 1041.4 1084.6 10563.2 10634.7 10990.3 11061.6 11088.8 472095.0 485422.0 487375.0 489169.0 490268.0 75514.2 75677.0 75801.6 77625.0 78889.2 1039.7 1042.7 1045.8 1072.7 1073.2 17581.6 17642.7 17836.0 17844.9 18164.6 36734.4 37759.2 38347.2 38827.4 39085.0 51117.2 54341.0 59212.7 60746.4 60765.0 7756.7 8058.6 8150.5 8182.3 8263.4 8838.8 11278.0 11522.8 12202.9 12436.8 10949.3 10989.8 11246.5 11251.6 11338.2 11149.2 11197.3 11290.2 11310.8 11325.3 11121.3 11340.3 11485.7 11531.6 11592.0 8439.3 8512.4 8529.9 8637.4 8660.5 8728.4 10005.3 10750.8 10869.6 11415.9 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#3] mootools.html Cycles:180 Average:5562.88 Median:5062.47 stddev:3163.68 (62.5%) stddev-sans-first:3156.40 16:50:09 INFO - PROCESS | 21985 | Values: 1307.9 1435.2 1466.3 1566.5 1708.9 8045.6 8445.0 8452.0 8709.3 8711.0 8081.3 8280.8 8285.4 8286.9 8288.6 1962.3 2260.9 2305.9 2331.4 2349.2 2317.3 2324.8 2326.5 2327.1 2328.3 2229.2 2238.5 2275.5 2275.8 2279.4 1770.0 2142.0 2202.6 2203.8 2227.4 1906.1 1918.2 1921.9 1925.8 1927.6 8644.9 8703.1 8705.6 8710.7 8741.0 4979.4 5151.5 5151.8 5155.7 5159.7 3082.2 3176.2 3278.2 3287.3 3301.7 995.3 1017.7 1021.9 1026.3 1027.8 11291.7 11293.9 11327.4 11344.8 11345.4 4396.3 4424.5 4435.9 4458.8 4526.4 9514.5 9537.5 9574.9 9579.1 9584.0 4934.6 4945.8 4958.4 4970.3 4970.8 4142.6 4579.1 4702.2 4706.2 4782.4 3822.1 3880.7 3920.1 3954.8 3982.1 1210.8 1224.8 1238.5 1243.2 1248.4 980.1 984.5 984.9 985.7 995.4 5557.8 5684.0 5692.1 5694.2 5732.9 427.3 431.0 432.6 437.7 987.8 3990.0 4060.8 4063.8 4115.7 4151.9 10438.9 10689.6 10698.9 10721.6 10756.7 10652.1 10656.0 10664.1 10676.7 10686.6 7400.7 7720.8 7729.0 7903.6 7906.0 5647.7 5906.6 5907.2 5985.9 5990.0 9595.4 9654.0 9755.1 9756.9 9769.9 9351.6 9546.6 9811.6 9818.9 9825.8 6827.4 7235.3 7434.3 7679.2 7846.0 8201.1 8206.3 8239.8 8280.0 8283.5 7410.7 7544.5 7625.9 7706.8 7726.1 7341.9 7393.7 7415.8 7481.1 7581.6 6406.6 6456.5 6489.7 6490.6 6490.9 4989.2 5052.0 5072.9 5228.0 5231.2 5134.0 5179.3 5248.0 5326.2 5329.2 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#4] prototype.html Cycles:180 Average:4514.45 Median:5066.92 stddev:1308.47 (25.8%) stddev-sans-first:1273.98 16:50:09 INFO - PROCESS | 21985 | Values: 334.5 335.7 343.5 345.6 348.5 5281.4 5284.8 5370.3 5371.8 5412.4 5257.7 5298.5 5298.9 5303.5 5311.4 3836.8 3909.8 3974.6 4043.6 4168.7 4154.6 4156.8 4164.8 4165.5 4171.4 4171.4 4171.6 4184.8 4190.5 4200.9 3925.9 4106.2 4158.7 4187.2 4208.4 3711.4 3714.2 3731.9 3737.8 3742.9 5133.6 5204.8 5212.2 5212.4 5213.7 4457.6 4718.7 4720.6 4762.7 4773.2 5455.4 5505.7 5517.3 5527.7 5538.4 3985.8 3993.7 4008.5 4014.2 4016.7 5495.3 5749.0 5760.3 5812.8 5821.8 3960.4 3984.7 4008.8 4058.1 4063.6 4072.3 4073.4 4083.3 4083.5 4086.7 4545.7 4625.2 4649.5 4652.9 4714.2 5556.9 5563.7 5597.7 5610.8 5625.9 1411.8 1424.9 1425.3 1428.3 1438.6 888.2 913.7 916.4 926.5 932.0 4741.5 4749.6 4805.3 4828.0 4859.6 5044.3 5046.3 5070.3 5165.7 5170.6 4695.9 4896.5 4915.0 4915.8 4916.5 2667.9 2697.7 2717.6 2763.1 2768.7 5161.6 5261.8 5265.9 5283.7 5287.0 4799.9 5123.9 5176.0 5243.3 5254.2 5176.0 5181.8 5185.6 5206.2 5292.9 5061.9 5063.5 5140.9 5146.9 5150.3 4733.9 4976.3 5014.4 5015.8 5024.4 5167.3 5172.8 5199.4 5217.4 5224.0 3704.5 3728.7 3734.8 3736.3 3739.2 5055.8 5081.9 5426.3 5821.8 5837.2 5649.4 5665.6 5685.2 5687.7 5693.3 5460.5 5648.7 5650.8 5653.0 5661.9 5567.7 5584.8 5591.2 5593.6 5598.8 5661.6 5690.3 5700.9 5708.3 5710.2 5323.5 5523.8 5529.5 5547.3 5578.2 16:50:09 INFO - PROCESS | 21985 | 16:50:09 INFO - PROCESS | 21985 | [#5] yui.html Cycles:180 Average:21985.37 Median:4734.16 stddev:33270.86 (702.8%) stddev-sans-first:33325.75 16:50:09 INFO - PROCESS | 21985 | Values: 684.4 687.8 719.6 801.4 806.9 14658.6 15398.8 15437.0 16349.4 16365.5 14380.4 14446.4 14556.9 14566.6 14574.6 674.3 783.8 815.7 820.4 830.4 812.1 815.4 816.0 816.3 818.7 843.9 845.1 845.8 846.0 846.2 700.4 836.1 837.1 868.0 868.7 634.3 634.9 635.4 636.0 636.1 15247.2 15247.3 15289.9 15312.5 15316.6 13807.6 13841.3 14143.7 14183.5 14187.3 11852.8 11973.9 12091.1 12255.7 12440.4 4501.8 4516.9 4522.2 4543.8 4658.8 66005.7 70424.3 71669.6 71729.0 71903.6 10953.2 11324.1 11779.6 12144.0 12511.3 20620.0 20877.9 20942.6 20950.2 20999.6 8452.1 8478.4 8490.7 8782.9 8921.6 4779.1 4835.9 4922.0 4986.2 5016.4 3296.6 3391.6 3392.2 3393.5 3400.5 492.0 553.8 591.5 596.9 598.6 559.2 578.8 679.9 691.9 736.0 9203.4 9319.4 9338.8 9520.5 9751.5 577.2 628.7 693.2 713.7 717.8 4383.2 4669.0 4689.2 4938.4 4988.9 126664.0 128652.0 129278.0 129762.0 130681.0 111718.0 113277.0 113311.4 113322.4 114277.0 97468.5 97770.5 99136.0 99377.5 101589.5 8993.2 9512.2 9553.1 9600.6 9719.1 54777.0 55349.4 55483.0 56435.7 57929.4 77083.6 80979.6 81357.6 83542.6 84118.0 12131.5 12310.8 12325.4 12476.8 12744.8 13558.9 13913.3 14035.4 14151.8 14875.3 13219.9 13233.1 13477.3 13539.6 14316.2 13177.0 13331.5 13433.0 13810.7 13925.7 11995.4 12386.0 12792.9 12884.4 13309.5 9256.6 9616.7 9627.5 10338.6 10538.9 10222.9 10392.4 10494.6 10629.6 10701.0 16:50:09 INFO - PROCESS | 21985 | -------- Summary: end -------- 16:50:09 INFO - PROCESS | 21985 | 16:50:10 INFO - TEST-INFO | 21985: exit 0 16:50:10 INFO - TEST-OK | dromaeo_css | took 1113579ms 16:50:10 INFO - TEST-START | kraken 16:50:10 INFO - operating with platform_type : linux_ 16:50:10 INFO - Initialising browser for kraken test... 16:50:10 INFO - TEST-INFO | started process 22166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpex2hgF/profile http://localhost:33390/getInfo.html) 16:50:14 INFO - PROCESS | 22166 | __metrics Screen width/height:1600/1200 16:50:14 INFO - PROCESS | 22166 | colorDepth:24 16:50:14 INFO - PROCESS | 22166 | Browser inner width/height: 1024/697 16:50:14 INFO - PROCESS | 22166 | __metrics 16:50:15 INFO - PROCESS | 22166 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:16 INFO - TEST-INFO | 22166: exit 0 16:50:16 INFO - Browser initialized. 16:50:16 INFO - Running cycle 1/1 for kraken test... 16:50:16 INFO - TEST-INFO | started process 22250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpex2hgF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:28 INFO - PROCESS | 22250 | RSS: Main: 157339648 16:50:28 INFO - PROCESS | 22250 | 16:50:30 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33390/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:31 INFO - PROCESS | 22250 | RSS: Main: 215126016 16:50:31 INFO - PROCESS | 22250 | 16:50:34 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33390/tests/kraken/driver.html?testName=audio-dft) 16:50:35 INFO - PROCESS | 22250 | RSS: Main: 203440128 16:50:35 INFO - PROCESS | 22250 | 16:50:38 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33390/tests/kraken/driver.html?testName=audio-fft) 16:50:38 INFO - PROCESS | 22250 | RSS: Main: 268472320 16:50:38 INFO - PROCESS | 22250 | 16:50:40 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33390/tests/kraken/driver.html?testName=audio-oscillator) 16:50:41 INFO - PROCESS | 22250 | RSS: Main: 179453952 16:50:41 INFO - PROCESS | 22250 | 16:50:43 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:44 INFO - PROCESS | 22250 | RSS: Main: 184578048 16:50:44 INFO - PROCESS | 22250 | 16:50:47 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33390/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:47 INFO - PROCESS | 22250 | RSS: Main: 220700672 16:50:47 INFO - PROCESS | 22250 | 16:50:51 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33390/tests/kraken/driver.html?testName=imaging-desaturate) 16:50:51 INFO - PROCESS | 22250 | RSS: Main: 220741632 16:50:51 INFO - PROCESS | 22250 | 16:50:54 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33390/tests/kraken/driver.html?testName=json-parse-financial) 16:50:55 INFO - PROCESS | 22250 | RSS: Main: 220213248 16:50:55 INFO - PROCESS | 22250 | 16:50:56 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:50:57 INFO - PROCESS | 22250 | RSS: Main: 207593472 16:50:57 INFO - PROCESS | 22250 | 16:50:59 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:59 INFO - PROCESS | 22250 | RSS: Main: 211910656 16:50:59 INFO - PROCESS | 22250 | 16:51:01 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:02 INFO - PROCESS | 22250 | RSS: Main: 218423296 16:51:02 INFO - PROCESS | 22250 | 16:51:05 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:05 INFO - PROCESS | 22250 | RSS: Main: 235237376 16:51:05 INFO - PROCESS | 22250 | 16:51:08 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:09 INFO - PROCESS | 22250 | RSS: Main: 228347904 16:51:09 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | Cycle 1(1): loaded http://localhost:33390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33390/tests/kraken/driver.html?testName=ai-astar) 16:51:10 INFO - PROCESS | 22250 | RSS: Main: 270901248 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | __start_tp_report 16:51:10 INFO - PROCESS | 22250 | _x_x_mozilla_page_load 16:51:10 INFO - PROCESS | 22250 | _x_x_mozilla_page_load_details 16:51:10 INFO - PROCESS | 22250 | |i|pagename|runs| 16:51:10 INFO - PROCESS | 22250 | |0;ai-astar;103;113;110;111;113;113;110;111;110;109 16:51:10 INFO - PROCESS | 22250 | |1;audio-beat-detection;158;126;137;190;128;126;155;132;164;132 16:51:10 INFO - PROCESS | 22250 | |2;audio-dft;162;161;161;161;162;161;161;162;163;162 16:51:10 INFO - PROCESS | 22250 | |3;audio-fft;74;75;80;124;75;76;76;74;98;75 16:51:10 INFO - PROCESS | 22250 | |4;audio-oscillator;85;85;115;84;85;85;115;84;86;127 16:51:10 INFO - PROCESS | 22250 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 16:51:10 INFO - PROCESS | 22250 | |6;imaging-darkroom;146;146;147;148;149;146;146;146;147;148 16:51:10 INFO - PROCESS | 22250 | |7;imaging-desaturate;94;95;95;97;95;95;95;94;95;94 16:51:10 INFO - PROCESS | 22250 | |8;json-parse-financial;54;54;56;53;54;53;55;54;53;53 16:51:10 INFO - PROCESS | 22250 | |9;json-stringify-tinderbox;62;62;62;62;62;63;62;61;62;62 16:51:10 INFO - PROCESS | 22250 | |10;stanford-crypto-aes;80;79;78;79;80;80;79;82;133;83 16:51:10 INFO - PROCESS | 22250 | |11;stanford-crypto-ccm;138;122;126;134;118;119;119;121;122;122 16:51:10 INFO - PROCESS | 22250 | |12;stanford-crypto-pbkdf2;158;169;160;157;159;159;162;164;157;160 16:51:10 INFO - PROCESS | 22250 | |13;stanford-crypto-sha256-iterative;65;62;63;63;63;62;63;66;63;67 16:51:10 INFO - PROCESS | 22250 | __end_tp_report 16:51:10 INFO - PROCESS | 22250 | __start_cc_report 16:51:10 INFO - PROCESS | 22250 | _x_x_mozilla_cycle_collect,1660 16:51:10 INFO - PROCESS | 22250 | __end_cc_report 16:51:10 INFO - PROCESS | 22250 | __startTimestamp1467071470947__endTimestamp 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | ------- Summary: start ------- 16:51:10 INFO - PROCESS | 22250 | Number of tests: 14 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.95 (2.7%) stddev-sans-first:1.54 16:51:10 INFO - PROCESS | 22250 | Values: 103.0 113.0 110.0 111.0 113.0 113.0 110.0 111.0 110.0 109.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:146.00 stddev:21.26 (14.6%) stddev-sans-first:22.01 16:51:10 INFO - PROCESS | 22250 | Values: 158.0 126.0 137.0 190.0 128.0 126.0 155.0 132.0 164.0 132.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 16:51:10 INFO - PROCESS | 22250 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 163.0 162.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:16.21 (21.5%) stddev-sans-first:16.89 16:51:10 INFO - PROCESS | 22250 | Values: 74.0 75.0 80.0 124.0 75.0 76.0 76.0 74.0 98.0 75.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.82 (19.8%) stddev-sans-first:17.44 16:51:10 INFO - PROCESS | 22250 | Values: 85.0 85.0 115.0 84.0 85.0 85.0 115.0 84.0 86.0 127.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:51:10 INFO - PROCESS | 22250 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 16:51:10 INFO - PROCESS | 22250 | Values: 146.0 146.0 147.0 148.0 149.0 146.0 146.0 146.0 147.0 148.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 16:51:10 INFO - PROCESS | 22250 | Values: 94.0 95.0 95.0 97.0 95.0 95.0 95.0 94.0 95.0 94.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 16:51:10 INFO - PROCESS | 22250 | Values: 54.0 54.0 56.0 53.0 54.0 53.0 55.0 54.0 53.0 53.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 16:51:10 INFO - PROCESS | 22250 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 62.0 61.0 62.0 62.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:80.00 stddev:16.83 (21.0%) stddev-sans-first:17.74 16:51:10 INFO - PROCESS | 22250 | Values: 80.0 79.0 78.0 79.0 80.0 80.0 79.0 82.0 133.0 83.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:122.00 stddev:6.72 (5.5%) stddev-sans-first:4.90 16:51:10 INFO - PROCESS | 22250 | Values: 138.0 122.0 126.0 134.0 118.0 119.0 119.0 121.0 122.0 122.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.00 stddev:3.69 (2.3%) stddev-sans-first:3.80 16:51:10 INFO - PROCESS | 22250 | Values: 158.0 169.0 160.0 157.0 159.0 159.0 162.0 164.0 157.0 160.0 16:51:10 INFO - PROCESS | 22250 | 16:51:10 INFO - PROCESS | 22250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.74 16:51:10 INFO - PROCESS | 22250 | Values: 65.0 62.0 63.0 63.0 63.0 62.0 63.0 66.0 63.0 67.0 16:51:10 INFO - PROCESS | 22250 | -------- Summary: end -------- 16:51:10 INFO - PROCESS | 22250 | 16:51:11 INFO - TEST-INFO | 22250: exit 0 16:51:11 INFO - TEST-OK | kraken | took 61739ms 16:51:11 INFO - SUITE-END | took 1175s 16:51:12 INFO - Completed test suite (00:19:35) 16:51:12 INFO - javascript benchmark 16:51:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.235441139715, 3065.9233519162003, 3086.2747254395213, 3098.70562296582, 3132.8746850125995, 5211.973940130299, 5220.190870415082, 5265.420803711589, 5286.9735651321735, 5294.444083371243, 5228.503292187245, 5240.711760853152, 5268.209768534722, 5303.0, 5351.491608297215, 4729.432468103832, 4785.952140478603, 4822.300766388889, 4834.419869615651, 5015.724135172564, 4908.631852611051, 4914.729689867074, 4932.136876046696, 4976.129177393942, 5005.199168133099, 4722.716637001774, 4781.665283430161, 4798.952010479886, 4804.543568361, 4829.855104346875, 4808.014357056795, 4812.278158276252, 4879.902401951941, 4880.2435622478215, 4925.408950925876, 4716.38686970695, 4839.879003024953, 4848.951510484885, 4867.586255168315, 4895.31465594817, 5221.634485586011, 5270.710110943896, 5307.681539107666, 5372.946270537323, 5386.272853164812, 5688.60179787415, 5691.971540142315, 5713.371529131792, 5729.427057294279, 5737.39757325479, 5533.612647114704, 5561.4716601923155, 5731.398203188689, 5772.105323674838, 5775.5668324875805, 5190.169572868323, 5285.550728188147, 5287.339082614673, 5289.233061206142, 5289.841304760864, 5757.65454072757, 5785.103308987113, 5788.102844059177, 5793.304803423532, 5801.82594522165, 5412.458754124635, 5443.374011988672, 5492.148716948799, 5542.861428464321, 5544.251526044013, 5634.1830434586755, 5640.548756099584, 5648.774049037993, 5652.717364131777, 5653.604247702621, 5568.916466253009, 5569.526590239875, 5570.359408667974, 5571.4150014248735, 5572.749226284827, 5445.128779395278, 5558.082916318762, 5578.860528486739, 5616.887662246814, 5631.577631677641, 4333.349997500401, 4354.172707185625, 4357.2592659248, 4364.956350436519, 4386.210482113251, 3874.9418758718643, 3881.880077099681, 3893.902652433712, 3924.156306394139, 3943.861964831217, 5176.482351764794, 5227.059129356752, 5309.46905309466, 5367.275417818622, 5371.3822910365025, 5703.828885133453, 5712.485876271156, 5720.713964301768, 5722.141678748221, 5761.740721667451, 5356.5179133877355, 5377.784888604412, 5388.784448622089, 5394.352677678625, 5408.5402740766685, 4799.544043315879, 4879.658423910292, 4906.411230652345, 4908.533689299511, 4954.256861470808, 5897.262842144732, 5899.528037756969, 5899.793507227227, 5906.8818623627285, 5916.112583112567, 5566.749496272597, 5687.857803554944, 5704.743286552032, 5706.9714651426475, 5708.714564271687, 5826.592138550261, 5857.882842343214, 5861.7655293787775, 5933.762649493972, 5938.703064846827, 5627.0, 5627.915581266366, 5628.634138780966, 5632.098864181711, 5636.4927156556105, 5555.472230138131, 5662.886742265049, 5741.569382296261, 5741.971290143522, 5747.453991870766, 5540.69526176048, 5615.831525054255, 5623.3533143689, 5667.943320566742, 5669.971650141888, 5580.860478487908, 5587.5809314302405, 5588.441155884379, 5593.496585307342, 5598.272224610774, 5319.760610772447, 5435.945640543544, 5463.508284254436, 5510.3938566758425, 5575.804846830341, 5580.720963951705, 5688.857778555569, 5689.487946084707, 5690.089585666274, 5691.77232910679, 5470.562355011669, 5519.0, 5520.613557051129, 5524.14375771756, 5525.640833345819], "value": 5236.353556327338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6065816232206, 607.3167686352853, 613.6870196199939, 630.7697690343025, 640.5932233032026, 32536.67463325366, 35409.11477213068, 46208.768956155174, 47245.527544724544, 47283.0, 44531.0, 44969.550304496945, 45216.54783452165, 45238.77380613101, 45320.77339613305, 8756.430831995916, 8962.955185224066, 8976.910230897705, 8979.551022448884, 8988.460692358447, 8530.530820804854, 8567.785805354853, 8587.141285871425, 8592.8711069334, 8614.698485553006, 8607.569621518931, 8750.6937257196, 8758.211760941515, 8763.386562940597, 8763.78090547735, 8657.95671021644, 8698.869516957251, 8700.651973921067, 8705.608247628872, 8706.259967902735, 8854.158854908774, 8924.241439477652, 8926.018138004814, 8926.821463570757, 8927.687530936386, 42720.0, 43170.784146079066, 43201.783991080156, 43229.567704323184, 43247.567524324986, 3356.8153751543655, 3890.3191941410423, 4140.937885931713, 4141.64795992338, 4243.8090285937205, 33073.83463082693, 33761.83119084389, 34372.312553749034, 35657.0, 35758.463623045674, 4368.453943257093, 4392.253316936129, 4453.309736990772, 4503.729776213438, 4665.160271151191, 365177.0, 367668.0, 369382.0, 369985.0, 370106.9999999973, 31022.534661980088, 31927.361452771278, 32037.0, 33562.16094597606, 61733.38266617366, 33623.15942101467, 34013.14967125842, 34018.14954626105, 34075.488867667, 34152.48771268433, 13963.650908727363, 14025.649358765908, 14049.0, 14068.577942661737, 14072.648183795487, 12660.240385576895, 12865.099443038898, 12875.549355772502, 12889.677758056123, 12985.220886746825, 7415.1101867776215, 7423.294786995227, 7459.365953893871, 7479.813004674927, 7492.737754178577, 2813.521701310782, 2823.280063583773, 2877.8848846046344, 2896.420715856837, 2922.7661787056986, 1025.220832167558, 1051.5898799468214, 1055.3984228989557, 1065.9307145035548, 1140.1505878120854, 31662.841685791424, 31882.840585797385, 32242.677573223966, 32277.51583726246, 32643.0, 1116.6929094498914, 1121.063911633795, 1126.378015657467, 1149.6780901347636, 1150.0339714639742, 15941.920290398473, 16439.506814795575, 16572.419965301397, 16583.253753581117, 16652.084135372428, 547260.0, 553100.0, 553125.0, 554135.0, 554259.0, 57696.13455798166, 58144.709276454196, 58222.41777582255, 58269.70865145647, 58283.70858145767, 1245.7882160032816, 1319.3732976835927, 1339.2901762066122, 1382.9446822127204, 1394.114737141902, 31960.520592191602, 31974.0, 32616.836915815267, 32859.17852053718, 33408.498872516444, 49975.75012124916, 50779.49220507748, 50846.745766270935, 50875.23687144622, 50978.49021509737, 406705.0, 412698.0, 414009.0, 415503.0, 416786.0, 22354.664680029487, 23208.535829283657, 23455.06179752791, 23458.178963736187, 23504.6474302889, 44494.3325850119, 45220.77389613031, 45228.32157517574, 45538.54461455343, 45995.0, 37851.81074094722, 38251.426228607146, 38945.41581876331, 39009.414858776574, 39092.413613795245, 38687.41968870413, 38732.2253554933, 39022.978757370656, 39150.6084939147, 39151.0, 37604.81197594104, 38460.80769596246, 38936.52229993474, 39004.0, 39010.80494597509, 32766.508502372006, 33313.333733325686, 33793.324133517686, 34088.82955585206, 34491.31017379588, 25847.353816153995, 25938.22185334443, 26240.8687956559, 26331.736682632927, 26543.33641658974], "value": 18323.75774258956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7114193213157, 387.8254785346594, 395.95446523649787, 403.27611936573845, 414.9356849688298, 17876.19557119931, 18995.52511187221, 19531.21875124995, 19587.5103122422, 20659.0, 18904.77118987265, 19009.334673286437, 19049.42851714447, 19353.0, 19419.611607767834, 5539.861503462405, 5577.944220557783, 5777.393373695764, 5793.217915581385, 5797.36229014808, 5693.373728889819, 5697.287839020122, 5700.686462244575, 5714.628549144292, 5717.256756621633, 5459.12653975364, 5647.09646456567, 5649.435056494338, 5652.886942261173, 5674.432556744313, 5663.0, 5672.631278966875, 5684.459976302244, 5685.800996965107, 5686.09022556389, 4881.951180488185, 5131.794728210867, 5131.87170320745, 5135.845924622267, 5135.897282054338, 22431.32706018822, 22474.43813904649, 22504.32487025392, 22919.0, 22940.082396704278, 2360.8937597807967, 2493.638422428756, 2568.203856804378, 2606.9478610427873, 2975.1669532530927, 13739.175649461064, 14107.858921410758, 14403.78394324086, 14837.743186801177, 14943.925280373638, 1929.807019298073, 1932.884026958387, 1943.3101249056665, 1988.2444671025062, 2001.5596568754995, 73237.26762732358, 74111.62944185245, 76113.0, 76990.6150469244, 78286.60856695737, 9333.160015598492, 9497.952510237543, 9949.104580587782, 10038.196944244442, 10178.18574514037, 13063.542776002794, 13149.342532873317, 13159.868401316056, 13175.67060823487, 13199.67000824987, 8159.714409995621, 8190.959045204736, 8252.587370631445, 8271.875921861178, 8371.874421883676, 7644.961775191088, 7785.64964576584, 7794.064712234568, 7950.920490795133, 8477.27943124829, 6150.354212807591, 6283.905741413882, 6285.685715714196, 6389.552731308764, 6403.871922561522, 1744.4504980930967, 1766.646670665872, 1783.5184500184878, 1786.5444311700433, 1815.2376002079159, 902.5351943748974, 1011.7369483934083, 1015.1270905179931, 1016.9203977865283, 1086.2999405929852, 19240.903795480932, 19393.90303048476, 19450.805491945182, 19585.216591336186, 19683.704744428844, 936.8922573904089, 994.1748348870565, 1019.169376957777, 1041.354360296621, 1084.5878566144972, 10563.154947604173, 10634.735551768432, 10990.340579565252, 11061.557537698402, 11088.778224435466, 472095.0, 485422.0, 487375.0, 489169.0, 490268.0, 75514.24485755182, 75677.0, 75801.62099189579, 77625.0, 78889.21110788934, 1039.6984874386494, 1042.6715584590677, 1045.8378951262566, 1072.7103682005816, 1073.1682945716975, 17581.648367032845, 17642.735358969883, 17836.0, 17844.91077544604, 18164.636707266043, 36734.44898326474, 37759.244815103, 38347.2330553393, 38827.41758873676, 39085.02287442837, 51117.23324150215, 54341.0, 59212.70393648177, 60746.392536074076, 60765.0, 7756.689732410866, 8058.556779377191, 8150.510969341858, 8182.304504116979, 8263.421560490948, 8838.823223535364, 11278.0, 11522.827157592475, 12202.938985305016, 12436.813447798471, 10949.343039417661, 10989.780204396027, 11246.493907774333, 11251.606193783178, 11338.206325557132, 11149.23666020177, 11197.328160310408, 11290.209685321948, 11310.773784524428, 11325.32048077118, 11121.27711698737, 11340.319580825177, 11485.712857178638, 11531.596394126165, 11592.0, 8439.28266097364, 8512.40413171072, 8529.872051919103, 8637.438566493158, 8660.523671197892, 8728.432651877607, 10005.299629025898, 10750.784984300426, 10869.619563315246, 11415.885841141482], "value": 9112.796386516418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.8561358250586, 1435.2034620785466, 1466.3035058347284, 1566.4752307976828, 1708.9401870934519, 8045.637946292416, 8445.028821685508, 8452.028016778064, 8709.303255739542, 8711.0417854036, 8081.272685458308, 8280.792980175484, 8285.378596605264, 8286.91713082869, 8288.627011784469, 1962.2935743132462, 2260.9095636174616, 2305.9077636894544, 2331.440454290975, 2349.236498138112, 2317.2584772872688, 2324.8023917966993, 2326.5463234669246, 2327.0575416956076, 2328.2665960222475, 2229.2197730794173, 2238.473958619723, 2275.5335156293004, 2275.7951784339407, 2279.361778701966, 1769.973450398245, 2142.046789178816, 2202.592520383734, 2203.7796220377836, 2227.4208705736464, 1906.08507916201, 1918.1847714721187, 1921.8846869187894, 1925.8170473804967, 1927.633749587574, 8644.870326945038, 8703.129687031309, 8705.608247628808, 8710.651573937035, 8741.0, 4979.377577802775, 5151.536361727425, 5151.819686310999, 5155.664881782672, 5159.664621799571, 3082.152408087771, 3176.1900715317447, 3278.229616040229, 3287.309664970359, 3301.6533264007176, 995.3032876986139, 1017.6590842067842, 1021.933574317667, 1026.2703435580984, 1027.825269704152, 11291.661250162508, 11293.887061129366, 11327.433628318551, 11344.773104537946, 11345.37600431976, 4396.252637051709, 4424.46906371231, 4435.933460998088, 4458.7547684877645, 4526.388937493462, 9514.476703781358, 9537.523123843781, 9574.904250957541, 9579.13787759091, 9583.952080239555, 4934.605231581537, 4945.752712364368, 4958.429780575208, 4970.304157417964, 4970.776315065831, 4142.565030671736, 4579.084183163381, 4702.247640377524, 4706.247000479907, 4782.378290822171, 3822.0635944193295, 3880.708946828999, 3920.1179734559496, 3954.762714237155, 3982.064214909494, 1210.8002179640262, 1224.8224007518859, 1238.5169783784331, 1243.2043492165021, 1248.431963456625, 980.1472718734747, 984.5077461269366, 984.8916619171886, 985.6599473181741, 995.4375777685584, 5557.833265002057, 5684.0, 5692.1461780733225, 5694.174344719992, 5732.914006289909, 427.26510402108323, 431.0473852785317, 432.6236174528118, 437.656439694838, 987.7579992901785, 3990.0, 4060.7969601520394, 4063.79681015948, 4115.691323150776, 4151.896202594899, 10438.895611043792, 10689.625863094754, 10698.893011069946, 10721.571137154582, 10756.677299681021, 10652.094571961316, 10656.0, 10664.146868250522, 10676.733081672865, 10686.625968091235, 7400.666969986363, 7720.7683769487, 7728.961355193188, 7903.644336004893, 7905.960470197612, 5647.7176141193595, 5906.586538942404, 5907.202527658883, 5985.880282394415, 5990.0, 9595.376300540442, 9653.951730241304, 9755.122039016522, 9756.902430975599, 9769.853452198366, 9351.5791789371, 9546.570404331684, 9811.55847986828, 9818.852717209105, 9825.754356140867, 6827.351401616838, 7235.3488186063505, 7434.3309102181065, 7679.193684663253, 7845.960770196112, 8201.09787923316, 8206.302464290602, 8239.794005149919, 8280.0, 8283.50298982063, 7410.6665200065045, 7544.47188696786, 7625.923740762521, 7706.7687969361, 7726.111497177896, 7341.853162936818, 7393.667284972082, 7415.777526674208, 7481.064866891638, 7581.6209189541405, 6406.615603063831, 6456.451201647913, 6489.675516224264, 6490.578112422678, 6490.935090649033, 4989.151844186425, 5052.0, 5072.949270507395, 5228.032813929435, 5231.241469986754, 5133.998870220271, 5179.300794392709, 5248.029114613809, 5326.174442961347, 5329.200619907045], "value": 4394.128443773103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.52664479761137, 335.6911641290013, 343.5448031358451, 345.5525095001973, 348.4755443058197, 5281.419043905167, 5284.762185701643, 5370.288004557703, 5371.838844834651, 5412.350517937848, 5257.737113144347, 5298.523132918037, 5298.894022119565, 5303.469653034705, 5311.3974152665205, 3836.808159592023, 3909.8436062557535, 3974.642282194602, 4043.6360727534516, 4168.6665066794585, 4154.646855017312, 4156.792160391983, 4164.750114993095, 4165.541790403068, 4171.416001759756, 4171.353440216756, 4171.624553790159, 4184.769837658928, 4190.506648544111, 4200.852970146046, 3925.9411108833247, 4106.178764247163, 4158.6673066154635, 4187.225363307798, 4208.3687446882905, 3711.406175011985, 3714.23858109087, 3731.869384571527, 3737.8131093445218, 3742.8689995850013, 5133.614978876599, 5204.843854684365, 5212.218167274901, 5212.384160910092, 5213.661112027706, 4457.576530229623, 4718.740469274188, 4720.598749106296, 4762.738049407281, 4773.164696178155, 5455.427180146107, 5505.6696598204235, 5517.282753242052, 5527.668339899619, 5538.424632545885, 3985.8206380712936, 3993.7204395692315, 4008.498937632796, 4014.2172276406113, 4016.6585840203616, 5495.313085864267, 5749.0, 5760.279965004374, 5812.825615231508, 5821.79623713168, 3960.386140148282, 3984.7210695251056, 4008.819603117867, 4058.1477889642915, 4063.593640635913, 4072.2873497137884, 4073.3889916512762, 4083.285425050664, 4083.530394004668, 4086.6730661547003, 4545.727256364563, 4625.190591646516, 4649.511801260886, 4652.930206046912, 4714.22215334466, 5556.888862222733, 5563.749631266603, 5597.74810133545, 5610.775568977277, 5625.943740562624, 1411.7600007998665, 1424.886009119268, 1425.337218193545, 1428.328685517805, 1438.6475313548037, 888.2403635224108, 913.7304495173939, 916.3539704508306, 926.5228407370209, 932.0, 4741.525847415231, 4749.57771536512, 4805.261001229266, 4827.975860120677, 4859.611231101574, 5044.2937988681615, 5046.34397528319, 5070.340855688737, 5165.715885626327, 5170.586353091744, 4695.906081878344, 4896.453844001171, 4914.950850491521, 4915.754212289443, 4916.483769204254, 2667.8932842686463, 2697.662792150981, 2717.6331195288776, 2763.115802943079, 2768.671037901818, 5161.638685292069, 5261.816091379409, 5265.894682106336, 5283.735813209324, 5287.012837746661, 4799.928001079987, 5123.897522049613, 5176.0, 5243.344581927259, 5254.185601231815, 5175.955497578436, 5181.844544663666, 5185.559227465632, 5206.214675148777, 5292.9470705294, 5061.949380506295, 5063.493650634907, 5140.922886156785, 5146.948530514647, 5150.304708864255, 4733.857984260478, 4976.30331753562, 5014.373203349582, 5015.824446144367, 5024.371953505812, 5167.302414174038, 5172.818951336685, 5199.440167949524, 5217.426083130928, 5223.973880130575, 3704.518412606344, 3728.7389882709035, 3734.79458629778, 3736.271427071695, 3739.1773809761808, 5055.823046193365, 5081.8729531762, 5426.321709786277, 5821.79623713168, 5837.182794408871, 5649.350324712711, 5665.603407761417, 5685.175649530877, 5687.720262940805, 5693.28833895763, 5460.515465463284, 5648.661080335193, 5650.802221922378, 5653.014624689667, 5661.858453538694, 5567.66594004361, 5584.804531841529, 5591.18927755465, 5593.608447408805, 5598.832035038955, 5661.556303142672, 5690.3456102548735, 5700.859828034327, 5708.343540492897, 5710.200571920018, 5323.494268044529, 5523.834284971457, 5529.502344788988, 5547.306586676666, 5578.219049333015], "value": 4104.158286235356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.411406190676, 687.790223981686, 719.5790462579391, 801.4109629422376, 806.8709006558952, 14658.560243192722, 15398.769018464718, 15436.996595221332, 16349.427770028036, 16365.509034728948, 14380.424783008668, 14446.422143114289, 14556.927215363934, 14566.635834104127, 14574.562763117097, 674.2616834566167, 783.8393129408486, 815.7308088330851, 820.3519219816338, 830.393812516863, 812.1472453923386, 815.3762371785589, 816.0248503038871, 816.338765599863, 818.6643476174739, 843.8945131858518, 845.1421806866036, 845.7927807687095, 845.9619317130744, 846.2172490446343, 700.3731660164176, 836.1304243586662, 837.1419295222385, 867.96528138875, 868.674247157316, 634.3244444666416, 634.8793729191485, 635.4058954877205, 635.9777407790751, 636.0586332228282, 15247.16140612266, 15247.313870875838, 15289.923550382287, 15312.540623781193, 15316.617084572863, 13807.585772426843, 13841.30793460323, 14143.71712565743, 14183.503577374742, 14187.290635468185, 11852.822207666892, 11973.94013029938, 12091.093168012434, 12255.69360765979, 12440.440180191914, 4501.819927202941, 4516.909661806778, 4522.208613492626, 4543.840965566189, 4658.813647454098, 66005.66997164984, 70424.29575704229, 71669.64165179193, 71729.0, 71903.64048179777, 10953.233273670767, 11324.094072474183, 11779.646610601696, 12144.0, 12511.311877846623, 20620.0, 20877.89561052185, 20942.581148376947, 20950.161993520393, 20999.580008399746, 8452.112528184574, 8478.44890082155, 8490.745277641681, 8782.91217087821, 8921.553922303989, 4779.115863565252, 4835.854924352275, 4921.975390123026, 4986.152354099811, 5016.44819069902, 3296.6373698893103, 3391.6269210386836, 3392.2197894484407, 3393.5079413484905, 3400.472926696366, 491.98524044278014, 553.8172403106965, 591.5326891755551, 596.931352894414, 598.5570677698558, 559.2254727202853, 578.8003138917067, 679.9426891184157, 691.8826095855158, 736.0274464435258, 9203.40177888435, 9319.394239374418, 9338.766530836783, 9520.523973801282, 9751.512424378752, 577.151587166864, 628.7327885648581, 693.1889689063808, 713.7252157919238, 717.7739012211136, 4383.232934236496, 4669.0, 4689.20283551797, 4938.407391113089, 4988.8752781180765, 126664.0, 128652.0, 129278.0, 129762.0, 130681.0, 111718.0, 113277.0, 113311.43344283226, 113322.43338783253, 114277.0, 97468.51265743768, 97770.51114744523, 99135.99999999856, 99377.50311248397, 101589.49205253927, 8993.235574975939, 9512.240235556168, 9553.092456216647, 9600.567974441306, 9719.125278724949, 54777.0, 55349.44650553604, 55483.0, 56435.71782141063, 57929.4207057924, 77083.61458192673, 80979.59510202648, 81357.59321203594, 83542.58228709061, 84118.0, 12131.514739410324, 12310.753784924073, 12325.383730813603, 12476.750464990831, 12744.757500272859, 13558.86441135576, 13913.304334783423, 14035.438582456587, 14151.787723184367, 14875.256237188314, 13219.867801321863, 13233.13984591037, 13477.25875076841, 13539.59381218565, 14316.212608306643, 13177.0, 13331.466741330238, 13432.992525560818, 13810.723785524435, 13925.651858703613, 11995.40022998864, 12386.0, 12792.936035319764, 12884.420201091161, 13309.46762129504, 9256.583453744732, 9616.663416780379, 9627.521960860271, 10338.586456541954, 10538.947305263731, 10222.897771022195, 10392.42841643717, 10494.632687855888, 10629.627963021258, 10701.0], "value": 7549.170721917341, "unit": "score"}], "name": "dromaeo_css", "value": 7013.8429298498695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 111.0, 113.0, 113.0, 110.0, 111.0, 110.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 137.0, 190.0, 128.0, 126.0, 155.0, 132.0, 164.0, 132.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 80.0, 124.0, 75.0, 76.0, 76.0, 74.0, 98.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 85.0, 85.0, 115.0, 84.0, 86.0, 127.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 149.0, 146.0, 146.0, 146.0, 147.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 53.0, 54.0, 53.0, 55.0, 54.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 80.0, 80.0, 79.0, 82.0, 133.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 122.0, 126.0, 134.0, 118.0, 119.0, 119.0, 121.0, 122.0, 122.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 169.0, 160.0, 157.0, 159.0, 159.0, 162.0, 164.0, 157.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 66.0, 63.0, 67.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1502.6, "alertThreshold": 2.0}]} 16:51:12 INFO - Return code: 0 16:51:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:12 INFO - # TBPL SUCCESS # 16:51:12 INFO - Running post-action listener: _resource_record_post_action 16:51:12 INFO - ##### 16:51:12 INFO - ##### Finished run-tests step (success) 16:51:12 INFO - ##### 16:51:12 INFO - Running post-run listener: _resource_record_post_run 16:51:12 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 552366080; Read time: 0; Write time: 531168 16:51:12 INFO - TinderboxPrint: CPU usage
13.2% 16:51:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:51:12 INFO - TinderboxPrint: I/O write bytes / time
552,366,080 / 531,168 16:51:12 INFO - TinderboxPrint: CPU idle
8,272.9 (86.8%) 16:51:12 INFO - TinderboxPrint: CPU user
1,208.9 (12.7%) 16:51:12 INFO - TinderboxPrint: Swap in / out
0 / 0 16:51:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256774144; Read time: 0; Write time: 238212 16:51:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 295485440; Read time: 0; Write time: 292936 16:51:12 INFO - Running post-run listener: _upload_blobber_files 16:51:12 INFO - Blob upload gear active. 16:51:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:12 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 16:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:51:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:14 INFO - (blobuploader) - INFO - Done attempting. 16:51:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:17 INFO - (blobuploader) - INFO - Done attempting. 16:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:18 INFO - (blobuploader) - INFO - Done attempting. 16:51:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:18 INFO - Return code: 0 16:51:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e95292478395bb59af3db04ba2a371117d6e0b8d09eddf8fe465e9102e7c1ddc7401363815738407bf9134e25d94a92d94085203008d442130a54cea5ac66883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/957778c114cb3bfbc5e5966111c8084a905e248e3783dd8669cfb7777dfac6b9cb55e9281ae1744f1e4191fca760a9af075d5c9516d4efddd282e9dd466beec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0776ee7a23b68f012a3124afa6f8cd0b9accd5d4e81f12c04c5224c2c76d0a21b056a2a80c1087205ebb0c1ab345fcd9d85657d1b8bc71af13a2ec6439930c9d"} 16:51:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:18 INFO - Contents: 16:51:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e95292478395bb59af3db04ba2a371117d6e0b8d09eddf8fe465e9102e7c1ddc7401363815738407bf9134e25d94a92d94085203008d442130a54cea5ac66883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/957778c114cb3bfbc5e5966111c8084a905e248e3783dd8669cfb7777dfac6b9cb55e9281ae1744f1e4191fca760a9af075d5c9516d4efddd282e9dd466beec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0776ee7a23b68f012a3124afa6f8cd0b9accd5d4e81f12c04c5224c2c76d0a21b056a2a80c1087205ebb0c1ab345fcd9d85657d1b8bc71af13a2ec6439930c9d"} 16:51:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:18 INFO - Copying logs to upload dir... 16:51:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.580845 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 16:51:17.943169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:51:17.946671) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e95292478395bb59af3db04ba2a371117d6e0b8d09eddf8fe465e9102e7c1ddc7401363815738407bf9134e25d94a92d94085203008d442130a54cea5ac66883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/957778c114cb3bfbc5e5966111c8084a905e248e3783dd8669cfb7777dfac6b9cb55e9281ae1744f1e4191fca760a9af075d5c9516d4efddd282e9dd466beec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0776ee7a23b68f012a3124afa6f8cd0b9accd5d4e81f12c04c5224c2c76d0a21b056a2a80c1087205ebb0c1ab345fcd9d85657d1b8bc71af13a2ec6439930c9d"} build_url:https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e95292478395bb59af3db04ba2a371117d6e0b8d09eddf8fe465e9102e7c1ddc7401363815738407bf9134e25d94a92d94085203008d442130a54cea5ac66883", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/957778c114cb3bfbc5e5966111c8084a905e248e3783dd8669cfb7777dfac6b9cb55e9281ae1744f1e4191fca760a9af075d5c9516d4efddd282e9dd466beec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0776ee7a23b68f012a3124afa6f8cd0b9accd5d4e81f12c04c5224c2c76d0a21b056a2a80c1087205ebb0c1ab345fcd9d85657d1b8bc71af13a2ec6439930c9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:51:17.975662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:51:17.976179) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467070241.13230-1788394039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:51:18.057125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:51:18.057464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:51:18.057756) ========= ========= Total master_lag: 0.17 =========