builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1465492332.67 results: success (0) buildid: 20160609073122 builduid: 294152786a8a4072bece211b666b7117 revision: 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.671113) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.671591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.671867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.686370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.686741) ========= 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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 10:12:12-- 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% 226M=0s 2016-06-09 10:12:12 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.806655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.806967) ========= 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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:12.856015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 10:12:12.856407) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 --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 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 --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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 10:12:13,008 truncating revision to first 12 chars 2016-06-09 10:12:13,008 Setting DEBUG logging. 2016-06-09 10:12:13,008 attempt 1/10 2016-06-09 10:12:13,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0ace95ea7f4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 10:12:13,899 unpacking tar archive at: mozilla-inbound-0ace95ea7f4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.219112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 10:12:14.088871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:14.089203) ========= script_repo_revision: 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:14.089628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:14.089904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 10:12:14.105686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 10:12:14.106078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:14 INFO - MultiFileLogger online at 20160609 10:12:14 in /builds/slave/test 10:12:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:12:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:14 INFO - {'append_to_log': False, 10:12:14 INFO - 'base_work_dir': '/builds/slave/test', 10:12:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:12:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:14 INFO - 'branch': 'Mozilla-Inbound', 10:12:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:14 INFO - 'config_files': ('talos/linux_config.py',), 10:12:14 INFO - 'default_actions': ('clobber', 10:12:14 INFO - 'read-buildbot-config', 10:12:14 INFO - 'download-and-extract', 10:12:14 INFO - 'populate-webroot', 10:12:14 INFO - 'create-virtualenv', 10:12:14 INFO - 'install', 10:12:14 INFO - 'run-tests'), 10:12:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:14 INFO - 'download_minidump_stackwalk': True, 10:12:14 INFO - 'download_symbols': 'ondemand', 10:12:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:14 INFO - 'installer_path': 'installer.exe', 10:12:14 INFO - 'log_level': 'info', 10:12:14 INFO - 'log_name': 'talos', 10:12:14 INFO - 'log_to_console': True, 10:12:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:14 INFO - 'opt_config_files': (), 10:12:14 INFO - 'pip_index': False, 10:12:14 INFO - 'sps_profile': False, 10:12:14 INFO - 'sps_profile_interval': 0, 10:12:14 INFO - 'suite': 'dromaeojs-e10s', 10:12:14 INFO - 'system_bits': '32', 10:12:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:14 INFO - 'title': 'talos-linux64-ix-018', 10:12:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:14 INFO - 'use_talos_json': True, 10:12:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:14 INFO - 'work_dir': 'build'} 10:12:14 INFO - ##### 10:12:14 INFO - ##### Running clobber step. 10:12:14 INFO - ##### 10:12:14 INFO - Running pre-action listener: _resource_record_pre_action 10:12:14 INFO - Running main action method: clobber 10:12:14 INFO - rmtree: /builds/slave/test/build 10:12:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:14 INFO - Running post-action listener: _resource_record_post_action 10:12:14 INFO - ##### 10:12:14 INFO - ##### Finished clobber step (success) 10:12:14 INFO - ##### 10:12:14 INFO - ##### 10:12:14 INFO - ##### Running read-buildbot-config step. 10:12:14 INFO - ##### 10:12:14 INFO - Running pre-action listener: _resource_record_pre_action 10:12:14 INFO - Running main action method: read_buildbot_config 10:12:14 INFO - Using buildbot properties: 10:12:14 INFO - { 10:12:14 INFO - "project": "", 10:12:14 INFO - "product": "firefox", 10:12:14 INFO - "script_repo_revision": "production", 10:12:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:12:14 INFO - "repository": "", 10:12:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:12:14 INFO - "buildid": "20160609073122", 10:12:14 INFO - "pgo_build": "True", 10:12:14 INFO - "basedir": "/builds/slave/test", 10:12:14 INFO - "buildnumber": 843, 10:12:14 INFO - "slavename": "talos-linux64-ix-018", 10:12:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:12:14 INFO - "platform": "ubuntu64_hw", 10:12:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:12:14 INFO - "branch": "mozilla-inbound", 10:12:14 INFO - "repo_path": "integration/mozilla-inbound", 10:12:14 INFO - "revision": "0ace95ea7f4cb6366e19a3a4e9e8626637f74028", 10:12:14 INFO - "stage_platform": "linux64-pgo", 10:12:14 INFO - "builduid": "294152786a8a4072bece211b666b7117", 10:12:14 INFO - "slavebuilddir": "test" 10:12:14 INFO - } 10:12:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:12:14 INFO - Running post-action listener: _resource_record_post_action 10:12:14 INFO - ##### 10:12:14 INFO - ##### Finished read-buildbot-config step (success) 10:12:14 INFO - ##### 10:12:14 INFO - ##### 10:12:14 INFO - ##### Running download-and-extract step. 10:12:14 INFO - ##### 10:12:14 INFO - Running pre-action listener: _resource_record_pre_action 10:12:14 INFO - Running main action method: download_and_extract 10:12:14 INFO - mkdir: /builds/slave/test/build/tests 10:12: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')]} 10:12:14 INFO - https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:15 INFO - Downloaded 1361 bytes. 10:12:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:12:15 INFO - Using the following test package requirements: 10:12:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:12:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:12:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'jsshell-linux-x86_64.zip'], 10:12:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:12:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:12:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:12:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:12:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:12:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:12:15 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')]} 10:12:15 INFO - https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:16 INFO - Downloaded 24452310 bytes. 10:12:16 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'] 10:12:16 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 10:12:17 INFO - Return code: 0 10:12:17 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 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:19 INFO - Downloaded 24452310 bytes. 10:12:19 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'] 10:12:19 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 10:12:20 INFO - Return code: 0 10:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:20 INFO - https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:22 INFO - Downloaded 10833377 bytes. 10:12:22 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'] 10:12:22 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 10:12:22 INFO - Return code: 0 10:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:22 INFO - https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/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 10:12:23 INFO - Downloaded 59344037 bytes. 10:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:23 INFO - mkdir: /builds/slave/test/properties 10:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:23 INFO - Contents: 10:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:24 INFO - Running post-action listener: _resource_record_post_action 10:12:24 INFO - Running post-action listener: set_extra_try_arguments 10:12:24 INFO - ##### 10:12:24 INFO - ##### Finished download-and-extract step (success) 10:12:24 INFO - ##### 10:12:24 INFO - ##### 10:12:24 INFO - ##### Running populate-webroot step. 10:12:24 INFO - ##### 10:12:24 INFO - Running pre-action listener: _resource_record_pre_action 10:12:24 INFO - Running main action method: populate_webroot 10:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:24 INFO - '--tppagecycles', 10:12:24 INFO - '7'], 10:12:24 INFO - 'tests': ['tsvgm']}}, 10:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['damp', 'tps']}, 10:12:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'tests': ['damp', 'tps']}, 10:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['dromaeo_dom']}, 10:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['a11yr', 10:12:24 INFO - 'ts_paint', 10:12:24 INFO - 'tpaint', 10:12:24 INFO - 'sessionrestore', 10:12:24 INFO - 'sessionrestore_no_auto_restore', 10:12:24 INFO - 'tabpaint']}, 10:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['tsvgx', 10:12:24 INFO - 'tsvgr_opacity', 10:12:24 INFO - 'tart', 10:12:24 INFO - 'tscrollx', 10:12:24 INFO - 'cart']}, 10:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:24 INFO - 'tsvgr_opacity', 10:12:24 INFO - 'tart', 10:12:24 INFO - 'tscrollx', 10:12:24 INFO - 'cart']}, 10:12:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'talos_options': ['--disable-e10s'], 10:12:24 INFO - 'tests': ['tp5o']}, 10:12:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'tests': ['tp5o']}, 10:12:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'talos_options': ['--disable-e10s', 10:12:24 INFO - '--xperf_path', 10:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:24 INFO - 'tests': ['tp5n']}, 10:12:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:24 INFO - 'talos_options': ['--xperf_path', 10:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:24 INFO - 'tests': ['tp5n']}}, 10:12:24 INFO - 'talos.zip': {'path': '', 10:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:24 INFO - Running post-action listener: _resource_record_post_action 10:12:24 INFO - ##### 10:12:24 INFO - ##### Finished populate-webroot step (success) 10:12:24 INFO - ##### 10:12:24 INFO - ##### 10:12:24 INFO - ##### Running create-virtualenv step. 10:12:24 INFO - ##### 10:12:24 INFO - Running pre-action listener: _resource_record_pre_action 10:12:24 INFO - Running main action method: create_virtualenv 10:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:24 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 10:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:24 INFO - Using real prefix '/usr' 10:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:27 INFO - Installing pip.................done. 10:12:27 INFO - Return code: 0 10:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:27 INFO - Using env: {'DISPLAY': ':0', 10:12:27 INFO - 'HOME': '/home/cltbld', 10:12:27 INFO - 'LANG': 'en_US.UTF-8', 10:12:27 INFO - 'LANGUAGE': 'en_US:en', 10:12:27 INFO - 'LOGNAME': 'cltbld', 10:12:27 INFO - 'MAIL': '/var/mail/cltbld', 10:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:27 INFO - 'MOZ_NO_REMOTE': '1', 10:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:27 INFO - 'NO_EM_RESTART': '1', 10:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:27 INFO - 'PWD': '/builds/slave/test', 10:12:27 INFO - 'SHELL': '/bin/bash', 10:12:27 INFO - 'SHLVL': '1', 10:12:27 INFO - 'TERM': 'linux', 10:12:27 INFO - 'TMOUT': '86400', 10:12:27 INFO - 'USER': 'cltbld', 10:12:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:27 INFO - '_': '/tools/buildbot/bin/python'} 10:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:27 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 10:12:27 INFO - Cleaning up... 10:12:27 INFO - Return code: 0 10:12:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:12:27 INFO - Using env: {'DISPLAY': ':0', 10:12:27 INFO - 'HOME': '/home/cltbld', 10:12:27 INFO - 'LANG': 'en_US.UTF-8', 10:12:27 INFO - 'LANGUAGE': 'en_US:en', 10:12:27 INFO - 'LOGNAME': 'cltbld', 10:12:27 INFO - 'MAIL': '/var/mail/cltbld', 10:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:27 INFO - 'MOZ_NO_REMOTE': '1', 10:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:27 INFO - 'NO_EM_RESTART': '1', 10:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:27 INFO - 'PWD': '/builds/slave/test', 10:12:27 INFO - 'SHELL': '/bin/bash', 10:12:27 INFO - 'SHLVL': '1', 10:12:27 INFO - 'TERM': 'linux', 10:12:27 INFO - 'TMOUT': '86400', 10:12:27 INFO - 'USER': 'cltbld', 10:12:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:27 INFO - '_': '/tools/buildbot/bin/python'} 10:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:27 INFO - Downloading/unpacking psutil>=3.1.1 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:28 INFO - Installing collected packages: psutil 10:12:28 INFO - Running setup.py install for psutil 10:12:28 INFO - building 'psutil._psutil_linux' extension 10:12:28 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 10:12:28 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 10:12:28 INFO - building 'psutil._psutil_posix' extension 10:12:28 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 10:12:29 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 10:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:29 INFO - Successfully installed psutil 10:12:29 INFO - Cleaning up... 10:12:29 INFO - Return code: 0 10:12:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12:29 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')]} 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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')]} 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:29 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 10:12:29 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 10:12:29 INFO - Using env: {'DISPLAY': ':0', 10:12:29 INFO - 'HOME': '/home/cltbld', 10:12:29 INFO - 'LANG': 'en_US.UTF-8', 10:12:29 INFO - 'LANGUAGE': 'en_US:en', 10:12:29 INFO - 'LOGNAME': 'cltbld', 10:12:29 INFO - 'MAIL': '/var/mail/cltbld', 10:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:29 INFO - 'MOZ_NO_REMOTE': '1', 10:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:29 INFO - 'NO_EM_RESTART': '1', 10:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:29 INFO - 'PWD': '/builds/slave/test', 10:12:29 INFO - 'SHELL': '/bin/bash', 10:12:29 INFO - 'SHLVL': '1', 10:12:29 INFO - 'TERM': 'linux', 10:12:29 INFO - 'TMOUT': '86400', 10:12:29 INFO - 'USER': 'cltbld', 10:12:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:29 INFO - '_': '/tools/buildbot/bin/python'} 10:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:29 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 10:12:29 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 10:12:29 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 10:12:29 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 10:12:29 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 10:12:29 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 10:12:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:31 INFO - Installing collected packages: mozsystemmonitor 10:12:31 INFO - Running setup.py install for mozsystemmonitor 10:12:31 INFO - Successfully installed mozsystemmonitor 10:12:31 INFO - Cleaning up... 10:12:31 INFO - Return code: 0 10:12:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:31 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 10:12:31 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 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:33 INFO - warning: no files found matching '*.txt' 10:12:33 INFO - no previously-included directories found matching 'build' 10:12:33 INFO - no previously-included directories found matching 'dist' 10:12:33 INFO - no previously-included directories found matching '.git*' 10:12:33 INFO - Installing collected packages: jsonschema, functools32 10:12:33 INFO - Running setup.py install for functools32 10:12:34 INFO - warning: no files found matching '*.txt' 10:12:34 INFO - no previously-included directories found matching 'build' 10:12:34 INFO - no previously-included directories found matching 'dist' 10:12:34 INFO - no previously-included directories found matching '.git*' 10:12:34 INFO - Successfully installed jsonschema functools32 10:12:34 INFO - Cleaning up... 10:12:34 INFO - Return code: 0 10:12:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:34 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:34 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 10:12:34 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 10:12:34 INFO - Using env: {'DISPLAY': ':0', 10:12:34 INFO - 'HOME': '/home/cltbld', 10:12:34 INFO - 'LANG': 'en_US.UTF-8', 10:12:34 INFO - 'LANGUAGE': 'en_US:en', 10:12:34 INFO - 'LOGNAME': 'cltbld', 10:12:34 INFO - 'MAIL': '/var/mail/cltbld', 10:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:34 INFO - 'MOZ_NO_REMOTE': '1', 10:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:34 INFO - 'NO_EM_RESTART': '1', 10:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:34 INFO - 'PWD': '/builds/slave/test', 10:12:34 INFO - 'SHELL': '/bin/bash', 10:12:34 INFO - 'SHLVL': '1', 10:12:34 INFO - 'TERM': 'linux', 10:12:34 INFO - 'TMOUT': '86400', 10:12:34 INFO - 'USER': 'cltbld', 10:12:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:34 INFO - '_': '/tools/buildbot/bin/python'} 10:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading docopt-0.6.1.tar.gz 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:36 INFO - Running setup.py install for blobuploader 10:12:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:37 INFO - Running setup.py install for requests 10:12:37 INFO - Running setup.py install for docopt 10:12:37 INFO - Successfully installed blobuploader requests docopt 10:12:37 INFO - Cleaning up... 10:12:37 INFO - Return code: 0 10:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:37 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 10:12:37 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 10:12:37 INFO - Using env: {'DISPLAY': ':0', 10:12:37 INFO - 'HOME': '/home/cltbld', 10:12:37 INFO - 'LANG': 'en_US.UTF-8', 10:12:37 INFO - 'LANGUAGE': 'en_US:en', 10:12:37 INFO - 'LOGNAME': 'cltbld', 10:12:37 INFO - 'MAIL': '/var/mail/cltbld', 10:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:37 INFO - 'MOZ_NO_REMOTE': '1', 10:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:37 INFO - 'NO_EM_RESTART': '1', 10:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:37 INFO - 'PWD': '/builds/slave/test', 10:12:37 INFO - 'SHELL': '/bin/bash', 10:12:37 INFO - 'SHLVL': '1', 10:12:37 INFO - 'TERM': 'linux', 10:12:37 INFO - 'TMOUT': '86400', 10:12:37 INFO - 'USER': 'cltbld', 10:12:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:37 INFO - '_': '/tools/buildbot/bin/python'} 10:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:37 INFO - Running setup.py (path:/tmp/pip-27Gr9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:37 INFO - Running setup.py (path:/tmp/pip-PyaPTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:37 INFO - Running setup.py (path:/tmp/pip-Lfk46I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:38 INFO - Running setup.py (path:/tmp/pip-QsIreJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:38 INFO - Running setup.py (path:/tmp/pip-Ff_ig3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:38 INFO - Running setup.py (path:/tmp/pip-6_Q91r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:38 INFO - Running setup.py (path:/tmp/pip-L63waG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:38 INFO - Running setup.py (path:/tmp/pip-T_38hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:38 INFO - Running setup.py (path:/tmp/pip-ADRZ10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:38 INFO - Running setup.py (path:/tmp/pip-vY82x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:38 INFO - Running setup.py (path:/tmp/pip-HQ87YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:38 INFO - Running setup.py (path:/tmp/pip-siPvTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:38 INFO - Running setup.py (path:/tmp/pip-IbkR3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:38 INFO - Running setup.py (path:/tmp/pip-OCipOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:38 INFO - Running setup.py (path:/tmp/pip-VwXKZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:38 INFO - Running setup.py (path:/tmp/pip-0_I3hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:38 INFO - Running setup.py (path:/tmp/pip-Rg2Wl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:39 INFO - Running setup.py install for manifestparser 10:12:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Running setup.py install for mozcrash 10:12:39 INFO - Running setup.py install for mozdebug 10:12:39 INFO - Running setup.py install for mozdevice 10:12:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Running setup.py install for mozfile 10:12:39 INFO - Running setup.py install for mozhttpd 10:12:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Running setup.py install for mozinfo 10:12:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Running setup.py install for mozInstall 10:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:39 INFO - Running setup.py install for mozleak 10:12:39 INFO - Running setup.py install for mozlog 10:12:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Running setup.py install for moznetwork 10:12:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Running setup.py install for mozprocess 10:12:40 INFO - Running setup.py install for mozprofile 10:12:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Running setup.py install for mozrunner 10:12:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Running setup.py install for mozscreenshot 10:12:40 INFO - Running setup.py install for moztest 10:12:40 INFO - Running setup.py install for mozversion 10:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:40 INFO - Cleaning up... 10:12:40 INFO - Return code: 0 10:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:40 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')]} 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 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')]} 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:40 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 10:12:40 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 10:12:40 INFO - Using env: {'DISPLAY': ':0', 10:12:40 INFO - 'HOME': '/home/cltbld', 10:12:40 INFO - 'LANG': 'en_US.UTF-8', 10:12:40 INFO - 'LANGUAGE': 'en_US:en', 10:12:40 INFO - 'LOGNAME': 'cltbld', 10:12:40 INFO - 'MAIL': '/var/mail/cltbld', 10:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:40 INFO - 'MOZ_NO_REMOTE': '1', 10:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:40 INFO - 'NO_EM_RESTART': '1', 10:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:40 INFO - 'PWD': '/builds/slave/test', 10:12:40 INFO - 'SHELL': '/bin/bash', 10:12:40 INFO - 'SHLVL': '1', 10:12:40 INFO - 'TERM': 'linux', 10:12:40 INFO - 'TMOUT': '86400', 10:12:40 INFO - 'USER': 'cltbld', 10:12:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:40 INFO - '_': '/tools/buildbot/bin/python'} 10:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:41 INFO - Running setup.py (path:/tmp/pip-ZQ9Tkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:41 INFO - Running setup.py (path:/tmp/pip-KUp0HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:41 INFO - Running setup.py (path:/tmp/pip-mL3gW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:41 INFO - Running setup.py (path:/tmp/pip-vJAwwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:41 INFO - Running setup.py (path:/tmp/pip-KvktJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:41 INFO - Running setup.py (path:/tmp/pip-_nsqTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:41 INFO - Running setup.py (path:/tmp/pip-DesxU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:41 INFO - Running setup.py (path:/tmp/pip-d_3CWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:41 INFO - Running setup.py (path:/tmp/pip-fsboLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:41 INFO - Running setup.py (path:/tmp/pip-kBevXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:41 INFO - Running setup.py (path:/tmp/pip-cvN46k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:41 INFO - Running setup.py (path:/tmp/pip-QoQNjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:41 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)) 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:41 INFO - Running setup.py (path:/tmp/pip-IKcwqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:42 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)) 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:42 INFO - Running setup.py (path:/tmp/pip-cjo_zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:42 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)) 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:42 INFO - Running setup.py (path:/tmp/pip-fTm8aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:42 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)) 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:42 INFO - Running setup.py (path:/tmp/pip-uTrEsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:42 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)) 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:42 INFO - Running setup.py (path:/tmp/pip-Ao9ltA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:42 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)) 10:12:42 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)) 10:12:42 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)) 10:12:42 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)) 10:12:42 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)) 10:12:42 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)) 10:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:42 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 10:12:42 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 10:12:42 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 10:12:42 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 10:12:42 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 10:12:42 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 10:12:44 INFO - Downloading blessings-1.6.tar.gz 10:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:44 INFO - Installing collected packages: blessings 10:12:44 INFO - Running setup.py install for blessings 10:12:44 INFO - Successfully installed blessings 10:12:44 INFO - Cleaning up... 10:12:44 INFO - Return code: 0 10:12:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:44 INFO - Reading from file tmpfile_stdout 10:12:44 INFO - Current package versions: 10:12:44 INFO - argparse == 1.2.1 10:12:44 INFO - blessings == 1.6 10:12:44 INFO - blobuploader == 1.2.4 10:12:44 INFO - docopt == 0.6.1 10:12:44 INFO - functools32 == 3.2.3-2 10:12:44 INFO - jsonschema == 2.5.1 10:12:44 INFO - manifestparser == 1.1 10:12:44 INFO - mozInstall == 1.12 10:12:44 INFO - mozcrash == 0.17 10:12:44 INFO - mozdebug == 0.1 10:12:44 INFO - mozdevice == 0.48 10:12:44 INFO - mozfile == 1.2 10:12:44 INFO - mozhttpd == 0.7 10:12:44 INFO - mozinfo == 0.9 10:12:44 INFO - mozleak == 0.1 10:12:44 INFO - mozlog == 3.2 10:12:44 INFO - moznetwork == 0.27 10:12:44 INFO - mozprocess == 0.22 10:12:44 INFO - mozprofile == 0.28 10:12:44 INFO - mozrunner == 6.11 10:12:44 INFO - mozscreenshot == 0.1 10:12:44 INFO - mozsystemmonitor == 0.3 10:12:44 INFO - moztest == 0.7 10:12:44 INFO - mozversion == 1.4 10:12:44 INFO - psutil == 3.1.1 10:12:44 INFO - requests == 1.2.3 10:12:44 INFO - wsgiref == 0.1.2 10:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:44 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:44 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 10:12:44 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 10:12:44 INFO - Using env: {'DISPLAY': ':0', 10:12:44 INFO - 'HOME': '/home/cltbld', 10:12:44 INFO - 'LANG': 'en_US.UTF-8', 10:12:44 INFO - 'LANGUAGE': 'en_US:en', 10:12:44 INFO - 'LOGNAME': 'cltbld', 10:12:44 INFO - 'MAIL': '/var/mail/cltbld', 10:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:44 INFO - 'MOZ_NO_REMOTE': '1', 10:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:44 INFO - 'NO_EM_RESTART': '1', 10:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:44 INFO - 'PWD': '/builds/slave/test', 10:12:44 INFO - 'SHELL': '/bin/bash', 10:12:44 INFO - 'SHLVL': '1', 10:12:44 INFO - 'TERM': 'linux', 10:12:44 INFO - 'TMOUT': '86400', 10:12:44 INFO - 'USER': 'cltbld', 10:12:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:44 INFO - '_': '/tools/buildbot/bin/python'} 10:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 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)) 10:12:44 INFO - Cleaning up... 10:12:44 INFO - Return code: 0 10:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:44 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:44 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 10:12:44 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 10:12:44 INFO - Using env: {'DISPLAY': ':0', 10:12:44 INFO - 'HOME': '/home/cltbld', 10:12:44 INFO - 'LANG': 'en_US.UTF-8', 10:12:44 INFO - 'LANGUAGE': 'en_US:en', 10:12:44 INFO - 'LOGNAME': 'cltbld', 10:12:44 INFO - 'MAIL': '/var/mail/cltbld', 10:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:44 INFO - 'MOZ_NO_REMOTE': '1', 10:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:44 INFO - 'NO_EM_RESTART': '1', 10:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:44 INFO - 'PWD': '/builds/slave/test', 10:12:44 INFO - 'SHELL': '/bin/bash', 10:12:44 INFO - 'SHLVL': '1', 10:12:44 INFO - 'TERM': 'linux', 10:12:44 INFO - 'TMOUT': '86400', 10:12:44 INFO - 'USER': 'cltbld', 10:12:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:44 INFO - '_': '/tools/buildbot/bin/python'} 10:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:45 INFO - Cleaning up... 10:12:45 INFO - Return code: 0 10:12:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:45 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 0x7f76aec0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, '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': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', '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 10:12:45 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 10:12:45 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 10:12:45 INFO - Using env: {'DISPLAY': ':0', 10:12:45 INFO - 'HOME': '/home/cltbld', 10:12:45 INFO - 'LANG': 'en_US.UTF-8', 10:12:45 INFO - 'LANGUAGE': 'en_US:en', 10:12:45 INFO - 'LOGNAME': 'cltbld', 10:12:45 INFO - 'MAIL': '/var/mail/cltbld', 10:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:45 INFO - 'MOZ_NO_REMOTE': '1', 10:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:45 INFO - 'NO_EM_RESTART': '1', 10:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:45 INFO - 'PWD': '/builds/slave/test', 10:12:45 INFO - 'SHELL': '/bin/bash', 10:12:45 INFO - 'SHLVL': '1', 10:12:45 INFO - 'TERM': 'linux', 10:12:45 INFO - 'TMOUT': '86400', 10:12:45 INFO - 'USER': 'cltbld', 10:12:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:45 INFO - '_': '/tools/buildbot/bin/python'} 10:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:45 INFO - Downloading/unpacking flake8 10:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:47 INFO - no previously-included directories found matching 'docs/_build' 10:12:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:48 INFO - Running setup.py install for pep8 10:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:48 INFO - no previously-included directories found matching 'docs/_build' 10:12:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:48 INFO - Cleaning up... 10:12:48 INFO - Return code: 0 10:12:48 INFO - Running post-action listener: _resource_record_post_action 10:12:48 INFO - Running post-action listener: _start_resource_monitoring 10:12:48 INFO - Starting resource monitoring. 10:12:48 INFO - ##### 10:12:48 INFO - ##### Finished create-virtualenv step (success) 10:12:48 INFO - ##### 10:12:48 INFO - ##### 10:12:48 INFO - ##### Running install step. 10:12:48 INFO - ##### 10:12:48 INFO - Running pre-action listener: _resource_record_pre_action 10:12:48 INFO - Running main action method: install 10:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:48 INFO - Reading from file tmpfile_stdout 10:12:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:48 INFO - Reading from file tmpfile_stdout 10:12:48 INFO - Output received: 10:12:48 INFO - Usage: mozinstall [options] installer 10:12:48 INFO - Options: 10:12:48 INFO - -h, --help show this help message and exit 10:12:48 INFO - -d DEST, --destination=DEST 10:12:48 INFO - Directory to install application into. [default: 10:12:48 INFO - "/builds/slave/test"] 10:12:48 INFO - --app=APP Application being installed. [default: firefox] 10:12:48 INFO - mkdir: /builds/slave/test/build/application 10:12:48 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'] 10:12:48 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 10:13:05 INFO - Reading from file tmpfile_stdout 10:13:05 INFO - Output received: 10:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:05 INFO - Running post-action listener: _resource_record_post_action 10:13:05 INFO - ##### 10:13:05 INFO - ##### Finished install step (success) 10:13:05 INFO - ##### 10:13:05 INFO - ##### 10:13:05 INFO - ##### Running run-tests step. 10:13:05 INFO - ##### 10:13:05 INFO - Running pre-action listener: _resource_record_pre_action 10:13:05 INFO - Running main action method: run_tests 10:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:05 INFO - Python 2.7.3 10:13:05 INFO - Return code: 0 10:13:05 INFO - grabbing minidump binary from tooltool 10:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:05 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 0x142e1c0>, '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 0x142f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:05 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 10:13:05 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 10:13:05 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 10:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:05 INFO - Return code: 0 10:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:06 INFO - Return code: 0 10:13:06 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:13:06 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:13:06 INFO - Using env: {'DISPLAY': ':0', 10:13:06 INFO - 'HOME': '/home/cltbld', 10:13:06 INFO - 'LANG': 'en_US.UTF-8', 10:13:06 INFO - 'LANGUAGE': 'en_US:en', 10:13:06 INFO - 'LOGNAME': 'cltbld', 10:13:06 INFO - 'MAIL': '/var/mail/cltbld', 10:13:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:06 INFO - 'MOZ_NO_REMOTE': '1', 10:13:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:06 INFO - 'NO_EM_RESTART': '1', 10:13:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:06 INFO - 'PWD': '/builds/slave/test', 10:13:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:06 INFO - 'SHELL': '/bin/bash', 10:13:06 INFO - 'SHLVL': '1', 10:13:06 INFO - 'TERM': 'linux', 10:13:06 INFO - 'TMOUT': '86400', 10:13:06 INFO - 'USER': 'cltbld', 10:13:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900', 10:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:06 INFO - '_': '/tools/buildbot/bin/python'} 10:13:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:13:06 INFO - mozversion application_buildid: 20160609073122 10:13:06 INFO - mozversion application_changeset: 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 10:13:06 INFO - mozversion application_display_name: Nightly 10:13:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:06 INFO - mozversion application_name: Firefox 10:13:06 INFO - mozversion application_remotingname: firefox 10:13:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:13:06 INFO - mozversion application_vendor: Mozilla 10:13:06 INFO - mozversion application_version: 50.0a1 10:13:06 INFO - mozversion platform_buildid: 20160609073122 10:13:06 INFO - mozversion platform_changeset: 0ace95ea7f4cb6366e19a3a4e9e8626637f74028 10:13:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:13:06 INFO - mozversion platform_version: 50.0a1 10:13:06 INFO - using testdate: 1465492386 10:13:06 INFO - actual date: 1465492386 10:13:06 INFO - starting webserver on 'localhost:34903' 10:13:06 INFO - SUITE-START | Running 2 tests 10:13:06 INFO - TEST-START | dromaeo_css 10:13:06 INFO - operating with platform_type : linux_ 10:13:06 INFO - Initialising browser for dromaeo_css test... 10:13:06 INFO - TEST-INFO | started process 21261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2F_9T/profile http://localhost:34903/getInfo.html) 10:13:11 INFO - PROCESS | 21261 | __metrics Screen width/height:1600/1200 10:13:11 INFO - PROCESS | 21261 | colorDepth:24 10:13:11 INFO - PROCESS | 21261 | Browser inner width/height: 1024/697 10:13:11 INFO - PROCESS | 21261 | __metrics 10:13:12 ERROR - PROCESS | 21261 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:13:12 INFO - TEST-INFO | 21261: exit 0 10:13:12 INFO - Browser initialized. 10:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:13 INFO - TEST-INFO | started process 21380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2F_9T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:24 INFO - PROCESS | 21380 | RSS: Main: 184164352 10:13:24 INFO - PROCESS | 21380 | 10:14:14 INFO - PROCESS | 21380 | 1465492454567 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] 10:16:22 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34903/tests/dromaeo/cssquery-ext.html) 10:16:23 INFO - PROCESS | 21380 | RSS: Main: 187064320 10:16:23 INFO - PROCESS | 21380 | 10:19:26 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-ext.html (next: http://localhost:34903/tests/dromaeo/cssquery-jquery.html) 10:19:26 INFO - PROCESS | 21380 | RSS: Main: 186978304 10:19:26 INFO - PROCESS | 21380 | 10:22:28 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34903/tests/dromaeo/cssquery-mootools.html) 10:22:29 INFO - PROCESS | 21380 | RSS: Main: 188620800 10:22:29 INFO - PROCESS | 21380 | 10:25:30 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34903/tests/dromaeo/cssquery-prototype.html) 10:25:31 INFO - PROCESS | 21380 | RSS: Main: 185733120 10:25:31 INFO - PROCESS | 21380 | 10:28:34 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34903/tests/dromaeo/cssquery-yui.html) 10:28:34 INFO - PROCESS | 21380 | RSS: Main: 187678720 10:28:34 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:34903/tests/dromaeo/cssquery-yui.html (next: http://localhost:34903/tests/dromaeo/cssquery-dojo.html) 10:31:37 INFO - PROCESS | 21380 | RSS: Main: 189190144 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | __start_tp_report 10:31:37 INFO - PROCESS | 21380 | _x_x_mozilla_page_load 10:31:37 INFO - PROCESS | 21380 | _x_x_mozilla_page_load_details 10:31:37 INFO - PROCESS | 21380 | |i|pagename|runs| 10:31:37 INFO - PROCESS | 21380 | |0;dojo.html;3139.9324229761883;3166.3825554016976;3190.569273148125;3204.9359012819746;3210.791298565593;5456.754446049932;5565.91651125233;5597.992361374951;5604.187392828037;5632.042552766029;5327.334083239595;5563.388027317002;5596.524295434893;5616.971915140429;5677.9716101419535;5031.924521132177;5076.593872490211;5180.481951804827;5218.13900706383;5222.3472065991755;693.3966244032223;5138.66598671087;5148.922766158511;5163.044836705221;5177.042247184283;5089.338386009832;5105.744712764384;5108.8211912583065;5111.795528178868;5155.639105262633;4944.060628480614;5092;5134.127198376285;5146.536811686929;5169.405518365398;5008;5008.449070602231;5009.799608015675;5017.949820501784;5030.346055012825;5512.366077901012;5570.080936645449;5605.439456054402;5609.439056094398;5637.566558054521;5871.765129394819;5963.493103086243;5974.731137098841;6000.819975400745;6045.153678485016;6005.6997150142315;6052.243469566304;6062.666553339564;6069.969650151766;6108.633481991094;5553.305836770403;5576;5579.107342825169;5579.46995035471;5581.107022876401;5871.500922421642;6096.980278560413;6104.065072948782;6126.785562505291;6131.110988906584;5921.348651648402;5956.7319470623925;5960.433758792994;5964.224650795456;6002.639841609517;6070.666113363719;6071.51427885768;6073.969630151821;6075.362086980892;6079.0273556230795;5762.971185144047;5915.08316210988;5925.111233314951;5967.19442875215;5975.133605627159;5719.056355701346;5891.587588868823;5910.674912879833;5964.880702385928;6004.249468816398;4525.705829121097;4526;4526.569975852289;4534.79593418297;4574.313852922089;3995.320795464778;3996.200759847984;4004.2391945530258;4005.5393629732953;4064.776437295918;5720;5749.88500229993;5757.395473475309;5762.567807414461;5766.279215098113;6030.939690603038;6090.025595904723;6091.177691011745;6093.878122437615;6117.265928088658;5466.562674985991;5708.143778433186;5715.5427565794635;5752.913706294409;5761.452661997104;5045.772940217699;5048.167052436307;5067.193007750948;5075.086484432837;5077.8730531737;6024.819255422344;6269.905951410732;6280.560360774702;6299.181106456132;6306.49548036156;5868.23712917318;5917.763289468545;5934.643921364732;5938.257717785277;5946.405359464192;6104.20645316106;6112.663803490851;6134.04922237054;6141.6007959482495;6165.72254248551;5750.913736293875;5793.15999180125;5855.238818953509;5862.325832529314;5884.323302820059;5852.092925596539;5932.228810254639;5948.078047902582;5956.195913551615;6017.669028203491;5718.228039214653;5724.942750572608;5755.107958266475;5766.07742761173;5770.2498675171955;5602.355729091044;5713.742881570256;5739.426057394227;5740.971295143498;5766.855828604151;5417.539509141767;5640.802571909963;5654.802081927113;5688.971555142198;5789.160571716993;5837.737301821343;5900.586958912835;5912.940870591239;5927.4665280125;5928.762849486145;5541.2796336476;5707.258056452634;5748.827535173951;5795.246617939641;5806.65160090396 10:31:37 INFO - PROCESS | 21380 | |1;ext.html;577.8266520043986;633.8605506788505;645.1902861908302;645.7062036773268;650.4926157597074;41771.79114104429;43108.56891431089;43192;43243.35134972978;47016.76491617537;45011.77494112533;45643.31535026969;45819.08361832761;45844.312335315;45857.54142458575;9025.097490250955;9059.505181645054;9153.908460915405;9176.265898728087;9176.72469825903;8940.329475289347;9007.414518056337;9010.68462603809;9020.729378118634;9039.186473217409;9050.683226087089;9064.637414503444;9064.77338066547;9141.131592498736;9167.816643667122;9079.182873541413;9087.182153606174;9114.544272786366;9141.040190780006;9151.267898568098;8892;8892.911070889273;8928.107189281085;8932.062133475956;8933.240674542672;42648.78675606633;42774.14451710948;43035.13929721419;43035.78482107569;43059.56940430618;3409.5226668266214;3516.0682419158943;3796.506454160969;3900.902477438058;4238.766867822269;33244.33511329784;33312;33542;33668.32663346744;34728;4394.978025109886;4499.662525310582;4574.679772415932;4588.7476188809605;4710.24636058229;343433;344630;345217;346290.9999999975;347449;53180.73409632927;58610.706946465;59964.30160642781;60283.397166027775;60441;63982.68008659927;64418.677906610166;64464.67767661132;64708.676456618356;64757;16797.58006049834;17056.48830535086;17064;17131.143442827808;17145.14274286281;12966.870331296755;13007.934960325138;13080.607581772561;13121.803172952414;13186.538471153464;18468.353607623667;18644.533886652942;18651.855036670684;18786.718199227023;18855.717164242546;6228.128062071313;6316.621002739758;6371.490280777527;6448.967755161194;6507.642079685663;978.6036655154674;1034.591336422109;1121.3664279681955;1173.501261963662;1182.0884226040814;32778.344433111204;32854.83572582122;33017.66982330146;33426.33147337088;33812.66187338145;1077.2943721862193;1166.9066474682006;1169.6607983684637;1182.7693599748138;1196.9940150299192;16557.337706491606;17011.744823827652;17018.404355847735;17129.143542823058;17343;489967;491193;492805;497366;497668;58162.127568086515;58376.416235837096;58723.41276587179;58977;59019.40980590225;1343.9059265851492;1361.0948719101686;1373.0388727890318;1374.4364810427676;1391.1166409330149;30322;31757.523637145;31819.522707158947;31928.36143277075;32284.515732264506;50038;50181.24728129154;50298.7485062587;50533.242001369275;50716;400438;412608;414637;414686;415131;42331;42529.57470425256;42611.147777044906;42827.78586107049;44235;48089.75955120202;48919.26621100615;49647.50352496429;50047.499525004285;52226.477735222164;40286.597134028285;41217.793911030254;45015.54984450113;45163.54836451725;45993.54006459893;43502.12995740131;43628;44036;44202.55797441985;44513;39070.218595628496;44115.77942110269;44535.55464445314;45287;45581.54418455773;38484;39222;39600.40599390954;39999;40073.79963100166;29555.852220738758;30031.69968300289;30329.393412132074;30364.24089397783;30392.5441118379 10:31:37 INFO - PROCESS | 21380 | |2;jquery.html;393.6221227621485;395.0794648469064;395.4720448201651;402.3923874948827;411.87231958092974;17913.910430447846;19314.71027934582;19650.213991440327;19655.803441965578;20284.391468255977;18004.909975450137;18792.812071879278;18840.152193151305;19772.90113549434;20115.396538103843;5248.737563121847;5255.474452554733;5390.00284947284;5413.133898576229;5414.7834086636485;5315.760790764425;5323.414424413311;5324.254604355393;5343.572514198855;5351.331083614548;5247.763850626712;5280.867978300535;5735.455131762496;5742.885142297151;5777.537796976253;5750.971245143747;5759.308882934054;5766.682832444214;5775.797847075353;5783.681897495636;5010.72441015744;5156.381234251914;5184.7407629618365;5188.92216616751;5202.3497062867145;13740.65648358799;13862.653433664138;14351.641208969859;22998.42503937415;23091.191808286796;2142.78572142786;2312.5259321839153;2332.416895776056;2544.2621639724457;2670.198940317897;10232;10519.73700657482;10538.20963427746;10636.893631063667;10786.191035672357;1897.990510047441;1913.770347558288;1974.8222659960672;1977.881327120363;1991.9502012449805;79128.60435697784;84000.57999709963;84492.99999999939;86186.13813861844;86794.49041321863;10545.525451354708;10595.364278143335;10857.2942758722;11058.723531911606;11262.493187806569;15383.692326153414;15417.614559636098;15447.613809654624;15489.457868974532;15496.225188740518;8133.7153199638915;8331.458455200514;8383.287420569199;8469.957650211833;8534.27458666008;8067.556284404414;8094.190580941859;8148.185181481923;8311;8320.37597180214;4626.676132670681;4642.698224615389;4647.837325693585;4705.411823522059;4764.094821983812;1830.8169183081852;1889.1687657430962;1930.7972662870197;1930.8648394612242;1942.174575805277;964.0889359555154;968.5980318167882;1020.9438480883623;1062.2670357453333;1071.2875937501474;16945;17442.215100320514;19343.613127737368;19561.608767824848;19698.40904772859;947.5688561704408;968.6609686609771;974.8440249560178;990.7622170678985;1004.4525733475274;10432.634857779942;10473.723902516527;10573.735656608493;10925.617603383844;10969.725756855983;513894;515906;525230;527149;527725;57653;74314.62842685753;92026;92242.53878730697;92405;981.7054883535054;992.6575331510472;1017.3133135133755;1047.3087762076993;1056.9312994655477;15957.601059973593;17107.315707371567;17265.22306496236;17356.13219339053;17429.215685294446;41285;41726.79136604298;42076;42291.788541058326;43017.569824302605;59331.40668593259;59827.102593460266;60125.699371502866;60217.096743548005;60342.39657603368;8338.87491687613;8406.285465735236;8586.65653373858;8766.298696104424;8858.955705221433;8585.699500517452;8974.551272436222;9185.127412895765;9201.815963680556;9713.514324283617;8256.25693687571;8416.24253817135;8803.075677053817;8824.691135810215;9028.142326478974;8355.95822020886;8692.434991725517;8716.73849784482;8737.956310218407;8855.114488551093;8860.86708699357;8897.377183597346;8902.42134261271;8906.554672266491;9189.77025574366;12762.17045892014;12976.15654982423;13065.412056457291;13072.150310229805;13178.670533236746;12215.877841221474;12443.377831108228;12489.875101248872;12695.111342205957;12790.604697651175 10:31:37 INFO - PROCESS | 21380 | |3;mootools.html;1483.6513419346452;1498.423107103765;1630.7309293966496;1741.1990484377177;1742.555648309681;7967.123616402191;8628.697995570155;8674.089220631837;9182.770430739234;9193.126652967965;8877.778055548615;8891.777705557364;8960.283177345813;8964.686235981742;8969.282457403408;2356.929292121235;2368.7868091871815;2374.1097088591778;2389.450426401929;2392.342105920868;2256.6050941085246;2309.3072078376504;2329.0683726509446;2330.382448651109;2332.790048895599;2318.6058370077044;2319.083961835074;2337.240396871015;2346.378209774411;2352.988235058831;2284.9146655338745;2307.619242824932;2317.8377513574055;2322.895469703859;2330.4639932815376;2308.5267520158327;2350.97649023511;2359.9646005309933;2366.8343215974887;2379.3456799380137;8975.326850486173;9034.503102329369;9053.90946090544;9061.365704400694;9116.680916167968;5191.5846732261325;5258.605604579634;5364.9731751341;5368.1679339702405;5403.378611459654;3355.2786150977413;3363.360961417323;3456.7753096048928;3465.8093804840723;3507.9123021924656;1104.1994553948323;1125.6904351303376;1168.263993683982;1182.0484509969472;1193.4152265389982;12722.300273484954;12749.362531873368;12749.872501274962;12768.42542085599;12788.424520896582;4743.4589887420025;4766.6901651392545;4774.737389443614;4804.855854324376;4870.0746858096845;10560.52477638508;10576.101031412261;10590.788184236271;10591.417472038958;10598.682039538671;5317.893642127213;5353.81261655848;5359.624826262124;5382.757775900094;5410.377806552218;4286.80709368073;4843.418789745253;4866.367372241657;4981.701097934136;4985.55130038291;3996.100877302642;4026.4296924199584;4093.4269202311702;4134.49091081753;4151.916961660811;1306.3207132291154;1311.1608570514877;1311.698309388846;1330.1487048289102;1331.660426591213;954.4511905654276;954.856771484283;964.5466630683568;964.7057647417465;969.5588507229194;5879.2944846618675;5946.643201407929;6006.879862402728;6048.939510604838;6052.757889684452;441.0495382450824;443.43240651965533;444.5532240098745;449.44044664392385;474.1796691723338;3781.2815565042556;3869.903252418656;3871.709621778378;3873.1479074603544;3877.9612203878164;10988.670339889815;11314.642242930737;11402.94298528502;11425.200235983568;11445.198836081394;11026.06888420382;11136.276142050741;11252.212345135926;11286.492107855167;11323.886761132448;8217.178282171735;8259.95870020658;8498.490090594583;8498.830023399621;8506.234438900405;5731.684757338387;5870.383609720918;5943.286805583358;5947.256592925884;5982.46157845796;10077.244206684381;10400.647915770902;10479.790404192026;10486.685399438029;10516.894831051592;10344.224183186141;10435.791284174426;10489.737756556147;10503.527341269813;10524.894751052698;7122.964385178041;7665.156832748505;7852.13626501073;7933.087694915159;7936.2857342839425;8877.245434137913;8884.600192991202;8920;8936.50849203274;8965.820683586422;7854.00923124321;8002.439829211899;8103.918960810316;8125.512469251864;8142.918570814216;7713.575753333396;7867.567283799446;7873.842523149619;7904.328132108605;7973.3621310293875;6396.488280937607;6398.520110991787;6469.029645553204;6477.1579694639395;6491.05879647439;5167.379914410144;5194.428612852507;5270.021134043773;5293.523582877559;5340.759665815125;5132.666376685504;5148.562372198405;5176.3011993381915;5212.322398088376;5355.464453554613 10:31:37 INFO - PROCESS | 21380 | |4;prototype.html;317.94753865612176;325.9234079991203;329.6275209013814;331.4266319267668;333.12554544321154;5663.207150998864;5698.316202055754;5699.91952937178;5719.684472571306;5721.914171287434;5543.695096769676;5551.500364967153;5565.638233514829;5584.86037849053;5596.964561556115;4110.527289361717;4197.412362269285;4319.956800431987;4338;4363.672724545656;4317.352397140423;4334.826606935719;4345.130973805236;4362.389265502832;4362.411074504948;4306.655467562588;4324.6107850293465;4331.480222373304;4349.499807522144;4361.323994780798;4253.914921701564;4281.336392859096;4328.956710432918;4342.848000320006;4355.80398882051;3805.3340665383726;3823.1589050409143;3823.5794062653085;3850.1144736710435;3874.748141370802;5395.487428694268;5430.456954304577;5458.4541545845495;5471.945280547184;5474.863128421821;4827.227643577046;4960.776765045582;4969.906620543475;4977.477364876672;4998.40019197695;5779.659238008613;5813.8372325535065;5888.852778680567;5890.263717035371;5940;4205.243056249874;4219.324908014733;4224.4930608327195;4224.683148763825;4248.872533823959;5922.3485416604135;6042.667653279068;6050.952272929019;6055.212822333113;6134.785282515135;4314.913701725948;4338.349247612883;4344.370066340363;4360.694751367438;4362.585554372329;4329.848455304049;4337.566243375637;4358.150160718629;4410.955890441054;4424.535423780521;4707.693999889996;4918.926216106761;4926.8768280793265;4937.716193789569;5068.391792984792;5823.708814559255;5825.621334613236;5867.2959244890035;5880.7353669085;5938.435848594377;1461.5615315405337;1481.3482067890093;1481.3926290221173;1482.9110253384831;1489.7392956232616;918.93108016899;939.6053657463882;974.512743628186;1010.7264846293576;1013.8580598716186;5517.944820551824;5568.94190103879;5581.49766521015;5607.327120745536;5625.662460252316;5941.435563621449;5941.940580594139;5993.880122397615;6004.399560044048;6016.548758843104;5287.3126493556365;5590.580706447033;5649.757053448235;5685.800996965087;5731.77072917087;3147.882501711905;3152.385284869474;3175.1109689287036;3191.856366463515;3209.7642407673216;5921.496672782861;6202.44178023971;6233.906491402633;6244.501319683243;6295.905561416583;6220.937790622036;6249.281332646713;6263.812085637438;6304.810855674337;6304.8423789404715;6115.877682446326;6287.245530536365;6312.274088479883;6332.936670633235;6418.74325027003;6114;6116.483022262306;6138.447539721446;6143.170671959407;6152.431130061985;5994.610350327215;6087.482563982111;6102.291358419649;6107.54193435503;6126.142340072304;6025.216721826135;6238.189035425366;6247.312795592572;6256.718447669957;6266.592671476339;4238.385434111975;4242.17277630859;4253.29868052769;4267.402563641155;4282.78586070689;5977.3126090500145;6050.2437195350585;6069;6072.757089716361;6091.360407157184;5864.824055278348;5896.528277737856;5897.997340452219;5903.406080358365;5919.260092488439;5891.882162356815;5952.404759524013;5972.611780234444;5972.641641501524;5987.670678112746;5565.777368905198;5649.943500564942;5758.424157584208;5810.448007439287;5821.592488525763;5875.706214689334;5887.352391236875;5916.437938395846;5943.821685349447;5977.820665380045;5615.6630602164005;5758.2514273144225;5781.566382521243;5826.912596311144;5851.327097383855 10:31:37 INFO - PROCESS | 21380 | |5;yui.html;727.8180454886278;772.2586317135549;791.8099656082542;812.8902598149248;830.5971603772169;15149.621259468506;15248.161351125684;15303.15832629205;15314.387424503035;15428;14974;15141.54575362738;15150.242487875617;15154.545363639108;15166.848331516681;651.2673242602073;765.5636287316232;781.3007358414202;781.3436713160944;787.7321710618388;764.6100488750749;764.6215123513869;771.2595907928395;771.6836097200149;774.802425381527;833.7832163637437;836.7991681996338;838;838.8364268967554;842.5955541340161;831.6382373667444;835.5529791561515;836.958152092393;838.0990435282066;840.5503055865144;605.8909396308662;605.9454649081604;610.9327973922865;611.0315150486484;614.5083932853744;14885.702285954329;14890.925545372313;14980.176090315028;15031.323590438456;15050.32273547693;13011.21932684042;13208.405621747044;13246.805111821106;13290.202587844664;13318.86681133186;12184.268943863308;12212.450439730233;12312.569060082855;12389.318587477685;12425.62723118308;3867.2652196082654;3882.2235552889533;3916.8824935251987;3925.509311336083;4074.124063326369;77361.61319193368;79435.99999999942;79573.60213198897;79630.6018469904;80022;11469.598564050219;11552.133589980785;11729;11805.350705711267;12083.395830208454;22331.330060098222;22644.207452739403;23032;23100.306990790305;23140.76859231386;8218.21926916942;8284.875726864102;8306.210909963544;8445.746627601182;8491.915080849236;4591.701539399928;4721.457032441244;4726.220173671306;4730.645201609893;4857.80568777252;3717.70258379329;3883.1845312484693;3889.4749208857006;3890.688744900401;3901.7463864848696;624.9437550620376;626.8816352400603;638.6200210874522;639.335091504839;656.2256537286048;669.2872091222929;672.8452455935162;679.5718697220818;702.1644243350397;719.5502810743285;9505.524723763923;9627.326087173831;9702.27232957531;9723.854142187873;9910.157636600825;747.3274053351918;752.3266676324658;755.3654929858944;767.0718430698805;777.9572123533147;5010.69935803853;5075.3402057733;5150.819721309811;5156.123459011977;5178.275041494194;107035;109231;113527.43236283766;114738.42630786792;116651.41674291744;65244;70430.64784676147;93884.53057734668;97821.51089244508;102187;87193;87685.56157219173;88752.5562372184;89230.55384723164;89640.5517972406;8946.194842464209;9067.863982040406;9138;9261.583228754856;9513.23894088485;38680.41979370255;45612.543874560826;46429.767851160526;49293.2606010903;50395.49604503908;68450;72759.63620181865;74083;74300;76153.61923190349;11501.597444089417;11605.535778568763;11714.76570468603;11902.761944760883;11911.285322880654;9148.908510914805;12936.417861196456;13039.413226405024;13200.603981880558;13715.588532344045;12078.577249796566;12393.75212495727;12395.380230988234;12507.187032842836;12746.681332966378;12336.444859981142;12456.626301210978;12523.686907827378;12540.310282934526;12545.31000794965;12231.449584768528;12371.21635652113;12449.37753112359;12478.452972994235;12591.433385497492;10393.220508461744;10394.22043346737;10612.363258204532;10757.731056723644;10780.353178809297;10191.54138063774;10613.09788667941;10645.787084258427;10662.253642244968;10696.358218506915 10:31:37 INFO - PROCESS | 21380 | __end_tp_report 10:31:37 INFO - PROCESS | 21380 | __start_cc_report 10:31:37 INFO - PROCESS | 21380 | _x_x_mozilla_cycle_collect,374 10:31:37 INFO - PROCESS | 21380 | __end_cc_report 10:31:37 INFO - PROCESS | 21380 | __startTimestamp1465493497655__endTimestamp 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | ------- Summary: start ------- 10:31:37 INFO - PROCESS | 21380 | Number of tests: 6 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#0] dojo.html Cycles:165 Average:5513.82 Median:5749.89 stddev:743.74 (12.9%) stddev-sans-first:722.33 10:31:37 INFO - PROCESS | 21380 | Values: 3139.9 3166.4 3190.6 3204.9 3210.8 5456.8 5565.9 5598.0 5604.2 5632.0 5327.3 5563.4 5596.5 5617.0 5678.0 5031.9 5076.6 5180.5 5218.1 5222.3 693.4 5138.7 5148.9 5163.0 5177.0 5089.3 5105.7 5108.8 5111.8 5155.6 4944.1 5092.0 5134.1 5146.5 5169.4 5008.0 5008.4 5009.8 5017.9 5030.3 5512.4 5570.1 5605.4 5609.4 5637.6 5871.8 5963.5 5974.7 6000.8 6045.2 6005.7 6052.2 6062.7 6070.0 6108.6 5553.3 5576.0 5579.1 5579.5 5581.1 5871.5 6097.0 6104.1 6126.8 6131.1 5921.3 5956.7 5960.4 5964.2 6002.6 6070.7 6071.5 6074.0 6075.4 6079.0 5763.0 5915.1 5925.1 5967.2 5975.1 5719.1 5891.6 5910.7 5964.9 6004.2 4525.7 4526.0 4526.6 4534.8 4574.3 3995.3 3996.2 4004.2 4005.5 4064.8 5720.0 5749.9 5757.4 5762.6 5766.3 6030.9 6090.0 6091.2 6093.9 6117.3 5466.6 5708.1 5715.5 5752.9 5761.5 5045.8 5048.2 5067.2 5075.1 5077.9 6024.8 6269.9 6280.6 6299.2 6306.5 5868.2 5917.8 5934.6 5938.3 5946.4 6104.2 6112.7 6134.0 6141.6 6165.7 5750.9 5793.2 5855.2 5862.3 5884.3 5852.1 5932.2 5948.1 5956.2 6017.7 5718.2 5724.9 5755.1 5766.1 5770.2 5602.4 5713.7 5739.4 5741.0 5766.9 5417.5 5640.8 5654.8 5689.0 5789.2 5837.7 5900.6 5912.9 5927.5 5928.8 5541.3 5707.3 5748.8 5795.2 5806.7 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#1] ext.html Cycles:180 Average:59359.11 Median:43565.06 stddev:111168.76 (255.2%) stddev-sans-first:111393.01 10:31:37 INFO - PROCESS | 21380 | Values: 577.8 633.9 645.2 645.7 650.5 41771.8 43108.6 43192.0 43243.4 47016.8 45011.8 45643.3 45819.1 45844.3 45857.5 9025.1 9059.5 9153.9 9176.3 9176.7 8940.3 9007.4 9010.7 9020.7 9039.2 9050.7 9064.6 9064.8 9141.1 9167.8 9079.2 9087.2 9114.5 9141.0 9151.3 8892.0 8892.9 8928.1 8932.1 8933.2 42648.8 42774.1 43035.1 43035.8 43059.6 3409.5 3516.1 3796.5 3900.9 4238.8 33244.3 33312.0 33542.0 33668.3 34728.0 4395.0 4499.7 4574.7 4588.7 4710.2 343433.0 344630.0 345217.0 346291.0 347449.0 53180.7 58610.7 59964.3 60283.4 60441.0 63982.7 64418.7 64464.7 64708.7 64757.0 16797.6 17056.5 17064.0 17131.1 17145.1 12966.9 13007.9 13080.6 13121.8 13186.5 18468.4 18644.5 18651.9 18786.7 18855.7 6228.1 6316.6 6371.5 6449.0 6507.6 978.6 1034.6 1121.4 1173.5 1182.1 32778.3 32854.8 33017.7 33426.3 33812.7 1077.3 1166.9 1169.7 1182.8 1197.0 16557.3 17011.7 17018.4 17129.1 17343.0 489967.0 491193.0 492805.0 497366.0 497668.0 58162.1 58376.4 58723.4 58977.0 59019.4 1343.9 1361.1 1373.0 1374.4 1391.1 30322.0 31757.5 31819.5 31928.4 32284.5 50038.0 50181.2 50298.7 50533.2 50716.0 400438.0 412608.0 414637.0 414686.0 415131.0 42331.0 42529.6 42611.1 42827.8 44235.0 48089.8 48919.3 49647.5 50047.5 52226.5 40286.6 41217.8 45015.5 45163.5 45993.5 43502.1 43628.0 44036.0 44202.6 44513.0 39070.2 44115.8 44535.6 45287.0 45581.5 38484.0 39222.0 39600.4 39999.0 40073.8 29555.9 30031.7 30329.4 30364.2 30392.5 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#2] jquery.html Cycles:180 Average:29353.08 Median:4734.75 stddev:85895.19 (1814.1%) stddev-sans-first:86108.62 10:31:37 INFO - PROCESS | 21380 | Values: 393.6 395.1 395.5 402.4 411.9 17913.9 19314.7 19650.2 19655.8 20284.4 18004.9 18792.8 18840.2 19772.9 20115.4 5248.7 5255.5 5390.0 5413.1 5414.8 5315.8 5323.4 5324.3 5343.6 5351.3 5247.8 5280.9 5735.5 5742.9 5777.5 5751.0 5759.3 5766.7 5775.8 5783.7 5010.7 5156.4 5184.7 5188.9 5202.3 13740.7 13862.7 14351.6 22998.4 23091.2 2142.8 2312.5 2332.4 2544.3 2670.2 10232.0 10519.7 10538.2 10636.9 10786.2 1898.0 1913.8 1974.8 1977.9 1992.0 79128.6 84000.6 84493.0 86186.1 86794.5 10545.5 10595.4 10857.3 11058.7 11262.5 15383.7 15417.6 15447.6 15489.5 15496.2 8133.7 8331.5 8383.3 8470.0 8534.3 8067.6 8094.2 8148.2 8311.0 8320.4 4626.7 4642.7 4647.8 4705.4 4764.1 1830.8 1889.2 1930.8 1930.9 1942.2 964.1 968.6 1020.9 1062.3 1071.3 16945.0 17442.2 19343.6 19561.6 19698.4 947.6 968.7 974.8 990.8 1004.5 10432.6 10473.7 10573.7 10925.6 10969.7 513894.0 515906.0 525230.0 527149.0 527725.0 57653.0 74314.6 92026.0 92242.5 92405.0 981.7 992.7 1017.3 1047.3 1056.9 15957.6 17107.3 17265.2 17356.1 17429.2 41285.0 41726.8 42076.0 42291.8 43017.6 59331.4 59827.1 60125.7 60217.1 60342.4 8338.9 8406.3 8586.7 8766.3 8859.0 8585.7 8974.6 9185.1 9201.8 9713.5 8256.3 8416.2 8803.1 8824.7 9028.1 8356.0 8692.4 8716.7 8738.0 8855.1 8860.9 8897.4 8902.4 8906.6 9189.8 12762.2 12976.2 13065.4 13072.2 13178.7 12215.9 12443.4 12489.9 12695.1 12790.6 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#3] mootools.html Cycles:180 Average:5887.80 Median:2608.82 stddev:3422.41 (131.2%) stddev-sans-first:3416.01 10:31:37 INFO - PROCESS | 21380 | Values: 1483.7 1498.4 1630.7 1741.2 1742.6 7967.1 8628.7 8674.1 9182.8 9193.1 8877.8 8891.8 8960.3 8964.7 8969.3 2356.9 2368.8 2374.1 2389.5 2392.3 2256.6 2309.3 2329.1 2330.4 2332.8 2318.6 2319.1 2337.2 2346.4 2353.0 2284.9 2307.6 2317.8 2322.9 2330.5 2308.5 2351.0 2360.0 2366.8 2379.3 8975.3 9034.5 9053.9 9061.4 9116.7 5191.6 5258.6 5365.0 5368.2 5403.4 3355.3 3363.4 3456.8 3465.8 3507.9 1104.2 1125.7 1168.3 1182.0 1193.4 12722.3 12749.4 12749.9 12768.4 12788.4 4743.5 4766.7 4774.7 4804.9 4870.1 10560.5 10576.1 10590.8 10591.4 10598.7 5317.9 5353.8 5359.6 5382.8 5410.4 4286.8 4843.4 4866.4 4981.7 4985.6 3996.1 4026.4 4093.4 4134.5 4151.9 1306.3 1311.2 1311.7 1330.1 1331.7 954.5 954.9 964.5 964.7 969.6 5879.3 5946.6 6006.9 6048.9 6052.8 441.0 443.4 444.6 449.4 474.2 3781.3 3869.9 3871.7 3873.1 3878.0 10988.7 11314.6 11402.9 11425.2 11445.2 11026.1 11136.3 11252.2 11286.5 11323.9 8217.2 8260.0 8498.5 8498.8 8506.2 5731.7 5870.4 5943.3 5947.3 5982.5 10077.2 10400.6 10479.8 10486.7 10516.9 10344.2 10435.8 10489.7 10503.5 10524.9 7123.0 7665.2 7852.1 7933.1 7936.3 8877.2 8884.6 8920.0 8936.5 8965.8 7854.0 8002.4 8103.9 8125.5 8142.9 7713.6 7867.6 7873.8 7904.3 7973.4 6396.5 6398.5 6469.0 6477.2 6491.1 5167.4 5194.4 5270.0 5293.5 5340.8 5132.7 5148.6 5176.3 5212.3 5355.5 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#4] prototype.html Cycles:180 Average:4950.44 Median:5637.71 stddev:1472.84 (26.1%) stddev-sans-first:1435.34 10:31:37 INFO - PROCESS | 21380 | Values: 317.9 325.9 329.6 331.4 333.1 5663.2 5698.3 5699.9 5719.7 5721.9 5543.7 5551.5 5565.6 5584.9 5597.0 4110.5 4197.4 4320.0 4338.0 4363.7 4317.4 4334.8 4345.1 4362.4 4362.4 4306.7 4324.6 4331.5 4349.5 4361.3 4253.9 4281.3 4329.0 4342.8 4355.8 3805.3 3823.2 3823.6 3850.1 3874.7 5395.5 5430.5 5458.5 5471.9 5474.9 4827.2 4960.8 4969.9 4977.5 4998.4 5779.7 5813.8 5888.9 5890.3 5940.0 4205.2 4219.3 4224.5 4224.7 4248.9 5922.3 6042.7 6051.0 6055.2 6134.8 4314.9 4338.3 4344.4 4360.7 4362.6 4329.8 4337.6 4358.2 4411.0 4424.5 4707.7 4918.9 4926.9 4937.7 5068.4 5823.7 5825.6 5867.3 5880.7 5938.4 1461.6 1481.3 1481.4 1482.9 1489.7 918.9 939.6 974.5 1010.7 1013.9 5517.9 5568.9 5581.5 5607.3 5625.7 5941.4 5941.9 5993.9 6004.4 6016.5 5287.3 5590.6 5649.8 5685.8 5731.8 3147.9 3152.4 3175.1 3191.9 3209.8 5921.5 6202.4 6233.9 6244.5 6295.9 6220.9 6249.3 6263.8 6304.8 6304.8 6115.9 6287.2 6312.3 6332.9 6418.7 6114.0 6116.5 6138.4 6143.2 6152.4 5994.6 6087.5 6102.3 6107.5 6126.1 6025.2 6238.2 6247.3 6256.7 6266.6 4238.4 4242.2 4253.3 4267.4 4282.8 5977.3 6050.2 6069.0 6072.8 6091.4 5864.8 5896.5 5898.0 5903.4 5919.3 5891.9 5952.4 5972.6 5972.6 5987.7 5565.8 5649.9 5758.4 5810.4 5821.6 5875.7 5887.4 5916.4 5943.8 5977.8 5615.7 5758.3 5781.6 5826.9 5851.3 10:31:37 INFO - PROCESS | 21380 | 10:31:37 INFO - PROCESS | 21380 | [#5] yui.html Cycles:180 Average:20130.85 Median:4728.43 stddev:29054.63 (614.5%) stddev-sans-first:29099.61 10:31:37 INFO - PROCESS | 21380 | Values: 727.8 772.3 791.8 812.9 830.6 15149.6 15248.2 15303.2 15314.4 15428.0 14974.0 15141.5 15150.2 15154.5 15166.8 651.3 765.6 781.3 781.3 787.7 764.6 764.6 771.3 771.7 774.8 833.8 836.8 838.0 838.8 842.6 831.6 835.6 837.0 838.1 840.6 605.9 605.9 610.9 611.0 614.5 14885.7 14890.9 14980.2 15031.3 15050.3 13011.2 13208.4 13246.8 13290.2 13318.9 12184.3 12212.5 12312.6 12389.3 12425.6 3867.3 3882.2 3916.9 3925.5 4074.1 77361.6 79436.0 79573.6 79630.6 80022.0 11469.6 11552.1 11729.0 11805.4 12083.4 22331.3 22644.2 23032.0 23100.3 23140.8 8218.2 8284.9 8306.2 8445.7 8491.9 4591.7 4721.5 4726.2 4730.6 4857.8 3717.7 3883.2 3889.5 3890.7 3901.7 624.9 626.9 638.6 639.3 656.2 669.3 672.8 679.6 702.2 719.6 9505.5 9627.3 9702.3 9723.9 9910.2 747.3 752.3 755.4 767.1 778.0 5010.7 5075.3 5150.8 5156.1 5178.3 107035.0 109231.0 113527.4 114738.4 116651.4 65244.0 70430.6 93884.5 97821.5 102187.0 87193.0 87685.6 88752.6 89230.6 89640.6 8946.2 9067.9 9138.0 9261.6 9513.2 38680.4 45612.5 46429.8 49293.3 50395.5 68450.0 72759.6 74083.0 74300.0 76153.6 11501.6 11605.5 11714.8 11902.8 11911.3 9148.9 12936.4 13039.4 13200.6 13715.6 12078.6 12393.8 12395.4 12507.2 12746.7 12336.4 12456.6 12523.7 12540.3 12545.3 12231.4 12371.2 12449.4 12478.5 12591.4 10393.2 10394.2 10612.4 10757.7 10780.4 10191.5 10613.1 10645.8 10662.3 10696.4 10:31:37 INFO - PROCESS | 21380 | -------- Summary: end -------- 10:31:37 INFO - PROCESS | 21380 | 10:31:38 INFO - TEST-INFO | 21380: exit 0 10:31:38 INFO - TEST-OK | dromaeo_css | took 1111765ms 10:31:38 INFO - TEST-START | kraken 10:31:38 INFO - operating with platform_type : linux_ 10:31:38 INFO - Initialising browser for kraken test... 10:31:38 INFO - TEST-INFO | started process 21619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplifYgS/profile http://localhost:34903/getInfo.html) 10:31:43 INFO - PROCESS | 21619 | __metrics Screen width/height:1600/1200 10:31:43 INFO - PROCESS | 21619 | colorDepth:24 10:31:43 INFO - PROCESS | 21619 | Browser inner width/height: 1024/697 10:31:43 INFO - PROCESS | 21619 | __metrics 10:31:43 ERROR - PROCESS | 21619 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:31:44 INFO - TEST-INFO | 21619: exit 0 10:31:44 INFO - Browser initialized. 10:31:44 INFO - Running cycle 1/1 for kraken test... 10:31:44 INFO - TEST-INFO | started process 21737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplifYgS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:56 INFO - PROCESS | 21737 | RSS: Main: 184688640 10:31:56 INFO - PROCESS | 21737 | 10:31:59 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34903/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:59 INFO - PROCESS | 21737 | RSS: Main: 190693376 10:31:59 INFO - PROCESS | 21737 | 10:32:02 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34903/tests/kraken/driver.html?testName=audio-dft) 10:32:03 INFO - PROCESS | 21737 | RSS: Main: 189456384 10:32:03 INFO - PROCESS | 21737 | 10:32:06 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34903/tests/kraken/driver.html?testName=audio-fft) 10:32:06 INFO - PROCESS | 21737 | RSS: Main: 184762368 10:32:06 INFO - PROCESS | 21737 | 10:32:08 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34903/tests/kraken/driver.html?testName=audio-oscillator) 10:32:09 INFO - PROCESS | 21737 | RSS: Main: 185503744 10:32:09 INFO - PROCESS | 21737 | 10:32:11 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:12 INFO - PROCESS | 21737 | RSS: Main: 185577472 10:32:12 INFO - PROCESS | 21737 | 10:32:15 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34903/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:16 INFO - PROCESS | 21737 | RSS: Main: 185430016 10:32:16 INFO - PROCESS | 21737 | 10:32:19 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34903/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:20 INFO - PROCESS | 21737 | RSS: Main: 186183680 10:32:20 INFO - PROCESS | 21737 | 10:32:22 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34903/tests/kraken/driver.html?testName=json-parse-financial) 10:32:23 INFO - PROCESS | 21737 | RSS: Main: 186048512 10:32:23 INFO - PROCESS | 21737 | 10:32:25 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:25 INFO - PROCESS | 21737 | RSS: Main: 186302464 10:32:25 INFO - PROCESS | 21737 | 10:32:27 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:28 INFO - PROCESS | 21737 | RSS: Main: 186114048 10:32:28 INFO - PROCESS | 21737 | 10:32:30 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:30 INFO - PROCESS | 21737 | RSS: Main: 186347520 10:32:30 INFO - PROCESS | 21737 | 10:32:33 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:34 INFO - PROCESS | 21737 | RSS: Main: 186101760 10:32:34 INFO - PROCESS | 21737 | 10:32:36 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:37 INFO - PROCESS | 21737 | RSS: Main: 185966592 10:32:37 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | Cycle 1(1): loaded http://localhost:34903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34903/tests/kraken/driver.html?testName=ai-astar) 10:32:39 INFO - PROCESS | 21737 | RSS: Main: 186851328 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | __start_tp_report 10:32:39 INFO - PROCESS | 21737 | _x_x_mozilla_page_load 10:32:39 INFO - PROCESS | 21737 | _x_x_mozilla_page_load_details 10:32:39 INFO - PROCESS | 21737 | |i|pagename|runs| 10:32:39 INFO - PROCESS | 21737 | |0;ai-astar;115;106;116;113;112;111;114;110;110;110 10:32:39 INFO - PROCESS | 21737 | |1;audio-beat-detection;160;128;149;173;126;166;159;129;190;127 10:32:39 INFO - PROCESS | 21737 | |2;audio-dft;160;161;162;163;166;167;163;163;163;163 10:32:39 INFO - PROCESS | 21737 | |3;audio-fft;76;74;76;161;77;75;74;76;162;77 10:32:39 INFO - PROCESS | 21737 | |4;audio-oscillator;85;85;146;87;85;85;136;85;85;145 10:32:39 INFO - PROCESS | 21737 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;118;118 10:32:39 INFO - PROCESS | 21737 | |6;imaging-darkroom;147;147;148;147;148;149;148;147;148;147 10:32:39 INFO - PROCESS | 21737 | |7;imaging-desaturate;96;100;95;96;95;95;96;96;94;95 10:32:39 INFO - PROCESS | 21737 | |8;json-parse-financial;59;61;59;61;60;61;66;62;58;58 10:32:39 INFO - PROCESS | 21737 | |9;json-stringify-tinderbox;61;60;62;60;62;60;60;60;61;61 10:32:39 INFO - PROCESS | 21737 | |10;stanford-crypto-aes;86;81;80;80;81;84;80;82;107;81 10:32:39 INFO - PROCESS | 21737 | |11;stanford-crypto-ccm;126;136;129;119;123;121;135;123;140;130 10:32:39 INFO - PROCESS | 21737 | |12;stanford-crypto-pbkdf2;163;171;165;162;167;171;162;179;161;173 10:32:39 INFO - PROCESS | 21737 | |13;stanford-crypto-sha256-iterative;65;63;65;62;66;63;67;64;64;62 10:32:39 INFO - PROCESS | 21737 | __end_tp_report 10:32:39 INFO - PROCESS | 21737 | __start_cc_report 10:32:39 INFO - PROCESS | 21737 | _x_x_mozilla_cycle_collect,902 10:32:39 INFO - PROCESS | 21737 | __end_cc_report 10:32:39 INFO - PROCESS | 21737 | __startTimestamp1465493559521__endTimestamp 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | ------- Summary: start ------- 10:32:39 INFO - PROCESS | 21737 | Number of tests: 14 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.95 (2.6%) stddev-sans-first:2.87 10:32:39 INFO - PROCESS | 21737 | Values: 115.0 106.0 116.0 113.0 112.0 111.0 114.0 110.0 110.0 110.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:159.50 stddev:22.59 (14.2%) stddev-sans-first:23.71 10:32:39 INFO - PROCESS | 21737 | Values: 160.0 128.0 149.0 173.0 126.0 166.0 159.0 129.0 190.0 127.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.08 (1.3%) stddev-sans-first:1.88 10:32:39 INFO - PROCESS | 21737 | Values: 160.0 161.0 162.0 163.0 166.0 167.0 163.0 163.0 163.0 163.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:36.22 (47.7%) stddev-sans-first:37.91 10:32:39 INFO - PROCESS | 21737 | Values: 76.0 74.0 76.0 161.0 77.0 75.0 74.0 76.0 162.0 77.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.00 stddev:27.69 (32.6%) stddev-sans-first:28.64 10:32:39 INFO - PROCESS | 21737 | Values: 85.0 85.0 146.0 87.0 85.0 85.0 136.0 85.0 85.0 145.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:32:39 INFO - PROCESS | 21737 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:32:39 INFO - PROCESS | 21737 | Values: 147.0 147.0 148.0 147.0 148.0 149.0 148.0 147.0 148.0 147.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.62 (1.7%) stddev-sans-first:1.72 10:32:39 INFO - PROCESS | 21737 | Values: 96.0 100.0 95.0 96.0 95.0 95.0 96.0 96.0 94.0 95.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:2.37 (3.9%) stddev-sans-first:2.45 10:32:39 INFO - PROCESS | 21737 | Values: 59.0 61.0 59.0 61.0 60.0 61.0 66.0 62.0 58.0 58.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 10:32:39 INFO - PROCESS | 21737 | Values: 61.0 60.0 62.0 60.0 62.0 60.0 60.0 60.0 61.0 61.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:8.24 (10.2%) stddev-sans-first:8.72 10:32:39 INFO - PROCESS | 21737 | Values: 86.0 81.0 80.0 80.0 81.0 84.0 80.0 82.0 107.0 81.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.50 stddev:7.04 (5.4%) stddev-sans-first:7.42 10:32:39 INFO - PROCESS | 21737 | Values: 126.0 136.0 129.0 119.0 123.0 121.0 135.0 123.0 140.0 130.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:169.00 stddev:5.93 (3.5%) stddev-sans-first:6.07 10:32:39 INFO - PROCESS | 21737 | Values: 163.0 171.0 165.0 162.0 167.0 171.0 162.0 179.0 161.0 173.0 10:32:39 INFO - PROCESS | 21737 | 10:32:39 INFO - PROCESS | 21737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.66 (2.6%) stddev-sans-first:1.73 10:32:39 INFO - PROCESS | 21737 | Values: 65.0 63.0 65.0 62.0 66.0 63.0 67.0 64.0 64.0 62.0 10:32:39 INFO - PROCESS | 21737 | -------- Summary: end -------- 10:32:39 INFO - PROCESS | 21737 | 10:32:40 INFO - TEST-INFO | 21737: exit 0 10:32:40 INFO - TEST-OK | kraken | took 62125ms 10:32:40 INFO - SUITE-END | took 1173s 10:32:40 INFO - Completed test suite (00:19:34) 10:32:40 INFO - javascript benchmark 10:32:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7324.156713995593, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.9324229761883, 3166.3825554016976, 3190.569273148125, 3204.9359012819746, 3210.791298565593, 5456.754446049932, 5565.91651125233, 5597.992361374951, 5604.187392828037, 5632.042552766029, 5327.334083239595, 5563.388027317002, 5596.524295434893, 5616.971915140429, 5677.9716101419535, 5031.924521132177, 5076.593872490211, 5180.481951804827, 5218.13900706383, 5222.3472065991755, 693.3966244032223, 5138.66598671087, 5148.922766158511, 5163.044836705221, 5177.042247184283, 5089.338386009832, 5105.744712764384, 5108.8211912583065, 5111.795528178868, 5155.639105262633, 4944.060628480614, 5092.0, 5134.127198376285, 5146.536811686929, 5169.405518365398, 5008.0, 5008.449070602231, 5009.799608015675, 5017.949820501784, 5030.346055012825, 5512.366077901012, 5570.080936645449, 5605.439456054402, 5609.439056094398, 5637.566558054521, 5871.765129394819, 5963.493103086243, 5974.731137098841, 6000.819975400745, 6045.153678485016, 6005.6997150142315, 6052.243469566304, 6062.666553339564, 6069.969650151766, 6108.633481991094, 5553.305836770403, 5576.0, 5579.107342825169, 5579.46995035471, 5581.107022876401, 5871.500922421642, 6096.980278560413, 6104.065072948782, 6126.785562505291, 6131.110988906584, 5921.348651648402, 5956.7319470623925, 5960.433758792994, 5964.224650795456, 6002.639841609517, 6070.666113363719, 6071.51427885768, 6073.969630151821, 6075.362086980892, 6079.0273556230795, 5762.971185144047, 5915.08316210988, 5925.111233314951, 5967.19442875215, 5975.133605627159, 5719.056355701346, 5891.587588868823, 5910.674912879833, 5964.880702385928, 6004.249468816398, 4525.705829121097, 4526.0, 4526.569975852289, 4534.79593418297, 4574.313852922089, 3995.320795464778, 3996.200759847984, 4004.2391945530258, 4005.5393629732953, 4064.776437295918, 5720.0, 5749.88500229993, 5757.395473475309, 5762.567807414461, 5766.279215098113, 6030.939690603038, 6090.025595904723, 6091.177691011745, 6093.878122437615, 6117.265928088658, 5466.562674985991, 5708.143778433186, 5715.5427565794635, 5752.913706294409, 5761.452661997104, 5045.772940217699, 5048.167052436307, 5067.193007750948, 5075.086484432837, 5077.8730531737, 6024.819255422344, 6269.905951410732, 6280.560360774702, 6299.181106456132, 6306.49548036156, 5868.23712917318, 5917.763289468545, 5934.643921364732, 5938.257717785277, 5946.405359464192, 6104.20645316106, 6112.663803490851, 6134.04922237054, 6141.6007959482495, 6165.72254248551, 5750.913736293875, 5793.15999180125, 5855.238818953509, 5862.325832529314, 5884.323302820059, 5852.092925596539, 5932.228810254639, 5948.078047902582, 5956.195913551615, 6017.669028203491, 5718.228039214653, 5724.942750572608, 5755.107958266475, 5766.07742761173, 5770.2498675171955, 5602.355729091044, 5713.742881570256, 5739.426057394227, 5740.971295143498, 5766.855828604151, 5417.539509141767, 5640.802571909963, 5654.802081927113, 5688.971555142198, 5789.160571716993, 5837.737301821343, 5900.586958912835, 5912.940870591239, 5927.4665280125, 5928.762849486145, 5541.2796336476, 5707.258056452634, 5748.827535173951, 5795.246617939641, 5806.65160090396], "value": 5464.934179797739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8266520043986, 633.8605506788505, 645.1902861908302, 645.7062036773268, 650.4926157597074, 41771.79114104429, 43108.56891431089, 43192.0, 43243.35134972978, 47016.76491617537, 45011.77494112533, 45643.31535026969, 45819.08361832761, 45844.312335315, 45857.54142458575, 9025.097490250955, 9059.505181645054, 9153.908460915405, 9176.265898728087, 9176.72469825903, 8940.329475289347, 9007.414518056337, 9010.68462603809, 9020.729378118634, 9039.186473217409, 9050.683226087089, 9064.637414503444, 9064.77338066547, 9141.131592498736, 9167.816643667122, 9079.182873541413, 9087.182153606174, 9114.544272786366, 9141.040190780006, 9151.267898568098, 8892.0, 8892.911070889273, 8928.107189281085, 8932.062133475956, 8933.240674542672, 42648.78675606633, 42774.14451710948, 43035.13929721419, 43035.78482107569, 43059.56940430618, 3409.5226668266214, 3516.0682419158943, 3796.506454160969, 3900.902477438058, 4238.766867822269, 33244.33511329784, 33312.0, 33542.0, 33668.32663346744, 34728.0, 4394.978025109886, 4499.662525310582, 4574.679772415932, 4588.7476188809605, 4710.24636058229, 343433.0, 344630.0, 345217.0, 346290.9999999975, 347449.0, 53180.73409632927, 58610.706946465, 59964.30160642781, 60283.397166027775, 60441.0, 63982.68008659927, 64418.677906610166, 64464.67767661132, 64708.676456618356, 64757.0, 16797.58006049834, 17056.48830535086, 17064.0, 17131.143442827808, 17145.14274286281, 12966.870331296755, 13007.934960325138, 13080.607581772561, 13121.803172952414, 13186.538471153464, 18468.353607623667, 18644.533886652942, 18651.855036670684, 18786.718199227023, 18855.717164242546, 6228.128062071313, 6316.621002739758, 6371.490280777527, 6448.967755161194, 6507.642079685663, 978.6036655154674, 1034.591336422109, 1121.3664279681955, 1173.501261963662, 1182.0884226040814, 32778.344433111204, 32854.83572582122, 33017.66982330146, 33426.33147337088, 33812.66187338145, 1077.2943721862193, 1166.9066474682006, 1169.6607983684637, 1182.7693599748138, 1196.9940150299192, 16557.337706491606, 17011.744823827652, 17018.404355847735, 17129.143542823058, 17343.0, 489967.0, 491193.0, 492805.0, 497366.0, 497668.0, 58162.127568086515, 58376.416235837096, 58723.41276587179, 58977.0, 59019.40980590225, 1343.9059265851492, 1361.0948719101686, 1373.0388727890318, 1374.4364810427676, 1391.1166409330149, 30322.0, 31757.523637145, 31819.522707158947, 31928.36143277075, 32284.515732264506, 50038.0, 50181.24728129154, 50298.7485062587, 50533.242001369275, 50716.0, 400438.0, 412608.0, 414637.0, 414686.0, 415131.0, 42331.0, 42529.57470425256, 42611.147777044906, 42827.78586107049, 44235.0, 48089.75955120202, 48919.26621100615, 49647.50352496429, 50047.499525004285, 52226.477735222164, 40286.597134028285, 41217.793911030254, 45015.54984450113, 45163.54836451725, 45993.54006459893, 43502.12995740131, 43628.0, 44036.0, 44202.55797441985, 44513.0, 39070.218595628496, 44115.77942110269, 44535.55464445314, 45287.0, 45581.54418455773, 38484.0, 39222.0, 39600.40599390954, 39999.0, 40073.79963100166, 29555.852220738758, 30031.69968300289, 30329.393412132074, 30364.24089397783, 30392.5441118379], "value": 20754.849449223468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6221227621485, 395.0794648469064, 395.4720448201651, 402.3923874948827, 411.87231958092974, 17913.910430447846, 19314.71027934582, 19650.213991440327, 19655.803441965578, 20284.391468255977, 18004.909975450137, 18792.812071879278, 18840.152193151305, 19772.90113549434, 20115.396538103843, 5248.737563121847, 5255.474452554733, 5390.00284947284, 5413.133898576229, 5414.7834086636485, 5315.760790764425, 5323.414424413311, 5324.254604355393, 5343.572514198855, 5351.331083614548, 5247.763850626712, 5280.867978300535, 5735.455131762496, 5742.885142297151, 5777.537796976253, 5750.971245143747, 5759.308882934054, 5766.682832444214, 5775.797847075353, 5783.681897495636, 5010.72441015744, 5156.381234251914, 5184.7407629618365, 5188.92216616751, 5202.3497062867145, 13740.65648358799, 13862.653433664138, 14351.641208969859, 22998.42503937415, 23091.191808286796, 2142.78572142786, 2312.5259321839153, 2332.416895776056, 2544.2621639724457, 2670.198940317897, 10232.0, 10519.73700657482, 10538.20963427746, 10636.893631063667, 10786.191035672357, 1897.990510047441, 1913.770347558288, 1974.8222659960672, 1977.881327120363, 1991.9502012449805, 79128.60435697784, 84000.57999709963, 84492.99999999939, 86186.13813861844, 86794.49041321863, 10545.525451354708, 10595.364278143335, 10857.2942758722, 11058.723531911606, 11262.493187806569, 15383.692326153414, 15417.614559636098, 15447.613809654624, 15489.457868974532, 15496.225188740518, 8133.7153199638915, 8331.458455200514, 8383.287420569199, 8469.957650211833, 8534.27458666008, 8067.556284404414, 8094.190580941859, 8148.185181481923, 8311.0, 8320.37597180214, 4626.676132670681, 4642.698224615389, 4647.837325693585, 4705.411823522059, 4764.094821983812, 1830.8169183081852, 1889.1687657430962, 1930.7972662870197, 1930.8648394612242, 1942.174575805277, 964.0889359555154, 968.5980318167882, 1020.9438480883623, 1062.2670357453333, 1071.2875937501474, 16945.0, 17442.215100320514, 19343.613127737368, 19561.608767824848, 19698.40904772859, 947.5688561704408, 968.6609686609771, 974.8440249560178, 990.7622170678985, 1004.4525733475274, 10432.634857779942, 10473.723902516527, 10573.735656608493, 10925.617603383844, 10969.725756855983, 513894.0, 515906.0, 525230.0, 527149.0, 527725.0, 57653.0, 74314.62842685753, 92026.0, 92242.53878730697, 92405.0, 981.7054883535054, 992.6575331510472, 1017.3133135133755, 1047.3087762076993, 1056.9312994655477, 15957.601059973593, 17107.315707371567, 17265.22306496236, 17356.13219339053, 17429.215685294446, 41285.0, 41726.79136604298, 42076.0, 42291.788541058326, 43017.569824302605, 59331.40668593259, 59827.102593460266, 60125.699371502866, 60217.096743548005, 60342.39657603368, 8338.87491687613, 8406.285465735236, 8586.65653373858, 8766.298696104424, 8858.955705221433, 8585.699500517452, 8974.551272436222, 9185.127412895765, 9201.815963680556, 9713.514324283617, 8256.25693687571, 8416.24253817135, 8803.075677053817, 8824.691135810215, 9028.142326478974, 8355.95822020886, 8692.434991725517, 8716.73849784482, 8737.956310218407, 8855.114488551093, 8860.86708699357, 8897.377183597346, 8902.42134261271, 8906.554672266491, 9189.77025574366, 12762.17045892014, 12976.15654982423, 13065.412056457291, 13072.150310229805, 13178.670533236746, 12215.877841221474, 12443.377831108228, 12489.875101248872, 12695.111342205957, 12790.604697651175], "value": 8924.293345057591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.6513419346452, 1498.423107103765, 1630.7309293966496, 1741.1990484377177, 1742.555648309681, 7967.123616402191, 8628.697995570155, 8674.089220631837, 9182.770430739234, 9193.126652967965, 8877.778055548615, 8891.777705557364, 8960.283177345813, 8964.686235981742, 8969.282457403408, 2356.929292121235, 2368.7868091871815, 2374.1097088591778, 2389.450426401929, 2392.342105920868, 2256.6050941085246, 2309.3072078376504, 2329.0683726509446, 2330.382448651109, 2332.790048895599, 2318.6058370077044, 2319.083961835074, 2337.240396871015, 2346.378209774411, 2352.988235058831, 2284.9146655338745, 2307.619242824932, 2317.8377513574055, 2322.895469703859, 2330.4639932815376, 2308.5267520158327, 2350.97649023511, 2359.9646005309933, 2366.8343215974887, 2379.3456799380137, 8975.326850486173, 9034.503102329369, 9053.90946090544, 9061.365704400694, 9116.680916167968, 5191.5846732261325, 5258.605604579634, 5364.9731751341, 5368.1679339702405, 5403.378611459654, 3355.2786150977413, 3363.360961417323, 3456.7753096048928, 3465.8093804840723, 3507.9123021924656, 1104.1994553948323, 1125.6904351303376, 1168.263993683982, 1182.0484509969472, 1193.4152265389982, 12722.300273484954, 12749.362531873368, 12749.872501274962, 12768.42542085599, 12788.424520896582, 4743.4589887420025, 4766.6901651392545, 4774.737389443614, 4804.855854324376, 4870.0746858096845, 10560.52477638508, 10576.101031412261, 10590.788184236271, 10591.417472038958, 10598.682039538671, 5317.893642127213, 5353.81261655848, 5359.624826262124, 5382.757775900094, 5410.377806552218, 4286.80709368073, 4843.418789745253, 4866.367372241657, 4981.701097934136, 4985.55130038291, 3996.100877302642, 4026.4296924199584, 4093.4269202311702, 4134.49091081753, 4151.916961660811, 1306.3207132291154, 1311.1608570514877, 1311.698309388846, 1330.1487048289102, 1331.660426591213, 954.4511905654276, 954.856771484283, 964.5466630683568, 964.7057647417465, 969.5588507229194, 5879.2944846618675, 5946.643201407929, 6006.879862402728, 6048.939510604838, 6052.757889684452, 441.0495382450824, 443.43240651965533, 444.5532240098745, 449.44044664392385, 474.1796691723338, 3781.2815565042556, 3869.903252418656, 3871.709621778378, 3873.1479074603544, 3877.9612203878164, 10988.670339889815, 11314.642242930737, 11402.94298528502, 11425.200235983568, 11445.198836081394, 11026.06888420382, 11136.276142050741, 11252.212345135926, 11286.492107855167, 11323.886761132448, 8217.178282171735, 8259.95870020658, 8498.490090594583, 8498.830023399621, 8506.234438900405, 5731.684757338387, 5870.383609720918, 5943.286805583358, 5947.256592925884, 5982.46157845796, 10077.244206684381, 10400.647915770902, 10479.790404192026, 10486.685399438029, 10516.894831051592, 10344.224183186141, 10435.791284174426, 10489.737756556147, 10503.527341269813, 10524.894751052698, 7122.964385178041, 7665.156832748505, 7852.13626501073, 7933.087694915159, 7936.2857342839425, 8877.245434137913, 8884.600192991202, 8920.0, 8936.50849203274, 8965.820683586422, 7854.00923124321, 8002.439829211899, 8103.918960810316, 8125.512469251864, 8142.918570814216, 7713.575753333396, 7867.567283799446, 7873.842523149619, 7904.328132108605, 7973.3621310293875, 6396.488280937607, 6398.520110991787, 6469.029645553204, 6477.1579694639395, 6491.05879647439, 5167.379914410144, 5194.428612852507, 5270.021134043773, 5293.523582877559, 5340.759665815125, 5132.666376685504, 5148.562372198405, 5176.3011993381915, 5212.322398088376, 5355.464453554613], "value": 4611.000717733414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.94753865612176, 325.9234079991203, 329.6275209013814, 331.4266319267668, 333.12554544321154, 5663.207150998864, 5698.316202055754, 5699.91952937178, 5719.684472571306, 5721.914171287434, 5543.695096769676, 5551.500364967153, 5565.638233514829, 5584.86037849053, 5596.964561556115, 4110.527289361717, 4197.412362269285, 4319.956800431987, 4338.0, 4363.672724545656, 4317.352397140423, 4334.826606935719, 4345.130973805236, 4362.389265502832, 4362.411074504948, 4306.655467562588, 4324.6107850293465, 4331.480222373304, 4349.499807522144, 4361.323994780798, 4253.914921701564, 4281.336392859096, 4328.956710432918, 4342.848000320006, 4355.80398882051, 3805.3340665383726, 3823.1589050409143, 3823.5794062653085, 3850.1144736710435, 3874.748141370802, 5395.487428694268, 5430.456954304577, 5458.4541545845495, 5471.945280547184, 5474.863128421821, 4827.227643577046, 4960.776765045582, 4969.906620543475, 4977.477364876672, 4998.40019197695, 5779.659238008613, 5813.8372325535065, 5888.852778680567, 5890.263717035371, 5940.0, 4205.243056249874, 4219.324908014733, 4224.4930608327195, 4224.683148763825, 4248.872533823959, 5922.3485416604135, 6042.667653279068, 6050.952272929019, 6055.212822333113, 6134.785282515135, 4314.913701725948, 4338.349247612883, 4344.370066340363, 4360.694751367438, 4362.585554372329, 4329.848455304049, 4337.566243375637, 4358.150160718629, 4410.955890441054, 4424.535423780521, 4707.693999889996, 4918.926216106761, 4926.8768280793265, 4937.716193789569, 5068.391792984792, 5823.708814559255, 5825.621334613236, 5867.2959244890035, 5880.7353669085, 5938.435848594377, 1461.5615315405337, 1481.3482067890093, 1481.3926290221173, 1482.9110253384831, 1489.7392956232616, 918.93108016899, 939.6053657463882, 974.512743628186, 1010.7264846293576, 1013.8580598716186, 5517.944820551824, 5568.94190103879, 5581.49766521015, 5607.327120745536, 5625.662460252316, 5941.435563621449, 5941.940580594139, 5993.880122397615, 6004.399560044048, 6016.548758843104, 5287.3126493556365, 5590.580706447033, 5649.757053448235, 5685.800996965087, 5731.77072917087, 3147.882501711905, 3152.385284869474, 3175.1109689287036, 3191.856366463515, 3209.7642407673216, 5921.496672782861, 6202.44178023971, 6233.906491402633, 6244.501319683243, 6295.905561416583, 6220.937790622036, 6249.281332646713, 6263.812085637438, 6304.810855674337, 6304.8423789404715, 6115.877682446326, 6287.245530536365, 6312.274088479883, 6332.936670633235, 6418.74325027003, 6114.0, 6116.483022262306, 6138.447539721446, 6143.170671959407, 6152.431130061985, 5994.610350327215, 6087.482563982111, 6102.291358419649, 6107.54193435503, 6126.142340072304, 6025.216721826135, 6238.189035425366, 6247.312795592572, 6256.718447669957, 6266.592671476339, 4238.385434111975, 4242.17277630859, 4253.29868052769, 4267.402563641155, 4282.78586070689, 5977.3126090500145, 6050.2437195350585, 6069.0, 6072.757089716361, 6091.360407157184, 5864.824055278348, 5896.528277737856, 5897.997340452219, 5903.406080358365, 5919.260092488439, 5891.882162356815, 5952.404759524013, 5972.611780234444, 5972.641641501524, 5987.670678112746, 5565.777368905198, 5649.943500564942, 5758.424157584208, 5810.448007439287, 5821.592488525763, 5875.706214689334, 5887.352391236875, 5916.437938395846, 5943.821685349447, 5977.820665380045, 5615.6630602164005, 5758.2514273144225, 5781.566382521243, 5826.912596311144, 5851.327097383855], "value": 4470.977620693175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.8180454886278, 772.2586317135549, 791.8099656082542, 812.8902598149248, 830.5971603772169, 15149.621259468506, 15248.161351125684, 15303.15832629205, 15314.387424503035, 15428.0, 14974.0, 15141.54575362738, 15150.242487875617, 15154.545363639108, 15166.848331516681, 651.2673242602073, 765.5636287316232, 781.3007358414202, 781.3436713160944, 787.7321710618388, 764.6100488750749, 764.6215123513869, 771.2595907928395, 771.6836097200149, 774.802425381527, 833.7832163637437, 836.7991681996338, 838.0, 838.8364268967554, 842.5955541340161, 831.6382373667444, 835.5529791561515, 836.958152092393, 838.0990435282066, 840.5503055865144, 605.8909396308662, 605.9454649081604, 610.9327973922865, 611.0315150486484, 614.5083932853744, 14885.702285954329, 14890.925545372313, 14980.176090315028, 15031.323590438456, 15050.32273547693, 13011.21932684042, 13208.405621747044, 13246.805111821106, 13290.202587844664, 13318.86681133186, 12184.268943863308, 12212.450439730233, 12312.569060082855, 12389.318587477685, 12425.62723118308, 3867.2652196082654, 3882.2235552889533, 3916.8824935251987, 3925.509311336083, 4074.124063326369, 77361.61319193368, 79435.99999999942, 79573.60213198897, 79630.6018469904, 80022.0, 11469.598564050219, 11552.133589980785, 11729.0, 11805.350705711267, 12083.395830208454, 22331.330060098222, 22644.207452739403, 23032.0, 23100.306990790305, 23140.76859231386, 8218.21926916942, 8284.875726864102, 8306.210909963544, 8445.746627601182, 8491.915080849236, 4591.701539399928, 4721.457032441244, 4726.220173671306, 4730.645201609893, 4857.80568777252, 3717.70258379329, 3883.1845312484693, 3889.4749208857006, 3890.688744900401, 3901.7463864848696, 624.9437550620376, 626.8816352400603, 638.6200210874522, 639.335091504839, 656.2256537286048, 669.2872091222929, 672.8452455935162, 679.5718697220818, 702.1644243350397, 719.5502810743285, 9505.524723763923, 9627.326087173831, 9702.27232957531, 9723.854142187873, 9910.157636600825, 747.3274053351918, 752.3266676324658, 755.3654929858944, 767.0718430698805, 777.9572123533147, 5010.69935803853, 5075.3402057733, 5150.819721309811, 5156.123459011977, 5178.275041494194, 107035.0, 109231.0, 113527.43236283766, 114738.42630786792, 116651.41674291744, 65244.0, 70430.64784676147, 93884.53057734668, 97821.51089244508, 102187.0, 87193.0, 87685.56157219173, 88752.5562372184, 89230.55384723164, 89640.5517972406, 8946.194842464209, 9067.863982040406, 9138.0, 9261.583228754856, 9513.23894088485, 38680.41979370255, 45612.543874560826, 46429.767851160526, 49293.2606010903, 50395.49604503908, 68450.0, 72759.63620181865, 74083.0, 74300.0, 76153.61923190349, 11501.597444089417, 11605.535778568763, 11714.76570468603, 11902.761944760883, 11911.285322880654, 9148.908510914805, 12936.417861196456, 13039.413226405024, 13200.603981880558, 13715.588532344045, 12078.577249796566, 12393.75212495727, 12395.380230988234, 12507.187032842836, 12746.681332966378, 12336.444859981142, 12456.626301210978, 12523.686907827378, 12540.310282934526, 12545.31000794965, 12231.449584768528, 12371.21635652113, 12449.37753112359, 12478.452972994235, 12591.433385497492, 10393.220508461744, 10394.22043346737, 10612.363258204532, 10757.731056723644, 10780.353178809297, 10191.54138063774, 10613.09788667941, 10645.787084258427, 10662.253642244968, 10696.358218506915], "value": 7396.50259573007, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 106.0, 116.0, 113.0, 112.0, 111.0, 114.0, 110.0, 110.0, 110.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 149.0, 173.0, 126.0, 166.0, 159.0, 129.0, 190.0, 127.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 163.0, 166.0, 167.0, 163.0, 163.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 161.0, 77.0, 75.0, 74.0, 76.0, 162.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 87.0, 85.0, 85.0, 136.0, 85.0, 85.0, 145.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 61.0, 60.0, 61.0, 66.0, 62.0, 58.0, 58.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 80.0, 80.0, 81.0, 84.0, 80.0, 82.0, 107.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 129.0, 119.0, 123.0, 121.0, 135.0, 123.0, 140.0, 130.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 165.0, 162.0, 167.0, 171.0, 162.0, 179.0, 161.0, 173.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 66.0, 63.0, 67.0, 64.0, 64.0, 62.0], "value": 64.1, "unit": "score"}]}]} 10:32:40 INFO - Return code: 0 10:32:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:40 ERROR - # TBPL SUCCESS # 10:32:40 INFO - Running post-action listener: _resource_record_post_action 10:32:40 INFO - ##### 10:32:40 INFO - ##### Finished run-tests step (success) 10:32:40 INFO - ##### 10:32:40 INFO - Running post-run listener: _resource_record_post_run 10:32:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 32768; Write bytes: 542425088; Read time: 340; Write time: 597868 10:32:40 INFO - TinderboxPrint: CPU usage
13.4% 10:32:40 INFO - TinderboxPrint: I/O read bytes / time
32,768 / 340 10:32:40 INFO - TinderboxPrint: I/O write bytes / time
542,425,088 / 597,868 10:32:40 INFO - TinderboxPrint: CPU idle
8,229.5 (86.5%) 10:32:40 INFO - TinderboxPrint: CPU user
1,220.9 (12.8%) 10:32:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255221760; Read time: 0; Write time: 357468 10:32:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 32768; Write bytes: 287203328; Read time: 340; Write time: 240400 10:32:41 INFO - Running post-run listener: _upload_blobber_files 10:32:41 INFO - Blob upload gear active. 10:32:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:41 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 10:32:41 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'] 10:32:41 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 10:32:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:43 INFO - (blobuploader) - INFO - Done attempting. 10:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:44 INFO - (blobuploader) - INFO - Done attempting. 10:32:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:52 INFO - (blobuploader) - INFO - Done attempting. 10:32:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:52 INFO - Return code: 0 10:32:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/28d3059e32df77ee97ade0e7b8df0d55eb930ed8f521ec5a7695676bb2d1dd4fd1334a4011dc3df5f96be3b98c1a6ecd7bb77903f44508b80b41e46e93d95134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b7ecd90c39a7e561995dd59260d780fb92cfa6e623c2a211e5276b946217e7a7dbc3a58b1c3cb3343ed2cffc3a79150ad77b431d9983bcaf676d73bf02ccd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0c94fc2202d67b79365de5b956f2c9f2b7dd59ab9cf4f69c9cefea56cf66f4e89b6c00408b13553ba5ea38de87cf5731534fb632624956fbb6622e79a780d144"} 10:32:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:52 INFO - Contents: 10:32:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/28d3059e32df77ee97ade0e7b8df0d55eb930ed8f521ec5a7695676bb2d1dd4fd1334a4011dc3df5f96be3b98c1a6ecd7bb77903f44508b80b41e46e93d95134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b7ecd90c39a7e561995dd59260d780fb92cfa6e623c2a211e5276b946217e7a7dbc3a58b1c3cb3343ed2cffc3a79150ad77b431d9983bcaf676d73bf02ccd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0c94fc2202d67b79365de5b956f2c9f2b7dd59ab9cf4f69c9cefea56cf66f4e89b6c00408b13553ba5ea38de87cf5731534fb632624956fbb6622e79a780d144"} 10:32:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:52 INFO - Copying logs to upload dir... 10:32:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.853022 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 10:32:51.978892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 10:32:51.983093) ========= 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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/28d3059e32df77ee97ade0e7b8df0d55eb930ed8f521ec5a7695676bb2d1dd4fd1334a4011dc3df5f96be3b98c1a6ecd7bb77903f44508b80b41e46e93d95134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b7ecd90c39a7e561995dd59260d780fb92cfa6e623c2a211e5276b946217e7a7dbc3a58b1c3cb3343ed2cffc3a79150ad77b431d9983bcaf676d73bf02ccd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0c94fc2202d67b79365de5b956f2c9f2b7dd59ab9cf4f69c9cefea56cf66f4e89b6c00408b13553ba5ea38de87cf5731534fb632624956fbb6622e79a780d144"} build_url:https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/eVRnRt2ITqSp-m7wwzY4pQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/28d3059e32df77ee97ade0e7b8df0d55eb930ed8f521ec5a7695676bb2d1dd4fd1334a4011dc3df5f96be3b98c1a6ecd7bb77903f44508b80b41e46e93d95134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b7ecd90c39a7e561995dd59260d780fb92cfa6e623c2a211e5276b946217e7a7dbc3a58b1c3cb3343ed2cffc3a79150ad77b431d9983bcaf676d73bf02ccd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0c94fc2202d67b79365de5b956f2c9f2b7dd59ab9cf4f69c9cefea56cf66f4e89b6c00408b13553ba5ea38de87cf5731534fb632624956fbb6622e79a780d144"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 10:32:52.015234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:32:52.015846) ========= 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=62c568580acbfdaac3eec7be000001dc-1465492332.38467-1992814900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:32:52.067655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 10:32:52.068168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 10:32:52.068668) ========= ========= Total master_lag: 0.14 =========