builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1465266724.51 results: success (0) buildid: 20160606163258 builduid: 8bb8abab14924da786beeb17122dab3e revision: aa8cdba912d328070bf56330a3abe5b86e9cd136 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.513028) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.513511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.513787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.529078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.529358) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 19:32:04-- 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% 42.0M=0s 2016-06-06 19:32:05 (42.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.636870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.637319) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016376 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:04.689244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 19:32:04.689918) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aa8cdba912d328070bf56330a3abe5b86e9cd136 --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 aa8cdba912d328070bf56330a3abe5b86e9cd136 --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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 19:32:05,140 truncating revision to first 12 chars 2016-06-06 19:32:05,140 Setting DEBUG logging. 2016-06-06 19:32:05,140 attempt 1/10 2016-06-06 19:32:05,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/aa8cdba912d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 19:32:06,466 unpacking tar archive at: mozilla-inbound-aa8cdba912d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.706901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 19:32:06.412953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:06.413287) ========= script_repo_revision: aa8cdba912d328070bf56330a3abe5b86e9cd136 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:06.413732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:06.414102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 19:32:06.429492) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 19:32:06.429761) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:32:06 INFO - MultiFileLogger online at 20160606 19:32:06 in /builds/slave/test 19:32:06 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 19:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:32:06 INFO - {'append_to_log': False, 19:32:06 INFO - 'base_work_dir': '/builds/slave/test', 19:32:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:32:06 INFO - 'branch': 'Mozilla-Inbound', 19:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:32:06 INFO - 'config_files': ('talos/linux_config.py',), 19:32:06 INFO - 'default_actions': ('clobber', 19:32:06 INFO - 'read-buildbot-config', 19:32:06 INFO - 'download-and-extract', 19:32:06 INFO - 'populate-webroot', 19:32:06 INFO - 'create-virtualenv', 19:32:06 INFO - 'install', 19:32:06 INFO - 'run-tests'), 19:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:32:06 INFO - 'download_minidump_stackwalk': True, 19:32:06 INFO - 'download_symbols': 'ondemand', 19:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:32:06 INFO - 'installer_path': 'installer.exe', 19:32:06 INFO - 'log_level': 'info', 19:32:06 INFO - 'log_name': 'talos', 19:32:06 INFO - 'log_to_console': True, 19:32:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:32:06 INFO - 'opt_config_files': (), 19:32:06 INFO - 'pip_index': False, 19:32:06 INFO - 'sps_profile': False, 19:32:06 INFO - 'sps_profile_interval': 0, 19:32:06 INFO - 'suite': 'dromaeojs-e10s', 19:32:06 INFO - 'system_bits': '32', 19:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:32:06 INFO - 'title': 'talos-linux64-ix-005', 19:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:32:06 INFO - 'use_talos_json': True, 19:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:32:06 INFO - 'work_dir': 'build'} 19:32:06 INFO - ##### 19:32:06 INFO - ##### Running clobber step. 19:32:06 INFO - ##### 19:32:06 INFO - Running pre-action listener: _resource_record_pre_action 19:32:06 INFO - Running main action method: clobber 19:32:06 INFO - rmtree: /builds/slave/test/build 19:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:32:07 INFO - Running post-action listener: _resource_record_post_action 19:32:07 INFO - ##### 19:32:07 INFO - ##### Finished clobber step (success) 19:32:07 INFO - ##### 19:32:07 INFO - ##### 19:32:07 INFO - ##### Running read-buildbot-config step. 19:32:07 INFO - ##### 19:32:07 INFO - Running pre-action listener: _resource_record_pre_action 19:32:07 INFO - Running main action method: read_buildbot_config 19:32:07 INFO - Using buildbot properties: 19:32:07 INFO - { 19:32:07 INFO - "project": "", 19:32:07 INFO - "product": "firefox", 19:32:07 INFO - "script_repo_revision": "production", 19:32:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:32:07 INFO - "repository": "", 19:32:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:32:07 INFO - "buildid": "20160606163258", 19:32:07 INFO - "pgo_build": "True", 19:32:07 INFO - "basedir": "/builds/slave/test", 19:32:07 INFO - "buildnumber": 813, 19:32:07 INFO - "slavename": "talos-linux64-ix-005", 19:32:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:32:07 INFO - "platform": "ubuntu64_hw", 19:32:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:32:07 INFO - "branch": "mozilla-inbound", 19:32:07 INFO - "repo_path": "integration/mozilla-inbound", 19:32:07 INFO - "revision": "aa8cdba912d328070bf56330a3abe5b86e9cd136", 19:32:07 INFO - "stage_platform": "linux64-pgo", 19:32:07 INFO - "builduid": "8bb8abab14924da786beeb17122dab3e", 19:32:07 INFO - "slavebuilddir": "test" 19:32:07 INFO - } 19:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:32:07 INFO - Running post-action listener: _resource_record_post_action 19:32:07 INFO - ##### 19:32:07 INFO - ##### Finished read-buildbot-config step (success) 19:32:07 INFO - ##### 19:32:07 INFO - ##### 19:32:07 INFO - ##### Running download-and-extract step. 19:32:07 INFO - ##### 19:32:07 INFO - Running pre-action listener: _resource_record_pre_action 19:32:07 INFO - Running main action method: download_and_extract 19:32:07 INFO - mkdir: /builds/slave/test/build/tests 19:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:07 INFO - https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:32:09 INFO - Downloaded 1361 bytes. 19:32:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:32:09 INFO - Using the following test package requirements: 19:32:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:32:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:32:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'jsshell-linux-x86_64.zip'], 19:32:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:32:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:32:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:32:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:32:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:32:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:09 INFO - https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:10 INFO - Downloaded 24442233 bytes. 19:32:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:32:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:32:11 INFO - Return code: 0 19:32:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:11 INFO - https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:12 INFO - Downloaded 24442233 bytes. 19:32:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:32:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:32:14 INFO - Return code: 0 19:32: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')]} 19:32:14 INFO - https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:32:15 INFO - Downloaded 10833369 bytes. 19:32:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:32:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:32:15 INFO - Return code: 0 19:32: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')]} 19:32:15 INFO - https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:32:16 INFO - Downloaded 59151283 bytes. 19:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:32:16 INFO - mkdir: /builds/slave/test/properties 19:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:16 INFO - Contents: 19:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:32:17 INFO - Running post-action listener: _resource_record_post_action 19:32:17 INFO - Running post-action listener: set_extra_try_arguments 19:32:17 INFO - ##### 19:32:17 INFO - ##### Finished download-and-extract step (success) 19:32:17 INFO - ##### 19:32:17 INFO - ##### 19:32:17 INFO - ##### Running populate-webroot step. 19:32:17 INFO - ##### 19:32:17 INFO - Running pre-action listener: _resource_record_pre_action 19:32:17 INFO - Running main action method: populate_webroot 19:32:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:17 INFO - '--tppagecycles', 19:32:17 INFO - '7'], 19:32:17 INFO - 'tests': ['tsvgm']}}, 19:32:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:32:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:32:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:32:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['damp', 'tps']}, 19:32:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'tests': ['damp', 'tps']}, 19:32:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['dromaeo_dom']}, 19:32:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:32:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['a11yr', 19:32:17 INFO - 'ts_paint', 19:32:17 INFO - 'tpaint', 19:32:17 INFO - 'sessionrestore', 19:32:17 INFO - 'sessionrestore_no_auto_restore', 19:32:17 INFO - 'tabpaint']}, 19:32:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['tsvgx', 19:32:17 INFO - 'tsvgr_opacity', 19:32:17 INFO - 'tart', 19:32:17 INFO - 'tscrollx', 19:32:17 INFO - 'cart']}, 19:32:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:32:17 INFO - 'tsvgr_opacity', 19:32:17 INFO - 'tart', 19:32:17 INFO - 'tscrollx', 19:32:17 INFO - 'cart']}, 19:32:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'talos_options': ['--disable-e10s'], 19:32:17 INFO - 'tests': ['tp5o']}, 19:32:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'tests': ['tp5o']}, 19:32:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'talos_options': ['--disable-e10s', 19:32:17 INFO - '--xperf_path', 19:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:17 INFO - 'tests': ['tp5n']}, 19:32:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:17 INFO - 'talos_options': ['--xperf_path', 19:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:17 INFO - 'tests': ['tp5n']}}, 19:32:17 INFO - 'talos.zip': {'path': '', 19:32:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:17 INFO - Running post-action listener: _resource_record_post_action 19:32:17 INFO - ##### 19:32:17 INFO - ##### Finished populate-webroot step (success) 19:32:17 INFO - ##### 19:32:17 INFO - ##### 19:32:17 INFO - ##### Running create-virtualenv step. 19:32:17 INFO - ##### 19:32:17 INFO - Running pre-action listener: _resource_record_pre_action 19:32:17 INFO - Running main action method: create_virtualenv 19:32:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:17 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 19:32:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:17 INFO - Using real prefix '/usr' 19:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:17 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:19 INFO - Installing pip.................done. 19:32:19 INFO - Return code: 0 19:32:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:19 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:19 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 19:32:19 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 19:32:19 INFO - Using env: {'DISPLAY': ':0', 19:32:19 INFO - 'HOME': '/home/cltbld', 19:32:19 INFO - 'LANG': 'en_US.UTF-8', 19:32:19 INFO - 'LANGUAGE': 'en_US:en', 19:32:19 INFO - 'LOGNAME': 'cltbld', 19:32:19 INFO - 'MAIL': '/var/mail/cltbld', 19:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:19 INFO - 'MOZ_NO_REMOTE': '1', 19:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:19 INFO - 'NO_EM_RESTART': '1', 19:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:19 INFO - 'PWD': '/builds/slave/test', 19:32:19 INFO - 'SHELL': '/bin/bash', 19:32:19 INFO - 'SHLVL': '1', 19:32:19 INFO - 'TERM': 'linux', 19:32:19 INFO - 'TMOUT': '86400', 19:32:19 INFO - 'USER': 'cltbld', 19:32:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:19 INFO - '_': '/tools/buildbot/bin/python'} 19:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:20 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 19:32:20 INFO - Cleaning up... 19:32:20 INFO - Return code: 0 19:32:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:32:20 INFO - Using env: {'DISPLAY': ':0', 19:32:20 INFO - 'HOME': '/home/cltbld', 19:32:20 INFO - 'LANG': 'en_US.UTF-8', 19:32:20 INFO - 'LANGUAGE': 'en_US:en', 19:32:20 INFO - 'LOGNAME': 'cltbld', 19:32:20 INFO - 'MAIL': '/var/mail/cltbld', 19:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:20 INFO - 'MOZ_NO_REMOTE': '1', 19:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:20 INFO - 'NO_EM_RESTART': '1', 19:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:20 INFO - 'PWD': '/builds/slave/test', 19:32:20 INFO - 'SHELL': '/bin/bash', 19:32:20 INFO - 'SHLVL': '1', 19:32:20 INFO - 'TERM': 'linux', 19:32:20 INFO - 'TMOUT': '86400', 19:32:20 INFO - 'USER': 'cltbld', 19:32:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:20 INFO - '_': '/tools/buildbot/bin/python'} 19:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:20 INFO - Downloading/unpacking psutil>=3.1.1 19:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:22 INFO - Installing collected packages: psutil 19:32:22 INFO - Running setup.py install for psutil 19:32:22 INFO - building 'psutil._psutil_linux' extension 19:32:22 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 19:32:22 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 19:32:22 INFO - building 'psutil._psutil_posix' extension 19:32:22 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 19:32:22 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 19:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:22 INFO - Successfully installed psutil 19:32:22 INFO - Cleaning up... 19:32:22 INFO - Return code: 0 19:32:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:32:22 INFO - Using env: {'DISPLAY': ':0', 19:32:22 INFO - 'HOME': '/home/cltbld', 19:32:22 INFO - 'LANG': 'en_US.UTF-8', 19:32:22 INFO - 'LANGUAGE': 'en_US:en', 19:32:22 INFO - 'LOGNAME': 'cltbld', 19:32:22 INFO - 'MAIL': '/var/mail/cltbld', 19:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:22 INFO - 'MOZ_NO_REMOTE': '1', 19:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:22 INFO - 'NO_EM_RESTART': '1', 19:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:22 INFO - 'PWD': '/builds/slave/test', 19:32:22 INFO - 'SHELL': '/bin/bash', 19:32:22 INFO - 'SHLVL': '1', 19:32:22 INFO - 'TERM': 'linux', 19:32:22 INFO - 'TMOUT': '86400', 19:32:22 INFO - 'USER': 'cltbld', 19:32:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:22 INFO - '_': '/tools/buildbot/bin/python'} 19:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:32:23 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 19:32:23 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 19:32:23 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 19:32:23 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 19:32:23 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 19:32:23 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 19:32:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:32:25 INFO - Installing collected packages: mozsystemmonitor 19:32:25 INFO - Running setup.py install for mozsystemmonitor 19:32:25 INFO - Successfully installed mozsystemmonitor 19:32:25 INFO - Cleaning up... 19:32:25 INFO - Return code: 0 19:32:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:32:25 INFO - Using env: {'DISPLAY': ':0', 19:32:25 INFO - 'HOME': '/home/cltbld', 19:32:25 INFO - 'LANG': 'en_US.UTF-8', 19:32:25 INFO - 'LANGUAGE': 'en_US:en', 19:32:25 INFO - 'LOGNAME': 'cltbld', 19:32:25 INFO - 'MAIL': '/var/mail/cltbld', 19:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:25 INFO - 'MOZ_NO_REMOTE': '1', 19:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:25 INFO - 'NO_EM_RESTART': '1', 19:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:25 INFO - 'PWD': '/builds/slave/test', 19:32:25 INFO - 'SHELL': '/bin/bash', 19:32:25 INFO - 'SHLVL': '1', 19:32:25 INFO - 'TERM': 'linux', 19:32:25 INFO - 'TMOUT': '86400', 19:32:25 INFO - 'USER': 'cltbld', 19:32:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:25 INFO - '_': '/tools/buildbot/bin/python'} 19:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:32:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32: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 19:32:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:32:27 INFO - warning: no files found matching '*.txt' 19:32:27 INFO - no previously-included directories found matching 'build' 19:32:27 INFO - no previously-included directories found matching 'dist' 19:32:27 INFO - no previously-included directories found matching '.git*' 19:32:27 INFO - Installing collected packages: jsonschema, functools32 19:32:27 INFO - Running setup.py install for functools32 19:32:27 INFO - warning: no files found matching '*.txt' 19:32:27 INFO - no previously-included directories found matching 'build' 19:32:27 INFO - no previously-included directories found matching 'dist' 19:32:27 INFO - no previously-included directories found matching '.git*' 19:32:27 INFO - Successfully installed jsonschema functools32 19:32:27 INFO - Cleaning up... 19:32:27 INFO - Return code: 0 19:32:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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', '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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:32: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 blobuploader==1.2.4 19:32:27 INFO - Using env: {'DISPLAY': ':0', 19:32:27 INFO - 'HOME': '/home/cltbld', 19:32:27 INFO - 'LANG': 'en_US.UTF-8', 19:32:27 INFO - 'LANGUAGE': 'en_US:en', 19:32:27 INFO - 'LOGNAME': 'cltbld', 19:32:27 INFO - 'MAIL': '/var/mail/cltbld', 19:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:27 INFO - 'MOZ_NO_REMOTE': '1', 19:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:27 INFO - 'NO_EM_RESTART': '1', 19:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:27 INFO - 'PWD': '/builds/slave/test', 19:32:27 INFO - 'SHELL': '/bin/bash', 19:32:27 INFO - 'SHLVL': '1', 19:32:27 INFO - 'TERM': 'linux', 19:32:27 INFO - 'TMOUT': '86400', 19:32:27 INFO - 'USER': 'cltbld', 19:32:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:27 INFO - '_': '/tools/buildbot/bin/python'} 19:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:28 INFO - Downloading/unpacking blobuploader==1.2.4 19:32:28 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 19:32:28 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 19:32:28 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 19:32:28 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 19:32:28 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 19:32:28 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 19:32:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:32:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 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 19:32:30 INFO - Downloading docopt-0.6.1.tar.gz 19:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:30 INFO - Running setup.py install for blobuploader 19:32:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:30 INFO - Running setup.py install for requests 19:32:31 INFO - Running setup.py install for docopt 19:32:31 INFO - Successfully installed blobuploader requests docopt 19:32:31 INFO - Cleaning up... 19:32:31 INFO - Return code: 0 19:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:31 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:31 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 19:32:31 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 19:32:31 INFO - Using env: {'DISPLAY': ':0', 19:32:31 INFO - 'HOME': '/home/cltbld', 19:32:31 INFO - 'LANG': 'en_US.UTF-8', 19:32:31 INFO - 'LANGUAGE': 'en_US:en', 19:32:31 INFO - 'LOGNAME': 'cltbld', 19:32:31 INFO - 'MAIL': '/var/mail/cltbld', 19:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:31 INFO - 'MOZ_NO_REMOTE': '1', 19:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:31 INFO - 'NO_EM_RESTART': '1', 19:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:31 INFO - 'PWD': '/builds/slave/test', 19:32:31 INFO - 'SHELL': '/bin/bash', 19:32:31 INFO - 'SHLVL': '1', 19:32:31 INFO - 'TERM': 'linux', 19:32:31 INFO - 'TMOUT': '86400', 19:32:31 INFO - 'USER': 'cltbld', 19:32:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:31 INFO - '_': '/tools/buildbot/bin/python'} 19:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:31 INFO - Running setup.py (path:/tmp/pip-uhCZAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:31 INFO - Running setup.py (path:/tmp/pip-n36Nh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:31 INFO - Running setup.py (path:/tmp/pip-oYnC7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:31 INFO - Running setup.py (path:/tmp/pip-0UNuUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:31 INFO - Running setup.py (path:/tmp/pip-hrjSAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:31 INFO - Running setup.py (path:/tmp/pip-mqOH9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:31 INFO - Running setup.py (path:/tmp/pip-PqVEPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:32 INFO - Running setup.py (path:/tmp/pip-01L_zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:32 INFO - Running setup.py (path:/tmp/pip-PtBRS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:32 INFO - Running setup.py (path:/tmp/pip-wk6JpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:32 INFO - Running setup.py (path:/tmp/pip-avQKom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:32 INFO - Running setup.py (path:/tmp/pip-WfF2Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:32 INFO - Running setup.py (path:/tmp/pip-B2a1uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:32 INFO - Running setup.py (path:/tmp/pip-3STjbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:32 INFO - Running setup.py (path:/tmp/pip-dgaBb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:32 INFO - Running setup.py (path:/tmp/pip-SPdyeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:32 INFO - Running setup.py (path:/tmp/pip-Zy39TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:32 INFO - Running setup.py install for manifestparser 19:32:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:32 INFO - Running setup.py install for mozcrash 19:32:32 INFO - Running setup.py install for mozdebug 19:32:33 INFO - Running setup.py install for mozdevice 19:32:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for mozfile 19:32:33 INFO - Running setup.py install for mozhttpd 19:32:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for mozinfo 19:32:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for mozInstall 19:32:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for mozleak 19:32:33 INFO - Running setup.py install for mozlog 19:32:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for moznetwork 19:32:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:33 INFO - Running setup.py install for mozprocess 19:32:33 INFO - Running setup.py install for mozprofile 19:32:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:34 INFO - Running setup.py install for mozrunner 19:32:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:34 INFO - Running setup.py install for mozscreenshot 19:32:34 INFO - Running setup.py install for moztest 19:32:34 INFO - Running setup.py install for mozversion 19:32:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:34 INFO - Cleaning up... 19:32:34 INFO - Return code: 0 19:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:34 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:34 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 19:32:34 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 19:32:34 INFO - Using env: {'DISPLAY': ':0', 19:32:34 INFO - 'HOME': '/home/cltbld', 19:32:34 INFO - 'LANG': 'en_US.UTF-8', 19:32:34 INFO - 'LANGUAGE': 'en_US:en', 19:32:34 INFO - 'LOGNAME': 'cltbld', 19:32:34 INFO - 'MAIL': '/var/mail/cltbld', 19:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:34 INFO - 'MOZ_NO_REMOTE': '1', 19:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:34 INFO - 'NO_EM_RESTART': '1', 19:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:34 INFO - 'PWD': '/builds/slave/test', 19:32:34 INFO - 'SHELL': '/bin/bash', 19:32:34 INFO - 'SHLVL': '1', 19:32:34 INFO - 'TERM': 'linux', 19:32:34 INFO - 'TMOUT': '86400', 19:32:34 INFO - 'USER': 'cltbld', 19:32:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:34 INFO - '_': '/tools/buildbot/bin/python'} 19:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:34 INFO - Running setup.py (path:/tmp/pip-aMV1CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:34 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)) 19:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:34 INFO - Running setup.py (path:/tmp/pip-dx_WT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:34 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)) 19:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:34 INFO - Running setup.py (path:/tmp/pip-9r39Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:34 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)) 19:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:34 INFO - Running setup.py (path:/tmp/pip-dIKWNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:35 INFO - Running setup.py (path:/tmp/pip-6JLG4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:35 INFO - Running setup.py (path:/tmp/pip-LueYuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:35 INFO - Running setup.py (path:/tmp/pip-9mO0Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:35 INFO - Running setup.py (path:/tmp/pip-rMi6Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:35 INFO - Running setup.py (path:/tmp/pip-NU4mIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:35 INFO - Running setup.py (path:/tmp/pip-eqOaWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:35 INFO - Running setup.py (path:/tmp/pip-Xgr2Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:35 INFO - Running setup.py (path:/tmp/pip-uLHMM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:35 INFO - Running setup.py (path:/tmp/pip-gAwF29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:35 INFO - Running setup.py (path:/tmp/pip-tDHZcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:35 INFO - Running setup.py (path:/tmp/pip-_EnwWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:35 INFO - Running setup.py (path:/tmp/pip-SgTY9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:35 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)) 19:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:35 INFO - Running setup.py (path:/tmp/pip-vyCjn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:35 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)) 19:32:35 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)) 19:32:35 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)) 19:32:35 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)) 19:32:35 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)) 19:32:35 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)) 19:32:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32:35 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 19:32:35 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 19:32:35 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 19:32:35 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 19:32:35 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 19:32:35 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 19:32:37 INFO - Downloading blessings-1.6.tar.gz 19:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:37 INFO - Installing collected packages: blessings 19:32:37 INFO - Running setup.py install for blessings 19:32:38 INFO - Successfully installed blessings 19:32:38 INFO - Cleaning up... 19:32:38 INFO - Return code: 0 19:32:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:38 INFO - Reading from file tmpfile_stdout 19:32:38 INFO - Current package versions: 19:32:38 INFO - argparse == 1.2.1 19:32:38 INFO - blessings == 1.6 19:32:38 INFO - blobuploader == 1.2.4 19:32:38 INFO - docopt == 0.6.1 19:32:38 INFO - functools32 == 3.2.3-2 19:32:38 INFO - jsonschema == 2.5.1 19:32:38 INFO - manifestparser == 1.1 19:32:38 INFO - mozInstall == 1.12 19:32:38 INFO - mozcrash == 0.17 19:32:38 INFO - mozdebug == 0.1 19:32:38 INFO - mozdevice == 0.48 19:32:38 INFO - mozfile == 1.2 19:32:38 INFO - mozhttpd == 0.7 19:32:38 INFO - mozinfo == 0.9 19:32:38 INFO - mozleak == 0.1 19:32:38 INFO - mozlog == 3.2 19:32:38 INFO - moznetwork == 0.27 19:32:38 INFO - mozprocess == 0.22 19:32:38 INFO - mozprofile == 0.28 19:32:38 INFO - mozrunner == 6.11 19:32:38 INFO - mozscreenshot == 0.1 19:32:38 INFO - mozsystemmonitor == 0.3 19:32:38 INFO - moztest == 0.7 19:32:38 INFO - mozversion == 1.4 19:32:38 INFO - psutil == 3.1.1 19:32:38 INFO - requests == 1.2.3 19:32:38 INFO - wsgiref == 0.1.2 19:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:38 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 19:32:38 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 19:32:38 INFO - Using env: {'DISPLAY': ':0', 19:32:38 INFO - 'HOME': '/home/cltbld', 19:32:38 INFO - 'LANG': 'en_US.UTF-8', 19:32:38 INFO - 'LANGUAGE': 'en_US:en', 19:32:38 INFO - 'LOGNAME': 'cltbld', 19:32:38 INFO - 'MAIL': '/var/mail/cltbld', 19:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:38 INFO - 'MOZ_NO_REMOTE': '1', 19:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:38 INFO - 'NO_EM_RESTART': '1', 19:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:38 INFO - 'PWD': '/builds/slave/test', 19:32:38 INFO - 'SHELL': '/bin/bash', 19:32:38 INFO - 'SHLVL': '1', 19:32:38 INFO - 'TERM': 'linux', 19:32:38 INFO - 'TMOUT': '86400', 19:32:38 INFO - 'USER': 'cltbld', 19:32:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:38 INFO - '_': '/tools/buildbot/bin/python'} 19:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 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)) 19:32:38 INFO - Cleaning up... 19:32:38 INFO - Return code: 0 19:32:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:38 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 19:32:38 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 19:32:38 INFO - Using env: {'DISPLAY': ':0', 19:32:38 INFO - 'HOME': '/home/cltbld', 19:32:38 INFO - 'LANG': 'en_US.UTF-8', 19:32:38 INFO - 'LANGUAGE': 'en_US:en', 19:32:38 INFO - 'LOGNAME': 'cltbld', 19:32:38 INFO - 'MAIL': '/var/mail/cltbld', 19:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:38 INFO - 'MOZ_NO_REMOTE': '1', 19:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:38 INFO - 'NO_EM_RESTART': '1', 19:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:38 INFO - 'PWD': '/builds/slave/test', 19:32:38 INFO - 'SHELL': '/bin/bash', 19:32:38 INFO - 'SHLVL': '1', 19:32:38 INFO - 'TERM': 'linux', 19:32:38 INFO - 'TMOUT': '86400', 19:32:38 INFO - 'USER': 'cltbld', 19:32:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:38 INFO - '_': '/tools/buildbot/bin/python'} 19:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:32:38 INFO - Cleaning up... 19:32:38 INFO - Return code: 0 19:32:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 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 0x7fc3abc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', '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 19:32:38 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 19:32:38 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 19:32:38 INFO - Using env: {'DISPLAY': ':0', 19:32:38 INFO - 'HOME': '/home/cltbld', 19:32:38 INFO - 'LANG': 'en_US.UTF-8', 19:32:38 INFO - 'LANGUAGE': 'en_US:en', 19:32:38 INFO - 'LOGNAME': 'cltbld', 19:32:38 INFO - 'MAIL': '/var/mail/cltbld', 19:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:38 INFO - 'MOZ_NO_REMOTE': '1', 19:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:38 INFO - 'NO_EM_RESTART': '1', 19:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:38 INFO - 'PWD': '/builds/slave/test', 19:32:38 INFO - 'SHELL': '/bin/bash', 19:32:38 INFO - 'SHLVL': '1', 19:32:38 INFO - 'TERM': 'linux', 19:32:38 INFO - 'TMOUT': '86400', 19:32:38 INFO - 'USER': 'cltbld', 19:32:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:38 INFO - '_': '/tools/buildbot/bin/python'} 19:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:38 INFO - Downloading/unpacking flake8 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:32:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:32:40 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 19:32:40 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 19:32:40 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 19:32:40 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 19:32:40 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 19:32:40 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 19:32:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:32:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 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 19:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:41 INFO - no previously-included directories found matching 'docs/_build' 19:32:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:32:41 INFO - Running setup.py install for pep8 19:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:41 INFO - no previously-included directories found matching 'docs/_build' 19:32:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:32:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:32:41 INFO - Cleaning up... 19:32:41 INFO - Return code: 0 19:32:41 INFO - Running post-action listener: _resource_record_post_action 19:32:41 INFO - Running post-action listener: _start_resource_monitoring 19:32:41 INFO - Starting resource monitoring. 19:32:41 INFO - ##### 19:32:41 INFO - ##### Finished create-virtualenv step (success) 19:32:41 INFO - ##### 19:32:41 INFO - ##### 19:32:41 INFO - ##### Running install step. 19:32:41 INFO - ##### 19:32:41 INFO - Running pre-action listener: _resource_record_pre_action 19:32:41 INFO - Running main action method: install 19:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:42 INFO - Reading from file tmpfile_stdout 19:32:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:42 INFO - Reading from file tmpfile_stdout 19:32:42 INFO - Output received: 19:32:42 INFO - Usage: mozinstall [options] installer 19:32:42 INFO - Options: 19:32:42 INFO - -h, --help show this help message and exit 19:32:42 INFO - -d DEST, --destination=DEST 19:32:42 INFO - Directory to install application into. [default: 19:32:42 INFO - "/builds/slave/test"] 19:32:42 INFO - --app=APP Application being installed. [default: firefox] 19:32:42 INFO - mkdir: /builds/slave/test/build/application 19:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:32:58 INFO - Reading from file tmpfile_stdout 19:32:58 INFO - Output received: 19:32:58 INFO - /builds/slave/test/build/application/firefox/firefox 19:32:58 INFO - Running post-action listener: _resource_record_post_action 19:32:58 INFO - ##### 19:32:58 INFO - ##### Finished install step (success) 19:32:58 INFO - ##### 19:32:58 INFO - ##### 19:32:58 INFO - ##### Running run-tests step. 19:32:58 INFO - ##### 19:32:58 INFO - Running pre-action listener: _resource_record_pre_action 19:32:58 INFO - Running main action method: run_tests 19:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:32:58 INFO - Python 2.7.3 19:32:58 INFO - Return code: 0 19:32:58 INFO - grabbing minidump binary from tooltool 19:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:58 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 0xf621c0>, '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 0xf630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:32:58 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 19:32:58 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 19:32:58 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 19:32:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:32:59 INFO - Return code: 0 19:32:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:32:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:32:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:32:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:32:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:32:59 INFO - Return code: 0 19:32:59 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/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:32:59 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/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 19:32:59 INFO - Using env: {'DISPLAY': ':0', 19:32:59 INFO - 'HOME': '/home/cltbld', 19:32:59 INFO - 'LANG': 'en_US.UTF-8', 19:32:59 INFO - 'LANGUAGE': 'en_US:en', 19:32:59 INFO - 'LOGNAME': 'cltbld', 19:32:59 INFO - 'MAIL': '/var/mail/cltbld', 19:32:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:32:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:59 INFO - 'MOZ_NO_REMOTE': '1', 19:32:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:59 INFO - 'NO_EM_RESTART': '1', 19:32:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:59 INFO - 'PWD': '/builds/slave/test', 19:32:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:32:59 INFO - 'SHELL': '/bin/bash', 19:32:59 INFO - 'SHLVL': '1', 19:32:59 INFO - 'TERM': 'linux', 19:32:59 INFO - 'TMOUT': '86400', 19:32:59 INFO - 'USER': 'cltbld', 19:32:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124', 19:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:59 INFO - '_': '/tools/buildbot/bin/python'} 19:32:59 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/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:33:00 INFO - mozversion application_buildid: 20160606163258 19:33:00 INFO - mozversion application_changeset: aa8cdba912d328070bf56330a3abe5b86e9cd136 19:33:00 INFO - mozversion application_display_name: Nightly 19:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:00 INFO - mozversion application_name: Firefox 19:33:00 INFO - mozversion application_remotingname: firefox 19:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:33:00 INFO - mozversion application_vendor: Mozilla 19:33:00 INFO - mozversion application_version: 49.0a1 19:33:00 INFO - mozversion platform_buildid: 20160606163258 19:33:00 INFO - mozversion platform_changeset: aa8cdba912d328070bf56330a3abe5b86e9cd136 19:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:33:00 INFO - mozversion platform_version: 49.0a1 19:33:00 INFO - using testdate: 1465266780 19:33:00 INFO - actual date: 1465266780 19:33:00 INFO - starting webserver on 'localhost:41823' 19:33:00 INFO - SUITE-START | Running 2 tests 19:33:00 INFO - TEST-START | dromaeo_css 19:33:00 INFO - operating with platform_type : linux_ 19:33:00 INFO - Initialising browser for dromaeo_css test... 19:33:00 INFO - TEST-INFO | started process 11516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtEs2O/profile http://localhost:41823/getInfo.html) 19:33:04 INFO - PROCESS | 11516 | __metrics Screen width/height:1600/1200 19:33:04 INFO - PROCESS | 11516 | colorDepth:24 19:33:04 INFO - PROCESS | 11516 | Browser inner width/height: 1024/697 19:33:04 INFO - PROCESS | 11516 | __metrics 19:33:05 ERROR - PROCESS | 11516 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:33:06 INFO - TEST-INFO | 11516: exit 0 19:33:06 INFO - Browser initialized. 19:33:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:06 INFO - TEST-INFO | started process 11635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtEs2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:18 INFO - PROCESS | 11635 | RSS: Main: 166866944 19:33:18 INFO - PROCESS | 11635 | 19:34:07 INFO - PROCESS | 11635 | 1465266847614 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] 19:36:15 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41823/tests/dromaeo/cssquery-ext.html) 19:36:16 INFO - PROCESS | 11635 | RSS: Main: 170950656 19:36:16 INFO - PROCESS | 11635 | 19:39:18 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-ext.html (next: http://localhost:41823/tests/dromaeo/cssquery-jquery.html) 19:39:19 INFO - PROCESS | 11635 | RSS: Main: 169611264 19:39:19 INFO - PROCESS | 11635 | 19:42:20 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41823/tests/dromaeo/cssquery-mootools.html) 19:42:21 INFO - PROCESS | 11635 | RSS: Main: 171515904 19:42:21 INFO - PROCESS | 11635 | 19:45:23 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41823/tests/dromaeo/cssquery-prototype.html) 19:45:23 INFO - PROCESS | 11635 | RSS: Main: 168718336 19:45:23 INFO - PROCESS | 11635 | 19:48:26 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41823/tests/dromaeo/cssquery-yui.html) 19:48:26 INFO - PROCESS | 11635 | RSS: Main: 170381312 19:48:26 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | Cycle 1(1): loaded http://localhost:41823/tests/dromaeo/cssquery-yui.html (next: http://localhost:41823/tests/dromaeo/cssquery-dojo.html) 19:51:29 INFO - PROCESS | 11635 | RSS: Main: 171831296 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | __start_tp_report 19:51:29 INFO - PROCESS | 11635 | _x_x_mozilla_page_load 19:51:29 INFO - PROCESS | 11635 | _x_x_mozilla_page_load_details 19:51:29 INFO - PROCESS | 11635 | |i|pagename|runs| 19:51:29 INFO - PROCESS | 11635 | |0;dojo.html;3122.359916217176;3153.211697075731;3176.555282260483;3202.0393881835457;3208.117767613906;5467.343918729753;5481.506664400204;5504.752286147123;5506.944930550693;5508.44915508449;5298.4701529847;5346.144616861303;5361.463853614647;5366.087765079936;5443.428440013801;4835.46809850917;4848.490908454614;4926.236433352836;4971.328870602477;5034.597232221414;992.7144813903016;4857.73282469464;4872.878178045559;4958.281049247857;4985.152524070917;4880.414350277953;4904.705717656916;4905.9264111038365;4906.901861962777;4911.189653707134;4908.067467181259;4919.827806026772;4921.581665558432;4921.975390123026;4972.87567810804;4836.032793441326;4939.357883475125;4965.776540055706;4994.87512812179;5025.3718285214345;5423.240746295522;5430;5439.619226654136;5454.972725136388;5478.726063696839;5606.046972014727;5866.589338746289;5877.794277200277;5883.764649414018;5932.169496270526;5894.528437724972;5904.084866845646;5936.46571808535;5964.582479226456;5973.850653733648;5546.168074788774;5549.639273447213;5560.4161563035705;5570.387257401723;5577.27495425592;5915.615484993462;5965.910511342333;6063.7574497020505;6069.332373438918;6070.3929607038945;5767.913481297784;5844.211031510692;5847.26909136358;5855.882882342329;5887.264091988502;5905.143754155623;5919.940800592025;5920.171176035358;5923.141144534105;5931.1992880960515;5607.130894711327;5751.079827227623;5775.566832487496;5898.675572843535;5906.675132867734;5802.709864506758;5821.679807610622;5835.387284335168;5845.766169353178;5897.882042359129;4412.713173643703;4423.314386270134;4431.623312018514;4436.378906952965;4447.466304043535;3971.7418367806;3985.362342025262;4010.63904248619;4033.3143365627325;4038.273110840077;5384.434634363413;5535.252740880011;5562.638428502134;5582.665040097607;5673.234113394639;5938.554608404387;5976.223090998143;5976.551758618121;5977.043673012297;5993.0710739835395;5386.676799392049;5427.3215848019;5440.591955603346;5593.161025846074;5652.491275785199;5095.974520127375;5126.718030508283;5145.099607568735;5199.818006369759;5205.427402985669;6106.6336019838955;6160.045192995093;6160.414760597736;6164.106204600308;6183.412575805291;5780.277465316835;5828.504577110823;5859.414058594107;6015.819525414245;6025.969870150797;6060.515158787198;6072.423119803611;6090.269167699905;6091.147239386578;6118.357572454828;5726.570507212059;5788.82633520995;5797.913031304618;5807.535397168132;5808.651480911159;5699.088145896637;5888.234529511136;5891.410858914074;5906.084556893688;5927.229460170151;5777.335606405317;5797.710114494343;5809.128630705428;5810.709464526842;5823.330317013429;5777.480026797609;5782.2483077199695;5797.623154494944;5804.535637148933;5819.15622234782;5534.225208470898;5550.944490555043;5562.360328562268;5596.496315331639;5640.097584386478;5718.79984200551;5766.048601980626;5778.537716982547;5779.508741756998;5784.074548072288;5492.148716948879;5617.354004289559;5618.803341883015;5619.494245517923;5625.324961004706 19:51:29 INFO - PROCESS | 11635 | |1;ext.html;578.884223155369;614.7264467312046;630.4704048599182;641.4836056974137;657.2277573850727;44195.558044419544;45953;45958.77020614896;48952.75523622386;49158;46349.53650463495;46792;46872.765636171775;46919.296210556866;47045.76477117618;8736.868946965784;8847.95576022119;8879.467231966102;8895.95552022239;8907.109289071073;8771.649134034631;8876.378653494257;8890.822183556325;8895.77760555988;8901.510416927067;8958.148975847284;8979.865302020475;9000.504972226525;9009.504477253748;9027.45835249887;8900.28797696186;8902.910970890272;8908.554572271392;8929.866052009225;8937.285017198608;8896;8969.372143949926;8977.192052715222;9005.144511271485;9021.142991415805;44019.77990110061;44097.11805763899;44330.55669443296;44344;44416;3575.856965721368;3733.644719901789;3778.6032466590887;3878.9030274243087;4256.361545768129;30231.244218894702;30313.69686303131;30358.69641303603;31971.680283197104;34917.4762378562;4408.294672852328;4433.689641725081;4439.844605438827;4579.656525760582;4587.541245875419;343110;345783;347210;348237;348512;61309.38690613037;61619;62027.6898615504;62065.379346206864;62154;36299;36911.44632830509;37329;38803.61196388056;38973.415398769044;17483.650326993644;17506.12469376526;17618.735718964224;17651.205695743723;17716.20277087534;13491.460341586422;13531.932340338235;13580.117292375964;13647.863521364858;13660.453581856615;19789.703154452694;20121.6981745271;20378.184872605227;20427;20469.795302047085;7149.6067716275065;7222.061132052904;7303.817404564822;7342.118945726547;7384.667689953965;929.9163075323119;1113.832925061231;1164.5050853387445;1171.0690001448868;1193.7373777768878;33560.66439335576;33802.830985844914;33940.49089263663;34080.829595851865;34276.82861585726;1150.9079273658256;1166.8949794518535;1181.0905602685884;1193.421190722499;1277.303869391184;17080.145992700564;17466.737998930028;17487.65024699499;17688;17789.377371791925;558563;564810;568673;569203;569279;57862.71068644714;60089.699551501966;60128.39871601228;60164;60285;1357.7352416278732;1386.5978866128912;1387.61840493865;1396.9511067112603;1403.7262733766818;30930.917417890265;32849.67150328466;33000.174995625304;33284.667153328155;33577.83211083929;52434.73782631215;52446.47553524416;52448.21327680012;52701;52947.73526132345;347507;355094;356296;356669;358907;28006.159815205578;28470.85764571164;28477.288067798472;28491.43017139687;28496.287592809516;47855.27862451006;49011.50988490212;49111;49372.259416109504;49414.25878611895;42031.57968420399;42070.15859682728;42746.57253427426;43440;43648.56351436445;40591.23597183216;40836;41706;41842.79078604587;42631.57368426276;37305;41196;41888.790556047024;42475.15049699051;42852.78573607112;35287.64712352843;37990;38143.237135257696;38210.426843597925;38290;28475.588513412797;29221.56167657444;29565.85217073901;29632.703672962994;29681.85159074191 19:51:29 INFO - PROCESS | 11635 | |2;jquery.html;398.1042654028435;402.9133736246706;403.26001786721383;404.64391335624646;418.5038487407517;18263.817361826394;19731.5067123322;19739.901300493497;20090.49773755657;20615.484612884684;17594.912025439888;17888.37390691326;17935.64128717425;18624.72062919054;19117.139728712205;5661.1508273758955;5728.627639203439;5921.703914804264;6050.909236361458;6085.604435711687;5989.311229208632;6019.488343490809;6023.397660233985;6054.697265136748;6058.697065146747;5992.64044157352;6052.878942421149;6073.089036644495;6085.087236914454;6088.117223002684;5908.556858235628;5953.28560572734;6011.789587364443;6088.391160883898;6570.93429065708;5889.087191485327;5902.675352855591;5911.201987731644;5928.466438020556;5937.970310148465;13806.723865522634;13963.301834908316;14218.786718199235;14229.85770142306;14338.42646294147;2294.6328587425933;2341;2366.585847476702;2447.681801365829;2858.6569611646737;9869.60521579136;10344.32761870476;10376.896231037668;10759.193060520493;10814.891851081546;1890.7163925411298;1897.6446120625312;1993.434914499478;1994.6509360861792;2006.0641480970933;64982;80878.59560702217;83899.16100838974;84337;84828.15171848264;10940.234183607072;10972.506237219344;11080.279781814157;11265.183704073981;11270.21108522412;15369.615759606098;15462.38150473991;15642.68714625701;15699.607509812346;15727.44953926607;8019.959900200462;8182.386321025947;8297.170282971776;8381.790455238668;8394.748157555283;7779.805504862424;7935.801604959922;7936.880946785803;8034.076081250731;8085.716999904975;4791.496892826203;4868.537488938545;4872.634552408584;4898.338724272177;4914.680545764514;1957.2171131547211;1962.5878565501118;2008.8794672319707;2014.909329080195;2046.754389473243;935.3826474526779;984.675057231112;995.7801692926107;1055.6727414501377;1077.3589714120087;19137.808621913882;19231.615367692568;20016.2994295199;21532.4616884576;21532.89233553822;989.0702739424918;1004.7739258666887;1052.1582733812918;1062.6440142552176;1066.5467176449977;10971.561137554409;11546.422678866023;11550;11626.244294121025;11682.824757628643;465076;502983;508668;513258;513391;95962.52018739862;98210.5089474548;98464.50767746115;100597.49701251448;100846;1011.962738193343;1064.4890452582804;1079.3092420850662;1100.0869278498826;1117.5641499815079;18145.81854181494;18201.18094685716;18615.162317695464;18659;18709.812901870806;36097.81951090228;38440.03899902525;39527;43063;43593;57353;58726;59390.10914836367;59630.70184649049;59773;8824.294056475595;8854.380193386658;8889.422187557788;8980.326475514232;9212.631494740403;9930.652427165014;12978.545750898673;13063.346832658519;13123.409446575119;13279;11178.832317515407;11440.199186056896;11723.824142637697;11955;12250.142490025613;11670.183087183816;11687.824682629938;11813.704657383634;11909.285442873108;12018;11761.353125577833;11786.528538858349;11847.644570662895;11992.64022079339;12269.141160118706;8633.266172375419;8644.610992505226;8914.153155450222;8990.325725570478;9082.863757043782;8808.64765409402;10926.617568385069;11588.884111159117;11685;11765.823512647146 19:51:29 INFO - PROCESS | 11635 | |3;mootools.html;1491.5749011531711;1521.5815650696056;1668.7747154134188;1782.3316256403848;1795.0845069014806;7945;8486.957565212173;8495;9025.458472491648;9096.909030909688;8542.530160841152;8712.128787121284;8775.780605484866;8805.075467075962;8829.381943263974;2320.0487800002;2353.658719485682;2362.397588614901;2367.893444794988;2373.964390534143;2317.9420514487106;2362.8464149830293;2377.084822343393;2385.010220758383;2391.0316321889577;2320.570694421529;2324.1516846351046;2342.5080733045997;2345.7419683834764;2345.835791494596;2259.2318611672113;2266.8639881607155;2299.5745787029286;2301.102569997694;2305.14709557464;2303.2629558541275;2345.753695861944;2347.0729062020578;2369.82226333024;2370.0875163062174;8808.559572021437;8830.426022308593;8840.027596964328;8841.734747957571;8906.109389061106;5100.9489905100845;5192.974035129838;5274.446183150791;5274.789008439658;5370.087085195526;3220.822854742988;3301.3067255876294;3365.1418888183603;3375.459926411787;3384.526166336715;1133.3086817041599;1136.636276391555;1168.9064874809994;1172.0389280789757;1176.4353110507004;12131.878681213164;12268.263904165779;12349.567765128177;12373.195742276814;12399.13206075575;4555.589996900295;4568.840090596813;4665.976670116627;4685.250359942393;4779.522047795263;10399.168066554657;10411.323263987817;10471.371717696962;10473.895261047444;10477.47612619366;5377.596680248997;5399.4600539945695;5417.160340147283;5442.346918369821;5451.209574611659;4408.9118217636105;4739.170645137087;4914.0908931847725;4929.852104436873;4945.307656928033;3933.527976642821;3992.86024989124;4029.3479673334377;4057.188562287495;4082.040720430696;1275.8150068240238;1293.2499150492692;1299.4867027524076;1303.9869601304056;1305.830242068525;826.3059030414481;881.1805021330224;891.3804905590682;946.9005754395689;958.3770549143113;6014.7594096236535;6076.27084749824;6092.360302168208;6118.1128736332985;6341.2174138817145;950.6387572722459;1001.8697569315942;1011.858339832424;1026.414943482223;1039.1323245090434;3942.7634341939574;4059.715819892638;4075;4092.2020206059533;4106.301928672133;10854.185936054828;11143.164262680331;11185.217034807649;11218.270812397332;11224.66326010221;10890.727731806768;11104.888951110546;11112.444377781241;11130.944345278383;11132.10943124548;8226.917730822615;8282.544460054754;8342.62458189383;8367.539785311745;8454.408191426664;5864.824055278348;5912;5984.730687119003;6071.150038994456;6090.147379366804;9967.700968970943;10135.543900524346;10193.847092293474;10258.43578603184;10298;10017.499125043865;10193.694189174337;10449.373037617463;10450.47747612601;10526.894731052591;6900.7929762107215;7349.742759003409;7446.962765186139;7602.201768814195;7716.5755883426955;8822.2060014599;8825.955870220609;8856.690015849414;8871.556422178994;8934.910650893407;7434.405247580073;7679.19368466303;7757.1079325878245;7895.289423951872;8034.638441270274;7604.467687261838;7833.49082309648;7841.411894108079;7895.289423951872;7950.4832185907735;7185.497015208885;7202.855942881009;7242.96378518104;7252.601106939169;7253.057102576631;4913.164761990542;5002.099622068063;5101.285819985279;5134.178531434953;5170.5346518813485;5201.687898726089;5211.4527974562125;5222.608304377263;5245.921311180259;5271.920921186109 19:51:29 INFO - PROCESS | 11635 | |4;prototype.html;328.55808936979753;329.56991126579817;341.36165370756686;341.8393355123092;347.93911065563555;5585.692786896719;5674.971625141874;5684.204211410406;5819.505342045921;5851.79518716845;5550;5708.77164913403;5714.742836572354;5717.171010203518;5736.741846616902;4173.603507666767;4413.9916338066105;4423.2480478318685;4433.423654924855;4433.512313645497;4326.156399502099;4340.804663790137;4372.366006928994;4414.933775993362;4421.712588681741;4317.546657600954;4323.481182258133;4338.457692788402;4349.543297953716;4368.0390314131;4290.785460726983;4379.102284031782;4388.758618275993;4397.702677710083;4419.138268037734;3820.121372084436;3830.291396091732;3831.5593706723803;3833.769973801553;3846.499955005859;5455.672659640434;5490.3411590608985;5500.3949565547755;5512.614117011811;5520.558355331604;4954.504549545053;4966.329545511346;4992.003198720505;4995.925061124086;5032.194848824207;5660.99034842629;5953.196318496991;5953.434423729739;5973.223480947449;6001.12983617373;4212.49450065994;4224.091820258628;4232.407462955189;4233.645233525273;4245.893852653709;6140.293866205444;6143.863385273694;6235.532335074888;6245.406686364788;6299.811005669837;4237.322028475429;4250.213710463512;4272.914541709149;4276.273033584298;4281.593248641374;4339.023719663113;4347.652187824967;4348.565143485626;4350.978245108818;4360.7819609019425;4789.544993225638;5024.196128619476;5056.064628043824;5077.263796749525;5079.288899554065;5940.82177534666;5955.612885162537;5977.820665380045;5987.527234204151;6079.969600151971;1501.4069442570124;1514.1974753380725;1515.1742300446283;1523.6114790728516;1524.542637208833;894.49461054504;924.922465327899;926.9016215784317;945.6784693204206;946.6355453150449;5125.615578831603;5609.5792815539;5817.0983497557945;5834.67909264986;5850.824475265749;6216.720247588869;6236.34518375564;6240.7503699852405;6270.874582508415;6277.2781130170615;5654.773809047674;5782.884342313214;5788.739506722208;5816;5836.416358364129;3256.8371581420834;3269.378818024568;3294.1223502603766;3297.637259901409;3306.7354611631013;6201.348858369806;6340.351508607795;6363.268224154189;6371.713272902731;6382.5532212744665;6316.968415157895;6325.399087086719;6325.715342809584;6333.986562150126;6356.237251529754;6383.521235907326;6412.903806442907;6417.454516366161;6430.614163150226;6463.0610816755725;5856.9121463178935;6114;6119.418655227746;6132.5707200495535;6184.226971628546;6081.452669259788;6081.756729730761;6166.229221347332;6194.473469755121;6202.751889924533;5913.693659472895;6305.96847015762;6365.88071844802;6393.712282947372;6399.296077431386;4293.957060429356;4312.137572485452;4324.459442569679;4331.917020744814;4337.587929146726;6212.949726590305;6225.937740622536;6248.500119990299;6272.247330320391;6279.434850863444;5714.685692286798;6038.279090459198;6042.425969532887;6049.062395328731;6083.482903953213;5984.820455386345;6014.578979471395;6026.457618814327;6033.974224381778;6049.667268300285;5691.203231547669;5885.793997210077;5894.646321220569;5897.233359663216;5995.400459954144;5985.910211346746;5991.850203744942;6005.489533389536;6016.518678505797;6077.574569780073;5916.881662366814;5936.28764548257;5953.315368732651;5955.76176952917;5957.672328022 19:51:29 INFO - PROCESS | 11635 | |5;yui.html;824.715473161759;841.9536925469099;845.9703910363135;854.6709516836019;856.4390324337553;14827.629309267273;16242.106684132368;16470.917645411788;16570.917145414285;16614.83385166148;14553.054051486646;14709.190994495299;14745.262736863167;14841.257937103155;14869.330880110394;687.4122625155508;823.9340852731797;824.575343697996;825.84721826462;825.859603867341;799.816042310269;808.8341889912554;813.7599408174602;821.1008945204991;821.1829229916242;864.6022829498406;865.5845194306737;866.4974314897376;866.8526350520426;870.303756994402;862.0603542139067;862.995685021574;863.3395452478859;863.8445079885618;867.600903584352;630.5649102119569;632.0803231298449;633.1231244726088;633.148415381316;636.1380329653346;13294.800577991338;13361.198328100345;13375;13376;13388.330583470788;12653.36733163338;12817.487300507968;13025.54410595634;13317;13597.32013399336;11398.71503212418;11433.885661143366;11476.368799716012;11516.712082197928;11858.703532411673;3803.9619603803885;3870.554886188096;3872.845086196549;3884.766913985142;4007.238624661334;72125.63937180281;72834.63582682106;73405.26594734038;73675;73772.6311368445;10407.94796026015;10496.212784041227;10524.26330156897;10546.736331591617;10628.840567391495;20533.38399848007;20553.177872884917;20605;20635.793642063687;20716.378508644764;8214.424990250625;8373.07896131425;8392.622331995075;8895.866562001574;9149.176574108229;4556.886077848014;4616.3537104805355;4638;4701.294805779161;4821.783019764119;3601.333753255656;3731.813409329577;3733.757305775116;3737.4767532545466;3737.551493820759;610.2920612090043;613.6072913335469;617.0589850478057;625.9812205633838;632.1118828046602;569.9287589051369;604.8850718363585;650.2814390098968;750.1560744162816;777.296546625305;10158.847617285746;10686.894059361743;10875.967057649113;10906.018458338787;10943.398113103856;705.8800003999332;707.1019804847814;707.7098389660317;764.9235076492417;786.563457281203;4979.651424400329;5066.113430149783;5066.670666406671;5080.974595127074;5101.413337466165;109721;111566;113994;114928.42535787268;115370.42314788372;95144;97466;97933.51033244931;98194.5090274544;98500.50749746205;86286;86405.56797216099;86674.99999999873;87889.5605521981;88075;9875.308728388944;9893.703188904345;9930.205583553154;10000.949995250268;10017.649382271586;50679;51278;52386.21420678769;52981;53006.73496632492;73309.6334518324;75367;76244.61877690576;76816;77218;11011.669649910515;11395.658130256106;12727.490900364252;12740.808887866504;13333.333333333489;15611.453599123975;15666.138362390178;15667.529974100795;16106.114163721108;16144.515664530083;14374.712505750036;14625.707485850437;14981.625459363604;15020.7746883799;15145.545633631009;13763.31183440804;14168.858311416754;14890.32993515316;14978.625534361292;15015.624609384853;14088.788668170191;14150.43398264058;14542.463294862275;14584.85415145835;14741.92629036848;11432.657020289405;11661.533538658698;12050.88482392885;12110.939445302716;12267.202631828903;11822.290662560274;12036.299006381452;12371.381430928597;12447.253164810141;12603.93698031504 19:51:29 INFO - PROCESS | 11635 | __end_tp_report 19:51:29 INFO - PROCESS | 11635 | __start_cc_report 19:51:29 INFO - PROCESS | 11635 | _x_x_mozilla_cycle_collect,352 19:51:29 INFO - PROCESS | 11635 | __end_cc_report 19:51:29 INFO - PROCESS | 11635 | __startTimestamp1465267889952__endTimestamp 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | ------- Summary: start ------- 19:51:29 INFO - PROCESS | 11635 | Number of tests: 6 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#0] dojo.html Cycles:165 Average:5423.94 Median:5625.32 stddev:723.84 (12.9%) stddev-sans-first:703.18 19:51:29 INFO - PROCESS | 11635 | Values: 3122.4 3153.2 3176.6 3202.0 3208.1 5467.3 5481.5 5504.8 5506.9 5508.4 5298.5 5346.1 5361.5 5366.1 5443.4 4835.5 4848.5 4926.2 4971.3 5034.6 992.7 4857.7 4872.9 4958.3 4985.2 4880.4 4904.7 4905.9 4906.9 4911.2 4908.1 4919.8 4921.6 4922.0 4972.9 4836.0 4939.4 4965.8 4994.9 5025.4 5423.2 5430.0 5439.6 5455.0 5478.7 5606.0 5866.6 5877.8 5883.8 5932.2 5894.5 5904.1 5936.5 5964.6 5973.9 5546.2 5549.6 5560.4 5570.4 5577.3 5915.6 5965.9 6063.8 6069.3 6070.4 5767.9 5844.2 5847.3 5855.9 5887.3 5905.1 5919.9 5920.2 5923.1 5931.2 5607.1 5751.1 5775.6 5898.7 5906.7 5802.7 5821.7 5835.4 5845.8 5897.9 4412.7 4423.3 4431.6 4436.4 4447.5 3971.7 3985.4 4010.6 4033.3 4038.3 5384.4 5535.3 5562.6 5582.7 5673.2 5938.6 5976.2 5976.6 5977.0 5993.1 5386.7 5427.3 5440.6 5593.2 5652.5 5096.0 5126.7 5145.1 5199.8 5205.4 6106.6 6160.0 6160.4 6164.1 6183.4 5780.3 5828.5 5859.4 6015.8 6026.0 6060.5 6072.4 6090.3 6091.1 6118.4 5726.6 5788.8 5797.9 5807.5 5808.7 5699.1 5888.2 5891.4 5906.1 5927.2 5777.3 5797.7 5809.1 5810.7 5823.3 5777.5 5782.2 5797.6 5804.5 5819.2 5534.2 5550.9 5562.4 5596.5 5640.1 5718.8 5766.0 5778.5 5779.5 5784.1 5492.1 5617.4 5618.8 5619.5 5625.3 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#1] ext.html Cycles:180 Average:58850.60 Median:42050.87 stddev:115243.69 (274.1%) stddev-sans-first:115483.93 19:51:29 INFO - PROCESS | 11635 | Values: 578.9 614.7 630.5 641.5 657.2 44195.6 45953.0 45958.8 48952.8 49158.0 46349.5 46792.0 46872.8 46919.3 47045.8 8736.9 8848.0 8879.5 8896.0 8907.1 8771.6 8876.4 8890.8 8895.8 8901.5 8958.1 8979.9 9000.5 9009.5 9027.5 8900.3 8902.9 8908.6 8929.9 8937.3 8896.0 8969.4 8977.2 9005.1 9021.1 44019.8 44097.1 44330.6 44344.0 44416.0 3575.9 3733.6 3778.6 3878.9 4256.4 30231.2 30313.7 30358.7 31971.7 34917.5 4408.3 4433.7 4439.8 4579.7 4587.5 343110.0 345783.0 347210.0 348237.0 348512.0 61309.4 61619.0 62027.7 62065.4 62154.0 36299.0 36911.4 37329.0 38803.6 38973.4 17483.7 17506.1 17618.7 17651.2 17716.2 13491.5 13531.9 13580.1 13647.9 13660.5 19789.7 20121.7 20378.2 20427.0 20469.8 7149.6 7222.1 7303.8 7342.1 7384.7 929.9 1113.8 1164.5 1171.1 1193.7 33560.7 33802.8 33940.5 34080.8 34276.8 1150.9 1166.9 1181.1 1193.4 1277.3 17080.1 17466.7 17487.7 17688.0 17789.4 558563.0 564810.0 568673.0 569203.0 569279.0 57862.7 60089.7 60128.4 60164.0 60285.0 1357.7 1386.6 1387.6 1397.0 1403.7 30930.9 32849.7 33000.2 33284.7 33577.8 52434.7 52446.5 52448.2 52701.0 52947.7 347507.0 355094.0 356296.0 356669.0 358907.0 28006.2 28470.9 28477.3 28491.4 28496.3 47855.3 49011.5 49111.0 49372.3 49414.3 42031.6 42070.2 42746.6 43440.0 43648.6 40591.2 40836.0 41706.0 41842.8 42631.6 37305.0 41196.0 41888.8 42475.2 42852.8 35287.6 37990.0 38143.2 38210.4 38290.0 28475.6 29221.6 29565.9 29632.7 29681.9 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#2] jquery.html Cycles:180 Average:29319.21 Median:2317.82 stddev:82698.75 (3568.0%) stddev-sans-first:82902.23 19:51:29 INFO - PROCESS | 11635 | Values: 398.1 402.9 403.3 404.6 418.5 18263.8 19731.5 19739.9 20090.5 20615.5 17594.9 17888.4 17935.6 18624.7 19117.1 5661.2 5728.6 5921.7 6050.9 6085.6 5989.3 6019.5 6023.4 6054.7 6058.7 5992.6 6052.9 6073.1 6085.1 6088.1 5908.6 5953.3 6011.8 6088.4 6570.9 5889.1 5902.7 5911.2 5928.5 5938.0 13806.7 13963.3 14218.8 14229.9 14338.4 2294.6 2341.0 2366.6 2447.7 2858.7 9869.6 10344.3 10376.9 10759.2 10814.9 1890.7 1897.6 1993.4 1994.7 2006.1 64982.0 80878.6 83899.2 84337.0 84828.2 10940.2 10972.5 11080.3 11265.2 11270.2 15369.6 15462.4 15642.7 15699.6 15727.4 8020.0 8182.4 8297.2 8381.8 8394.7 7779.8 7935.8 7936.9 8034.1 8085.7 4791.5 4868.5 4872.6 4898.3 4914.7 1957.2 1962.6 2008.9 2014.9 2046.8 935.4 984.7 995.8 1055.7 1077.4 19137.8 19231.6 20016.3 21532.5 21532.9 989.1 1004.8 1052.2 1062.6 1066.5 10971.6 11546.4 11550.0 11626.2 11682.8 465076.0 502983.0 508668.0 513258.0 513391.0 95962.5 98210.5 98464.5 100597.5 100846.0 1012.0 1064.5 1079.3 1100.1 1117.6 18145.8 18201.2 18615.2 18659.0 18709.8 36097.8 38440.0 39527.0 43063.0 43593.0 57353.0 58726.0 59390.1 59630.7 59773.0 8824.3 8854.4 8889.4 8980.3 9212.6 9930.7 12978.5 13063.3 13123.4 13279.0 11178.8 11440.2 11723.8 11955.0 12250.1 11670.2 11687.8 11813.7 11909.3 12018.0 11761.4 11786.5 11847.6 11992.6 12269.1 8633.3 8644.6 8914.2 8990.3 9082.9 8808.6 10926.6 11588.9 11685.0 11765.8 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#3] mootools.html Cycles:180 Average:5851.77 Median:4617.41 stddev:3327.23 (72.1%) stddev-sans-first:3320.43 19:51:29 INFO - PROCESS | 11635 | Values: 1491.6 1521.6 1668.8 1782.3 1795.1 7945.0 8487.0 8495.0 9025.5 9096.9 8542.5 8712.1 8775.8 8805.1 8829.4 2320.0 2353.7 2362.4 2367.9 2374.0 2317.9 2362.8 2377.1 2385.0 2391.0 2320.6 2324.2 2342.5 2345.7 2345.8 2259.2 2266.9 2299.6 2301.1 2305.1 2303.3 2345.8 2347.1 2369.8 2370.1 8808.6 8830.4 8840.0 8841.7 8906.1 5100.9 5193.0 5274.4 5274.8 5370.1 3220.8 3301.3 3365.1 3375.5 3384.5 1133.3 1136.6 1168.9 1172.0 1176.4 12131.9 12268.3 12349.6 12373.2 12399.1 4555.6 4568.8 4666.0 4685.3 4779.5 10399.2 10411.3 10471.4 10473.9 10477.5 5377.6 5399.5 5417.2 5442.3 5451.2 4408.9 4739.2 4914.1 4929.9 4945.3 3933.5 3992.9 4029.3 4057.2 4082.0 1275.8 1293.2 1299.5 1304.0 1305.8 826.3 881.2 891.4 946.9 958.4 6014.8 6076.3 6092.4 6118.1 6341.2 950.6 1001.9 1011.9 1026.4 1039.1 3942.8 4059.7 4075.0 4092.2 4106.3 10854.2 11143.2 11185.2 11218.3 11224.7 10890.7 11104.9 11112.4 11130.9 11132.1 8226.9 8282.5 8342.6 8367.5 8454.4 5864.8 5912.0 5984.7 6071.2 6090.1 9967.7 10135.5 10193.8 10258.4 10298.0 10017.5 10193.7 10449.4 10450.5 10526.9 6900.8 7349.7 7447.0 7602.2 7716.6 8822.2 8826.0 8856.7 8871.6 8934.9 7434.4 7679.2 7757.1 7895.3 8034.6 7604.5 7833.5 7841.4 7895.3 7950.5 7185.5 7202.9 7243.0 7252.6 7253.1 4913.2 5002.1 5101.3 5134.2 5170.5 5201.7 5211.5 5222.6 5245.9 5271.9 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#4] prototype.html Cycles:180 Average:5024.48 Median:5802.37 stddev:1510.00 (26.0%) stddev-sans-first:1472.52 19:51:29 INFO - PROCESS | 11635 | Values: 328.6 329.6 341.4 341.8 347.9 5585.7 5675.0 5684.2 5819.5 5851.8 5550.0 5708.8 5714.7 5717.2 5736.7 4173.6 4414.0 4423.2 4433.4 4433.5 4326.2 4340.8 4372.4 4414.9 4421.7 4317.5 4323.5 4338.5 4349.5 4368.0 4290.8 4379.1 4388.8 4397.7 4419.1 3820.1 3830.3 3831.6 3833.8 3846.5 5455.7 5490.3 5500.4 5512.6 5520.6 4954.5 4966.3 4992.0 4995.9 5032.2 5661.0 5953.2 5953.4 5973.2 6001.1 4212.5 4224.1 4232.4 4233.6 4245.9 6140.3 6143.9 6235.5 6245.4 6299.8 4237.3 4250.2 4272.9 4276.3 4281.6 4339.0 4347.7 4348.6 4351.0 4360.8 4789.5 5024.2 5056.1 5077.3 5079.3 5940.8 5955.6 5977.8 5987.5 6080.0 1501.4 1514.2 1515.2 1523.6 1524.5 894.5 924.9 926.9 945.7 946.6 5125.6 5609.6 5817.1 5834.7 5850.8 6216.7 6236.3 6240.8 6270.9 6277.3 5654.8 5782.9 5788.7 5816.0 5836.4 3256.8 3269.4 3294.1 3297.6 3306.7 6201.3 6340.4 6363.3 6371.7 6382.6 6317.0 6325.4 6325.7 6334.0 6356.2 6383.5 6412.9 6417.5 6430.6 6463.1 5856.9 6114.0 6119.4 6132.6 6184.2 6081.5 6081.8 6166.2 6194.5 6202.8 5913.7 6306.0 6365.9 6393.7 6399.3 4294.0 4312.1 4324.5 4331.9 4337.6 6212.9 6225.9 6248.5 6272.2 6279.4 5714.7 6038.3 6042.4 6049.1 6083.5 5984.8 6014.6 6026.5 6034.0 6049.7 5691.2 5885.8 5894.6 5897.2 5995.4 5985.9 5991.9 6005.5 6016.5 6077.6 5916.9 5936.3 5953.3 5955.8 5957.7 19:51:29 INFO - PROCESS | 11635 | 19:51:29 INFO - PROCESS | 11635 | [#5] yui.html Cycles:180 Average:20781.43 Median:3946.00 stddev:29588.74 (749.8%) stddev-sans-first:29633.80 19:51:29 INFO - PROCESS | 11635 | Values: 824.7 842.0 846.0 854.7 856.4 14827.6 16242.1 16470.9 16570.9 16614.8 14553.1 14709.2 14745.3 14841.3 14869.3 687.4 823.9 824.6 825.8 825.9 799.8 808.8 813.8 821.1 821.2 864.6 865.6 866.5 866.9 870.3 862.1 863.0 863.3 863.8 867.6 630.6 632.1 633.1 633.1 636.1 13294.8 13361.2 13375.0 13376.0 13388.3 12653.4 12817.5 13025.5 13317.0 13597.3 11398.7 11433.9 11476.4 11516.7 11858.7 3804.0 3870.6 3872.8 3884.8 4007.2 72125.6 72834.6 73405.3 73675.0 73772.6 10407.9 10496.2 10524.3 10546.7 10628.8 20533.4 20553.2 20605.0 20635.8 20716.4 8214.4 8373.1 8392.6 8895.9 9149.2 4556.9 4616.4 4638.0 4701.3 4821.8 3601.3 3731.8 3733.8 3737.5 3737.6 610.3 613.6 617.1 626.0 632.1 569.9 604.9 650.3 750.2 777.3 10158.8 10686.9 10876.0 10906.0 10943.4 705.9 707.1 707.7 764.9 786.6 4979.7 5066.1 5066.7 5081.0 5101.4 109721.0 111566.0 113994.0 114928.4 115370.4 95144.0 97466.0 97933.5 98194.5 98500.5 86286.0 86405.6 86675.0 87889.6 88075.0 9875.3 9893.7 9930.2 10000.9 10017.6 50679.0 51278.0 52386.2 52981.0 53006.7 73309.6 75367.0 76244.6 76816.0 77218.0 11011.7 11395.7 12727.5 12740.8 13333.3 15611.5 15666.1 15667.5 16106.1 16144.5 14374.7 14625.7 14981.6 15020.8 15145.5 13763.3 14168.9 14890.3 14978.6 15015.6 14088.8 14150.4 14542.5 14584.9 14741.9 11432.7 11661.5 12050.9 12110.9 12267.2 11822.3 12036.3 12371.4 12447.3 12603.9 19:51:29 INFO - PROCESS | 11635 | -------- Summary: end -------- 19:51:29 INFO - PROCESS | 11635 | 19:51:30 INFO - TEST-INFO | 11635: exit 0 19:51:30 INFO - TEST-OK | dromaeo_css | took 1110505ms 19:51:30 INFO - TEST-START | kraken 19:51:30 INFO - operating with platform_type : linux_ 19:51:30 INFO - Initialising browser for kraken test... 19:51:30 INFO - TEST-INFO | started process 11866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYjpTPC/profile http://localhost:41823/getInfo.html) 19:51:34 INFO - PROCESS | 11866 | __metrics Screen width/height:1600/1200 19:51:34 INFO - PROCESS | 11866 | colorDepth:24 19:51:34 INFO - PROCESS | 11866 | Browser inner width/height: 1024/697 19:51:34 INFO - PROCESS | 11866 | __metrics 19:51:35 ERROR - PROCESS | 11866 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:51:36 INFO - TEST-INFO | 11866: exit 0 19:51:36 INFO - Browser initialized. 19:51:36 INFO - Running cycle 1/1 for kraken test... 19:51:36 INFO - TEST-INFO | started process 11985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYjpTPC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:51:48 INFO - PROCESS | 11985 | RSS: Main: 167624704 19:51:48 INFO - PROCESS | 11985 | 19:51:50 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41823/tests/kraken/driver.html?testName=audio-beat-detection) 19:51:51 INFO - PROCESS | 11985 | RSS: Main: 172929024 19:51:51 INFO - PROCESS | 11985 | 19:51:54 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41823/tests/kraken/driver.html?testName=audio-dft) 19:51:54 INFO - PROCESS | 11985 | RSS: Main: 172130304 19:51:54 INFO - PROCESS | 11985 | 19:51:57 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41823/tests/kraken/driver.html?testName=audio-fft) 19:51:58 INFO - PROCESS | 11985 | RSS: Main: 166572032 19:51:58 INFO - PROCESS | 11985 | 19:52:00 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41823/tests/kraken/driver.html?testName=audio-oscillator) 19:52:01 INFO - PROCESS | 11985 | RSS: Main: 167432192 19:52:01 INFO - PROCESS | 11985 | 19:52:03 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:03 INFO - PROCESS | 11985 | RSS: Main: 167333888 19:52:03 INFO - PROCESS | 11985 | 19:52:06 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41823/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:07 INFO - PROCESS | 11985 | RSS: Main: 167481344 19:52:07 INFO - PROCESS | 11985 | 19:52:11 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41823/tests/kraken/driver.html?testName=imaging-desaturate) 19:52:11 INFO - PROCESS | 11985 | RSS: Main: 165433344 19:52:11 INFO - PROCESS | 11985 | 19:52:14 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41823/tests/kraken/driver.html?testName=json-parse-financial) 19:52:15 INFO - PROCESS | 11985 | RSS: Main: 167092224 19:52:15 INFO - PROCESS | 11985 | 19:52:16 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:52:17 INFO - PROCESS | 11985 | RSS: Main: 167493632 19:52:17 INFO - PROCESS | 11985 | 19:52:19 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:52:19 INFO - PROCESS | 11985 | RSS: Main: 167419904 19:52:19 INFO - PROCESS | 11985 | 19:52:21 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:52:22 INFO - PROCESS | 11985 | RSS: Main: 168001536 19:52:22 INFO - PROCESS | 11985 | 19:52:25 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:52:25 INFO - PROCESS | 11985 | RSS: Main: 167952384 19:52:25 INFO - PROCESS | 11985 | 19:52:28 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:52:29 INFO - PROCESS | 11985 | RSS: Main: 168116224 19:52:29 INFO - PROCESS | 11985 | 19:52:30 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:41823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41823/tests/kraken/driver.html?testName=ai-astar) 19:52:31 INFO - PROCESS | 11985 | RSS: Main: 168546304 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | __start_tp_report 19:52:31 INFO - PROCESS | 11985 | _x_x_mozilla_page_load 19:52:31 INFO - PROCESS | 11985 | _x_x_mozilla_page_load_details 19:52:31 INFO - PROCESS | 11985 | |i|pagename|runs| 19:52:31 INFO - PROCESS | 11985 | |0;ai-astar;110;106;111;111;109;112;109;110;110;112 19:52:31 INFO - PROCESS | 11985 | |1;audio-beat-detection;162;130;158;183;128;165;157;126;185;126 19:52:31 INFO - PROCESS | 11985 | |2;audio-dft;164;162;163;163;161;164;174;161;160;165 19:52:31 INFO - PROCESS | 11985 | |3;audio-fft;74;77;75;161;74;77;75;76;165;76 19:52:31 INFO - PROCESS | 11985 | |4;audio-oscillator;87;84;145;85;86;84;141;85;86;139 19:52:31 INFO - PROCESS | 11985 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;118;118;117 19:52:31 INFO - PROCESS | 11985 | |6;imaging-darkroom;146;147;147;148;150;147;147;147;147;146 19:52:31 INFO - PROCESS | 11985 | |7;imaging-desaturate;96;98;95;95;95;95;95;97;95;96 19:52:31 INFO - PROCESS | 11985 | |8;json-parse-financial;54;55;53;52;53;52;54;53;53;64 19:52:31 INFO - PROCESS | 11985 | |9;json-stringify-tinderbox;60;61;60;60;61;61;62;60;60;61 19:52:31 INFO - PROCESS | 11985 | |10;stanford-crypto-aes;80;79;82;83;84;81;81;81;111;82 19:52:31 INFO - PROCESS | 11985 | |11;stanford-crypto-ccm;133;124;134;122;124;120;130;130;135;133 19:52:31 INFO - PROCESS | 11985 | |12;stanford-crypto-pbkdf2;160;164;158;161;169;169;161;161;158;160 19:52:31 INFO - PROCESS | 11985 | |13;stanford-crypto-sha256-iterative;64;63;64;64;65;64;66;65;64;62 19:52:31 INFO - PROCESS | 11985 | __end_tp_report 19:52:31 INFO - PROCESS | 11985 | __start_cc_report 19:52:31 INFO - PROCESS | 11985 | _x_x_mozilla_cycle_collect,871 19:52:31 INFO - PROCESS | 11985 | __end_cc_report 19:52:31 INFO - PROCESS | 11985 | __startTimestamp1465267951018__endTimestamp 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | ------- Summary: start ------- 19:52:31 INFO - PROCESS | 11985 | Number of tests: 14 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.76 (1.6%) stddev-sans-first:1.87 19:52:31 INFO - PROCESS | 11985 | Values: 110.0 106.0 111.0 111.0 109.0 112.0 109.0 110.0 110.0 112.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:160.00 stddev:23.07 (14.4%) stddev-sans-first:24.19 19:52:31 INFO - PROCESS | 11985 | Values: 162.0 130.0 158.0 183.0 128.0 165.0 157.0 126.0 185.0 126.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.95 (2.4%) stddev-sans-first:4.18 19:52:31 INFO - PROCESS | 11985 | Values: 164.0 162.0 163.0 163.0 161.0 164.0 174.0 161.0 160.0 165.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:36.92 (48.9%) stddev-sans-first:38.51 19:52:31 INFO - PROCESS | 11985 | Values: 74.0 77.0 75.0 161.0 74.0 77.0 75.0 76.0 165.0 76.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.00 stddev:27.29 (32.1%) stddev-sans-first:28.38 19:52:31 INFO - PROCESS | 11985 | Values: 87.0 84.0 145.0 85.0 86.0 84.0 141.0 85.0 86.0 139.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:52:31 INFO - PROCESS | 11985 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 19:52:31 INFO - PROCESS | 11985 | Values: 146.0 147.0 147.0 148.0 150.0 147.0 147.0 147.0 147.0 146.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.06 (1.1%) stddev-sans-first:1.12 19:52:31 INFO - PROCESS | 11985 | Values: 96.0 98.0 95.0 95.0 95.0 95.0 95.0 97.0 95.0 96.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.74 19:52:31 INFO - PROCESS | 11985 | Values: 54.0 55.0 53.0 52.0 53.0 52.0 54.0 53.0 53.0 64.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 19:52:31 INFO - PROCESS | 11985 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 62.0 60.0 60.0 61.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.50 stddev:9.45 (11.6%) stddev-sans-first:9.89 19:52:31 INFO - PROCESS | 11985 | Values: 80.0 79.0 82.0 83.0 84.0 81.0 81.0 81.0 111.0 82.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:131.50 stddev:5.50 (4.2%) stddev-sans-first:5.59 19:52:31 INFO - PROCESS | 11985 | Values: 133.0 124.0 134.0 122.0 124.0 120.0 130.0 130.0 135.0 133.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:161.00 stddev:4.01 (2.5%) stddev-sans-first:4.18 19:52:31 INFO - PROCESS | 11985 | Values: 160.0 164.0 158.0 161.0 169.0 169.0 161.0 161.0 158.0 160.0 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - PROCESS | 11985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 19:52:31 INFO - PROCESS | 11985 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 66.0 65.0 64.0 62.0 19:52:31 INFO - PROCESS | 11985 | -------- Summary: end -------- 19:52:31 INFO - PROCESS | 11985 | 19:52:31 INFO - TEST-INFO | 11985: exit 0 19:52:31 INFO - TEST-OK | kraken | took 61306ms 19:52:31 INFO - SUITE-END | took 1171s 19:52:32 INFO - Completed test suite (00:19:32) 19:52:32 INFO - javascript benchmark 19:52:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7407.940212404684, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.359916217176, 3153.211697075731, 3176.555282260483, 3202.0393881835457, 3208.117767613906, 5467.343918729753, 5481.506664400204, 5504.752286147123, 5506.944930550693, 5508.44915508449, 5298.4701529847, 5346.144616861303, 5361.463853614647, 5366.087765079936, 5443.428440013801, 4835.46809850917, 4848.490908454614, 4926.236433352836, 4971.328870602477, 5034.597232221414, 992.7144813903016, 4857.73282469464, 4872.878178045559, 4958.281049247857, 4985.152524070917, 4880.414350277953, 4904.705717656916, 4905.9264111038365, 4906.901861962777, 4911.189653707134, 4908.067467181259, 4919.827806026772, 4921.581665558432, 4921.975390123026, 4972.87567810804, 4836.032793441326, 4939.357883475125, 4965.776540055706, 4994.87512812179, 5025.3718285214345, 5423.240746295522, 5430.0, 5439.619226654136, 5454.972725136388, 5478.726063696839, 5606.046972014727, 5866.589338746289, 5877.794277200277, 5883.764649414018, 5932.169496270526, 5894.528437724972, 5904.084866845646, 5936.46571808535, 5964.582479226456, 5973.850653733648, 5546.168074788774, 5549.639273447213, 5560.4161563035705, 5570.387257401723, 5577.27495425592, 5915.615484993462, 5965.910511342333, 6063.7574497020505, 6069.332373438918, 6070.3929607038945, 5767.913481297784, 5844.211031510692, 5847.26909136358, 5855.882882342329, 5887.264091988502, 5905.143754155623, 5919.940800592025, 5920.171176035358, 5923.141144534105, 5931.1992880960515, 5607.130894711327, 5751.079827227623, 5775.566832487496, 5898.675572843535, 5906.675132867734, 5802.709864506758, 5821.679807610622, 5835.387284335168, 5845.766169353178, 5897.882042359129, 4412.713173643703, 4423.314386270134, 4431.623312018514, 4436.378906952965, 4447.466304043535, 3971.7418367806, 3985.362342025262, 4010.63904248619, 4033.3143365627325, 4038.273110840077, 5384.434634363413, 5535.252740880011, 5562.638428502134, 5582.665040097607, 5673.234113394639, 5938.554608404387, 5976.223090998143, 5976.551758618121, 5977.043673012297, 5993.0710739835395, 5386.676799392049, 5427.3215848019, 5440.591955603346, 5593.161025846074, 5652.491275785199, 5095.974520127375, 5126.718030508283, 5145.099607568735, 5199.818006369759, 5205.427402985669, 6106.6336019838955, 6160.045192995093, 6160.414760597736, 6164.106204600308, 6183.412575805291, 5780.277465316835, 5828.504577110823, 5859.414058594107, 6015.819525414245, 6025.969870150797, 6060.515158787198, 6072.423119803611, 6090.269167699905, 6091.147239386578, 6118.357572454828, 5726.570507212059, 5788.82633520995, 5797.913031304618, 5807.535397168132, 5808.651480911159, 5699.088145896637, 5888.234529511136, 5891.410858914074, 5906.084556893688, 5927.229460170151, 5777.335606405317, 5797.710114494343, 5809.128630705428, 5810.709464526842, 5823.330317013429, 5777.480026797609, 5782.2483077199695, 5797.623154494944, 5804.535637148933, 5819.15622234782, 5534.225208470898, 5550.944490555043, 5562.360328562268, 5596.496315331639, 5640.097584386478, 5718.79984200551, 5766.048601980626, 5778.537716982547, 5779.508741756998, 5784.074548072288, 5492.148716948879, 5617.354004289559, 5618.803341883015, 5619.494245517923, 5625.324961004706], "value": 5375.492100026964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.884223155369, 614.7264467312046, 630.4704048599182, 641.4836056974137, 657.2277573850727, 44195.558044419544, 45953.0, 45958.77020614896, 48952.75523622386, 49158.0, 46349.53650463495, 46792.0, 46872.765636171775, 46919.296210556866, 47045.76477117618, 8736.868946965784, 8847.95576022119, 8879.467231966102, 8895.95552022239, 8907.109289071073, 8771.649134034631, 8876.378653494257, 8890.822183556325, 8895.77760555988, 8901.510416927067, 8958.148975847284, 8979.865302020475, 9000.504972226525, 9009.504477253748, 9027.45835249887, 8900.28797696186, 8902.910970890272, 8908.554572271392, 8929.866052009225, 8937.285017198608, 8896.0, 8969.372143949926, 8977.192052715222, 9005.144511271485, 9021.142991415805, 44019.77990110061, 44097.11805763899, 44330.55669443296, 44344.0, 44416.0, 3575.856965721368, 3733.644719901789, 3778.6032466590887, 3878.9030274243087, 4256.361545768129, 30231.244218894702, 30313.69686303131, 30358.69641303603, 31971.680283197104, 34917.4762378562, 4408.294672852328, 4433.689641725081, 4439.844605438827, 4579.656525760582, 4587.541245875419, 343110.0, 345783.0, 347210.0, 348237.0, 348512.0, 61309.38690613037, 61619.0, 62027.6898615504, 62065.379346206864, 62154.0, 36299.0, 36911.44632830509, 37329.0, 38803.61196388056, 38973.415398769044, 17483.650326993644, 17506.12469376526, 17618.735718964224, 17651.205695743723, 17716.20277087534, 13491.460341586422, 13531.932340338235, 13580.117292375964, 13647.863521364858, 13660.453581856615, 19789.703154452694, 20121.6981745271, 20378.184872605227, 20427.0, 20469.795302047085, 7149.6067716275065, 7222.061132052904, 7303.817404564822, 7342.118945726547, 7384.667689953965, 929.9163075323119, 1113.832925061231, 1164.5050853387445, 1171.0690001448868, 1193.7373777768878, 33560.66439335576, 33802.830985844914, 33940.49089263663, 34080.829595851865, 34276.82861585726, 1150.9079273658256, 1166.8949794518535, 1181.0905602685884, 1193.421190722499, 1277.303869391184, 17080.145992700564, 17466.737998930028, 17487.65024699499, 17688.0, 17789.377371791925, 558563.0, 564810.0, 568673.0, 569203.0, 569279.0, 57862.71068644714, 60089.699551501966, 60128.39871601228, 60164.0, 60285.0, 1357.7352416278732, 1386.5978866128912, 1387.61840493865, 1396.9511067112603, 1403.7262733766818, 30930.917417890265, 32849.67150328466, 33000.174995625304, 33284.667153328155, 33577.83211083929, 52434.73782631215, 52446.47553524416, 52448.21327680012, 52701.0, 52947.73526132345, 347507.0, 355094.0, 356296.0, 356669.0, 358907.0, 28006.159815205578, 28470.85764571164, 28477.288067798472, 28491.43017139687, 28496.287592809516, 47855.27862451006, 49011.50988490212, 49111.0, 49372.259416109504, 49414.25878611895, 42031.57968420399, 42070.15859682728, 42746.57253427426, 43440.0, 43648.56351436445, 40591.23597183216, 40836.0, 41706.0, 41842.79078604587, 42631.57368426276, 37305.0, 41196.0, 41888.790556047024, 42475.15049699051, 42852.78573607112, 35287.64712352843, 37990.0, 38143.237135257696, 38210.426843597925, 38290.0, 28475.588513412797, 29221.56167657444, 29565.85217073901, 29632.703672962994, 29681.85159074191], "value": 20377.552119983993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.1042654028435, 402.9133736246706, 403.26001786721383, 404.64391335624646, 418.5038487407517, 18263.817361826394, 19731.5067123322, 19739.901300493497, 20090.49773755657, 20615.484612884684, 17594.912025439888, 17888.37390691326, 17935.64128717425, 18624.72062919054, 19117.139728712205, 5661.1508273758955, 5728.627639203439, 5921.703914804264, 6050.909236361458, 6085.604435711687, 5989.311229208632, 6019.488343490809, 6023.397660233985, 6054.697265136748, 6058.697065146747, 5992.64044157352, 6052.878942421149, 6073.089036644495, 6085.087236914454, 6088.117223002684, 5908.556858235628, 5953.28560572734, 6011.789587364443, 6088.391160883898, 6570.93429065708, 5889.087191485327, 5902.675352855591, 5911.201987731644, 5928.466438020556, 5937.970310148465, 13806.723865522634, 13963.301834908316, 14218.786718199235, 14229.85770142306, 14338.42646294147, 2294.6328587425933, 2341.0, 2366.585847476702, 2447.681801365829, 2858.6569611646737, 9869.60521579136, 10344.32761870476, 10376.896231037668, 10759.193060520493, 10814.891851081546, 1890.7163925411298, 1897.6446120625312, 1993.434914499478, 1994.6509360861792, 2006.0641480970933, 64982.0, 80878.59560702217, 83899.16100838974, 84337.0, 84828.15171848264, 10940.234183607072, 10972.506237219344, 11080.279781814157, 11265.183704073981, 11270.21108522412, 15369.615759606098, 15462.38150473991, 15642.68714625701, 15699.607509812346, 15727.44953926607, 8019.959900200462, 8182.386321025947, 8297.170282971776, 8381.790455238668, 8394.748157555283, 7779.805504862424, 7935.801604959922, 7936.880946785803, 8034.076081250731, 8085.716999904975, 4791.496892826203, 4868.537488938545, 4872.634552408584, 4898.338724272177, 4914.680545764514, 1957.2171131547211, 1962.5878565501118, 2008.8794672319707, 2014.909329080195, 2046.754389473243, 935.3826474526779, 984.675057231112, 995.7801692926107, 1055.6727414501377, 1077.3589714120087, 19137.808621913882, 19231.615367692568, 20016.2994295199, 21532.4616884576, 21532.89233553822, 989.0702739424918, 1004.7739258666887, 1052.1582733812918, 1062.6440142552176, 1066.5467176449977, 10971.561137554409, 11546.422678866023, 11550.0, 11626.244294121025, 11682.824757628643, 465076.0, 502983.0, 508668.0, 513258.0, 513391.0, 95962.52018739862, 98210.5089474548, 98464.50767746115, 100597.49701251448, 100846.0, 1011.962738193343, 1064.4890452582804, 1079.3092420850662, 1100.0869278498826, 1117.5641499815079, 18145.81854181494, 18201.18094685716, 18615.162317695464, 18659.0, 18709.812901870806, 36097.81951090228, 38440.03899902525, 39527.0, 43063.0, 43593.0, 57353.0, 58726.0, 59390.10914836367, 59630.70184649049, 59773.0, 8824.294056475595, 8854.380193386658, 8889.422187557788, 8980.326475514232, 9212.631494740403, 9930.652427165014, 12978.545750898673, 13063.346832658519, 13123.409446575119, 13279.0, 11178.832317515407, 11440.199186056896, 11723.824142637697, 11955.0, 12250.142490025613, 11670.183087183816, 11687.824682629938, 11813.704657383634, 11909.285442873108, 12018.0, 11761.353125577833, 11786.528538858349, 11847.644570662895, 11992.64022079339, 12269.141160118706, 8633.266172375419, 8644.610992505226, 8914.153155450222, 8990.325725570478, 9082.863757043782, 8808.64765409402, 10926.617568385069, 11588.884111159117, 11685.0, 11765.823512647146], "value": 9295.017469891161, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.5749011531711, 1521.5815650696056, 1668.7747154134188, 1782.3316256403848, 1795.0845069014806, 7945.0, 8486.957565212173, 8495.0, 9025.458472491648, 9096.909030909688, 8542.530160841152, 8712.128787121284, 8775.780605484866, 8805.075467075962, 8829.381943263974, 2320.0487800002, 2353.658719485682, 2362.397588614901, 2367.893444794988, 2373.964390534143, 2317.9420514487106, 2362.8464149830293, 2377.084822343393, 2385.010220758383, 2391.0316321889577, 2320.570694421529, 2324.1516846351046, 2342.5080733045997, 2345.7419683834764, 2345.835791494596, 2259.2318611672113, 2266.8639881607155, 2299.5745787029286, 2301.102569997694, 2305.14709557464, 2303.2629558541275, 2345.753695861944, 2347.0729062020578, 2369.82226333024, 2370.0875163062174, 8808.559572021437, 8830.426022308593, 8840.027596964328, 8841.734747957571, 8906.109389061106, 5100.9489905100845, 5192.974035129838, 5274.446183150791, 5274.789008439658, 5370.087085195526, 3220.822854742988, 3301.3067255876294, 3365.1418888183603, 3375.459926411787, 3384.526166336715, 1133.3086817041599, 1136.636276391555, 1168.9064874809994, 1172.0389280789757, 1176.4353110507004, 12131.878681213164, 12268.263904165779, 12349.567765128177, 12373.195742276814, 12399.13206075575, 4555.589996900295, 4568.840090596813, 4665.976670116627, 4685.250359942393, 4779.522047795263, 10399.168066554657, 10411.323263987817, 10471.371717696962, 10473.895261047444, 10477.47612619366, 5377.596680248997, 5399.4600539945695, 5417.160340147283, 5442.346918369821, 5451.209574611659, 4408.9118217636105, 4739.170645137087, 4914.0908931847725, 4929.852104436873, 4945.307656928033, 3933.527976642821, 3992.86024989124, 4029.3479673334377, 4057.188562287495, 4082.040720430696, 1275.8150068240238, 1293.2499150492692, 1299.4867027524076, 1303.9869601304056, 1305.830242068525, 826.3059030414481, 881.1805021330224, 891.3804905590682, 946.9005754395689, 958.3770549143113, 6014.7594096236535, 6076.27084749824, 6092.360302168208, 6118.1128736332985, 6341.2174138817145, 950.6387572722459, 1001.8697569315942, 1011.858339832424, 1026.414943482223, 1039.1323245090434, 3942.7634341939574, 4059.715819892638, 4075.0, 4092.2020206059533, 4106.301928672133, 10854.185936054828, 11143.164262680331, 11185.217034807649, 11218.270812397332, 11224.66326010221, 10890.727731806768, 11104.888951110546, 11112.444377781241, 11130.944345278383, 11132.10943124548, 8226.917730822615, 8282.544460054754, 8342.62458189383, 8367.539785311745, 8454.408191426664, 5864.824055278348, 5912.0, 5984.730687119003, 6071.150038994456, 6090.147379366804, 9967.700968970943, 10135.543900524346, 10193.847092293474, 10258.43578603184, 10298.0, 10017.499125043865, 10193.694189174337, 10449.373037617463, 10450.47747612601, 10526.894731052591, 6900.7929762107215, 7349.742759003409, 7446.962765186139, 7602.201768814195, 7716.5755883426955, 8822.2060014599, 8825.955870220609, 8856.690015849414, 8871.556422178994, 8934.910650893407, 7434.405247580073, 7679.19368466303, 7757.1079325878245, 7895.289423951872, 8034.638441270274, 7604.467687261838, 7833.49082309648, 7841.411894108079, 7895.289423951872, 7950.4832185907735, 7185.497015208885, 7202.855942881009, 7242.96378518104, 7252.601106939169, 7253.057102576631, 4913.164761990542, 5002.099622068063, 5101.285819985279, 5134.178531434953, 5170.5346518813485, 5201.687898726089, 5211.4527974562125, 5222.608304377263, 5245.921311180259, 5271.920921186109], "value": 4684.494691860189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.55808936979753, 329.56991126579817, 341.36165370756686, 341.8393355123092, 347.93911065563555, 5585.692786896719, 5674.971625141874, 5684.204211410406, 5819.505342045921, 5851.79518716845, 5550.0, 5708.77164913403, 5714.742836572354, 5717.171010203518, 5736.741846616902, 4173.603507666767, 4413.9916338066105, 4423.2480478318685, 4433.423654924855, 4433.512313645497, 4326.156399502099, 4340.804663790137, 4372.366006928994, 4414.933775993362, 4421.712588681741, 4317.546657600954, 4323.481182258133, 4338.457692788402, 4349.543297953716, 4368.0390314131, 4290.785460726983, 4379.102284031782, 4388.758618275993, 4397.702677710083, 4419.138268037734, 3820.121372084436, 3830.291396091732, 3831.5593706723803, 3833.769973801553, 3846.499955005859, 5455.672659640434, 5490.3411590608985, 5500.3949565547755, 5512.614117011811, 5520.558355331604, 4954.504549545053, 4966.329545511346, 4992.003198720505, 4995.925061124086, 5032.194848824207, 5660.99034842629, 5953.196318496991, 5953.434423729739, 5973.223480947449, 6001.12983617373, 4212.49450065994, 4224.091820258628, 4232.407462955189, 4233.645233525273, 4245.893852653709, 6140.293866205444, 6143.863385273694, 6235.532335074888, 6245.406686364788, 6299.811005669837, 4237.322028475429, 4250.213710463512, 4272.914541709149, 4276.273033584298, 4281.593248641374, 4339.023719663113, 4347.652187824967, 4348.565143485626, 4350.978245108818, 4360.7819609019425, 4789.544993225638, 5024.196128619476, 5056.064628043824, 5077.263796749525, 5079.288899554065, 5940.82177534666, 5955.612885162537, 5977.820665380045, 5987.527234204151, 6079.969600151971, 1501.4069442570124, 1514.1974753380725, 1515.1742300446283, 1523.6114790728516, 1524.542637208833, 894.49461054504, 924.922465327899, 926.9016215784317, 945.6784693204206, 946.6355453150449, 5125.615578831603, 5609.5792815539, 5817.0983497557945, 5834.67909264986, 5850.824475265749, 6216.720247588869, 6236.34518375564, 6240.7503699852405, 6270.874582508415, 6277.2781130170615, 5654.773809047674, 5782.884342313214, 5788.739506722208, 5816.0, 5836.416358364129, 3256.8371581420834, 3269.378818024568, 3294.1223502603766, 3297.637259901409, 3306.7354611631013, 6201.348858369806, 6340.351508607795, 6363.268224154189, 6371.713272902731, 6382.5532212744665, 6316.968415157895, 6325.399087086719, 6325.715342809584, 6333.986562150126, 6356.237251529754, 6383.521235907326, 6412.903806442907, 6417.454516366161, 6430.614163150226, 6463.0610816755725, 5856.9121463178935, 6114.0, 6119.418655227746, 6132.5707200495535, 6184.226971628546, 6081.452669259788, 6081.756729730761, 6166.229221347332, 6194.473469755121, 6202.751889924533, 5913.693659472895, 6305.96847015762, 6365.88071844802, 6393.712282947372, 6399.296077431386, 4293.957060429356, 4312.137572485452, 4324.459442569679, 4331.917020744814, 4337.587929146726, 6212.949726590305, 6225.937740622536, 6248.500119990299, 6272.247330320391, 6279.434850863444, 5714.685692286798, 6038.279090459198, 6042.425969532887, 6049.062395328731, 6083.482903953213, 5984.820455386345, 6014.578979471395, 6026.457618814327, 6033.974224381778, 6049.667268300285, 5691.203231547669, 5885.793997210077, 5894.646321220569, 5897.233359663216, 5995.400459954144, 5985.910211346746, 5991.850203744942, 6005.489533389536, 6016.518678505797, 6077.574569780073, 5916.881662366814, 5936.28764548257, 5953.315368732651, 5955.76176952917, 5957.672328022], "value": 4531.69229168884, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.715473161759, 841.9536925469099, 845.9703910363135, 854.6709516836019, 856.4390324337553, 14827.629309267273, 16242.106684132368, 16470.917645411788, 16570.917145414285, 16614.83385166148, 14553.054051486646, 14709.190994495299, 14745.262736863167, 14841.257937103155, 14869.330880110394, 687.4122625155508, 823.9340852731797, 824.575343697996, 825.84721826462, 825.859603867341, 799.816042310269, 808.8341889912554, 813.7599408174602, 821.1008945204991, 821.1829229916242, 864.6022829498406, 865.5845194306737, 866.4974314897376, 866.8526350520426, 870.303756994402, 862.0603542139067, 862.995685021574, 863.3395452478859, 863.8445079885618, 867.600903584352, 630.5649102119569, 632.0803231298449, 633.1231244726088, 633.148415381316, 636.1380329653346, 13294.800577991338, 13361.198328100345, 13375.0, 13376.0, 13388.330583470788, 12653.36733163338, 12817.487300507968, 13025.54410595634, 13317.0, 13597.32013399336, 11398.71503212418, 11433.885661143366, 11476.368799716012, 11516.712082197928, 11858.703532411673, 3803.9619603803885, 3870.554886188096, 3872.845086196549, 3884.766913985142, 4007.238624661334, 72125.63937180281, 72834.63582682106, 73405.26594734038, 73675.0, 73772.6311368445, 10407.94796026015, 10496.212784041227, 10524.26330156897, 10546.736331591617, 10628.840567391495, 20533.38399848007, 20553.177872884917, 20605.0, 20635.793642063687, 20716.378508644764, 8214.424990250625, 8373.07896131425, 8392.622331995075, 8895.866562001574, 9149.176574108229, 4556.886077848014, 4616.3537104805355, 4638.0, 4701.294805779161, 4821.783019764119, 3601.333753255656, 3731.813409329577, 3733.757305775116, 3737.4767532545466, 3737.551493820759, 610.2920612090043, 613.6072913335469, 617.0589850478057, 625.9812205633838, 632.1118828046602, 569.9287589051369, 604.8850718363585, 650.2814390098968, 750.1560744162816, 777.296546625305, 10158.847617285746, 10686.894059361743, 10875.967057649113, 10906.018458338787, 10943.398113103856, 705.8800003999332, 707.1019804847814, 707.7098389660317, 764.9235076492417, 786.563457281203, 4979.651424400329, 5066.113430149783, 5066.670666406671, 5080.974595127074, 5101.413337466165, 109721.0, 111566.0, 113994.0, 114928.42535787268, 115370.42314788372, 95144.0, 97466.0, 97933.51033244931, 98194.5090274544, 98500.50749746205, 86286.0, 86405.56797216099, 86674.99999999873, 87889.5605521981, 88075.0, 9875.308728388944, 9893.703188904345, 9930.205583553154, 10000.949995250268, 10017.649382271586, 50679.0, 51278.0, 52386.21420678769, 52981.0, 53006.73496632492, 73309.6334518324, 75367.0, 76244.61877690576, 76816.0, 77218.0, 11011.669649910515, 11395.658130256106, 12727.490900364252, 12740.808887866504, 13333.333333333489, 15611.453599123975, 15666.138362390178, 15667.529974100795, 16106.114163721108, 16144.515664530083, 14374.712505750036, 14625.707485850437, 14981.625459363604, 15020.7746883799, 15145.545633631009, 13763.31183440804, 14168.858311416754, 14890.32993515316, 14978.625534361292, 15015.624609384853, 14088.788668170191, 14150.43398264058, 14542.463294862275, 14584.85415145835, 14741.92629036848, 11432.657020289405, 11661.533538658698, 12050.88482392885, 12110.939445302716, 12267.202631828903, 11822.290662560274, 12036.299006381452, 12371.381430928597, 12447.253164810141, 12603.93698031504], "value": 7645.374870147068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 111.0, 109.0, 112.0, 109.0, 110.0, 110.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 158.0, 183.0, 128.0, 165.0, 157.0, 126.0, 185.0, 126.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 163.0, 161.0, 164.0, 174.0, 161.0, 160.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 161.0, 74.0, 77.0, 75.0, 76.0, 165.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 145.0, 85.0, 86.0, 84.0, 141.0, 85.0, 86.0, 139.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 150.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 52.0, 53.0, 52.0, 54.0, 53.0, 53.0, 64.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 62.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 82.0, 83.0, 84.0, 81.0, 81.0, 81.0, 111.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 134.0, 122.0, 124.0, 120.0, 130.0, 130.0, 135.0, 133.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 158.0, 161.0, 169.0, 169.0, 161.0, 161.0, 158.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 62.0], "value": 64.1, "unit": "score"}]}]} 19:52:32 INFO - Return code: 0 19:52:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:52:32 ERROR - # TBPL SUCCESS # 19:52:32 INFO - Running post-action listener: _resource_record_post_action 19:52:32 INFO - ##### 19:52:32 INFO - ##### Finished run-tests step (success) 19:52:32 INFO - ##### 19:52:32 INFO - Running post-run listener: _resource_record_post_run 19:52:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542904320; Read time: 184; Write time: 360788 19:52:32 INFO - TinderboxPrint: CPU usage
13.5% 19:52:32 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 19:52:32 INFO - TinderboxPrint: I/O write bytes / time
542,904,320 / 360,788 19:52:32 INFO - TinderboxPrint: CPU idle
8,216.6 (86.5%) 19:52:32 INFO - TinderboxPrint: CPU user
1,223.8 (12.9%) 19:52:32 INFO - TinderboxPrint: Swap in / out
0 / 0 19:52:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248020992; Read time: 0; Write time: 211272 19:52:32 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294883328; Read time: 184; Write time: 149516 19:52:32 INFO - Running post-run listener: _upload_blobber_files 19:52:32 INFO - Blob upload gear active. 19:52:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:52:32 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 19:52:32 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'] 19:52:32 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 19:52:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:52:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:34 INFO - (blobuploader) - INFO - Done attempting. 19:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:52:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:34 INFO - (blobuploader) - INFO - Done attempting. 19:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:52:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:40 INFO - (blobuploader) - INFO - Done attempting. 19:52:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:52:40 INFO - Return code: 0 19:52:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:52:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:52:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce5ef8dac59d743963c52171647d7264499b0cb9550aaa76cb86da2daa4da9f7c11697e780e8712102e4ce064726f18acb49eb75bbe011cc73ca06e9e06da171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3ca2e93fbc063df802d9ea3dd6f5459bdf49e756eb46475585e218dad3657a923fe27d4e29acabaa5b376092e384d19677675fd192b4a0892d8dbde1d8dcfeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7242bbd2678c434fc31164a857c725889f51c8265af5c13c0aef55e708357db4c2b8efad19ad7601191e183f907290fd847aea0c5d3f833dbc821a9d663de13"} 19:52:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:52:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:52:40 INFO - Contents: 19:52:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce5ef8dac59d743963c52171647d7264499b0cb9550aaa76cb86da2daa4da9f7c11697e780e8712102e4ce064726f18acb49eb75bbe011cc73ca06e9e06da171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3ca2e93fbc063df802d9ea3dd6f5459bdf49e756eb46475585e218dad3657a923fe27d4e29acabaa5b376092e384d19677675fd192b4a0892d8dbde1d8dcfeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7242bbd2678c434fc31164a857c725889f51c8265af5c13c0aef55e708357db4c2b8efad19ad7601191e183f907290fd847aea0c5d3f833dbc821a9d663de13"} 19:52:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:52:40 INFO - Copying logs to upload dir... 19:52:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:52:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.370799 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 19:52:39.814756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 19:52:39.817890) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 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/ce5ef8dac59d743963c52171647d7264499b0cb9550aaa76cb86da2daa4da9f7c11697e780e8712102e4ce064726f18acb49eb75bbe011cc73ca06e9e06da171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3ca2e93fbc063df802d9ea3dd6f5459bdf49e756eb46475585e218dad3657a923fe27d4e29acabaa5b376092e384d19677675fd192b4a0892d8dbde1d8dcfeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7242bbd2678c434fc31164a857c725889f51c8265af5c13c0aef55e708357db4c2b8efad19ad7601191e183f907290fd847aea0c5d3f833dbc821a9d663de13"} build_url:https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/Vk8nPLKeSGCQIDwXsogncQ/artifacts/public/build/firefox-49.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/ce5ef8dac59d743963c52171647d7264499b0cb9550aaa76cb86da2daa4da9f7c11697e780e8712102e4ce064726f18acb49eb75bbe011cc73ca06e9e06da171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3ca2e93fbc063df802d9ea3dd6f5459bdf49e756eb46475585e218dad3657a923fe27d4e29acabaa5b376092e384d19677675fd192b4a0892d8dbde1d8dcfeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7242bbd2678c434fc31164a857c725889f51c8265af5c13c0aef55e708357db4c2b8efad19ad7601191e183f907290fd847aea0c5d3f833dbc821a9d663de13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 19:52:39.843255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:52:39.843576) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465262786.635423-1908266124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 19:52:39.927347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 19:52:39.927710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 19:52:39.928003) ========= ========= Total master_lag: 0.18 =========