builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466280265.76 results: success (0) buildid: 20160618103107 builduid: 2d80baff1abe4797850049f5b49d57e3 revision: 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.762118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.762600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.762888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.791211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.791491) ========= 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=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 13:04:25-- 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% 221M=0s 2016-06-18 13:04:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.935664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.935998) ========= 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=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.985625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:25.986003) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd --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 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd --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=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 13:04:26,168 truncating revision to first 12 chars 2016-06-18 13:04:26,168 Setting DEBUG logging. 2016-06-18 13:04:26,168 attempt 1/10 2016-06-18 13:04:26,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6e9946f0a1f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 13:04:26,531 unpacking tar archive at: mozilla-inbound-6e9946f0a1f6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:26.701193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:26.701545) ========= script_repo_revision: 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:26.701982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:26.702256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 13:04:26.710433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-18 13:04:26.710764) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:04:26 INFO - MultiFileLogger online at 20160618 13:04:26 in /builds/slave/test 13:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:04:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:04:26 INFO - {'append_to_log': False, 13:04:26 INFO - 'base_work_dir': '/builds/slave/test', 13:04:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:04:26 INFO - 'branch': 'Mozilla-Inbound', 13:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:26 INFO - 'config_files': ('talos/linux_config.py',), 13:04:26 INFO - 'default_actions': ('clobber', 13:04:26 INFO - 'read-buildbot-config', 13:04:26 INFO - 'download-and-extract', 13:04:26 INFO - 'populate-webroot', 13:04:26 INFO - 'create-virtualenv', 13:04:26 INFO - 'install', 13:04:26 INFO - 'run-tests'), 13:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:26 INFO - 'download_minidump_stackwalk': True, 13:04:26 INFO - 'download_symbols': 'ondemand', 13:04:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:26 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:26 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:26 INFO - 'installer_path': 'installer.exe', 13:04:26 INFO - 'log_level': 'info', 13:04:26 INFO - 'log_name': 'talos', 13:04:26 INFO - 'log_to_console': True, 13:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:04:26 INFO - 'opt_config_files': (), 13:04:26 INFO - 'pip_index': False, 13:04:26 INFO - 'sps_profile': False, 13:04:26 INFO - 'sps_profile_interval': 0, 13:04:26 INFO - 'suite': 'dromaeojs', 13:04:26 INFO - 'system_bits': '32', 13:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:26 INFO - 'title': 'talos-linux64-ix-017', 13:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:26 INFO - 'use_talos_json': True, 13:04:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:26 INFO - 'work_dir': 'build'} 13:04:26 INFO - ##### 13:04:26 INFO - ##### Running clobber step. 13:04:26 INFO - ##### 13:04:26 INFO - Running pre-action listener: _resource_record_pre_action 13:04:26 INFO - Running main action method: clobber 13:04:26 INFO - rmtree: /builds/slave/test/build 13:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:04:27 INFO - Running post-action listener: _resource_record_post_action 13:04:27 INFO - ##### 13:04:27 INFO - ##### Finished clobber step (success) 13:04:27 INFO - ##### 13:04:27 INFO - ##### 13:04:27 INFO - ##### Running read-buildbot-config step. 13:04:27 INFO - ##### 13:04:27 INFO - Running pre-action listener: _resource_record_pre_action 13:04:27 INFO - Running main action method: read_buildbot_config 13:04:27 INFO - Using buildbot properties: 13:04:27 INFO - { 13:04:27 INFO - "project": "", 13:04:27 INFO - "product": "firefox", 13:04:27 INFO - "script_repo_revision": "production", 13:04:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:04:27 INFO - "repository": "", 13:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:04:27 INFO - "buildid": "20160618103107", 13:04:27 INFO - "pgo_build": "True", 13:04:27 INFO - "basedir": "/builds/slave/test", 13:04:27 INFO - "buildnumber": 1128, 13:04:27 INFO - "slavename": "talos-linux64-ix-017", 13:04:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:04:27 INFO - "platform": "ubuntu64_hw", 13:04:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:04:27 INFO - "branch": "mozilla-inbound", 13:04:27 INFO - "repo_path": "integration/mozilla-inbound", 13:04:27 INFO - "revision": "6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd", 13:04:27 INFO - "stage_platform": "linux64-pgo", 13:04:27 INFO - "builduid": "2d80baff1abe4797850049f5b49d57e3", 13:04:27 INFO - "slavebuilddir": "test" 13:04:27 INFO - } 13:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:04:27 INFO - Running post-action listener: _resource_record_post_action 13:04:27 INFO - ##### 13:04:27 INFO - ##### Finished read-buildbot-config step (success) 13:04:27 INFO - ##### 13:04:27 INFO - ##### 13:04:27 INFO - ##### Running download-and-extract step. 13:04:27 INFO - ##### 13:04:27 INFO - Running pre-action listener: _resource_record_pre_action 13:04:27 INFO - Running main action method: download_and_extract 13:04:27 INFO - mkdir: /builds/slave/test/build/tests 13:04: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')]} 13:04:27 INFO - https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:04:29 INFO - Downloaded 1361 bytes. 13:04:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:04:29 INFO - Using the following test package requirements: 13:04:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:04:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:04:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:04:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'jsshell-linux-x86_64.zip'], 13:04:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:04:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:04:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:04:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:04:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:04:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:04:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:29 INFO - https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:31 INFO - Downloaded 24221007 bytes. 13:04:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:04:32 INFO - Return code: 0 13:04:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:04:32 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')]} 13:04:32 INFO - https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:39 INFO - Downloaded 24221007 bytes. 13:04:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:04:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:04:40 INFO - Return code: 0 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:40 INFO - https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:04:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:04:41 INFO - Downloaded 14405384 bytes. 13:04:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:04:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:04:42 INFO - Return code: 0 13:04:42 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')]} 13:04:42 INFO - https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:04:44 INFO - Downloaded 60117708 bytes. 13:04:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:04:44 INFO - mkdir: /builds/slave/test/properties 13:04:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:04:44 INFO - Writing to file /builds/slave/test/properties/build_url 13:04:44 INFO - Contents: 13:04:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:04:45 INFO - Running post-action listener: _resource_record_post_action 13:04:45 INFO - Running post-action listener: set_extra_try_arguments 13:04:45 INFO - ##### 13:04:45 INFO - ##### Finished download-and-extract step (success) 13:04:45 INFO - ##### 13:04:45 INFO - ##### 13:04:45 INFO - ##### Running populate-webroot step. 13:04:45 INFO - ##### 13:04:45 INFO - Running pre-action listener: _resource_record_pre_action 13:04:45 INFO - Running main action method: populate_webroot 13:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:45 INFO - '--tppagecycles', 13:04:45 INFO - '7'], 13:04:45 INFO - 'tests': ['tsvgm']}}, 13:04:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:04:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:04:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:04:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['damp', 'tps']}, 13:04:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['damp', 'tps']}, 13:04:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['dromaeo_dom']}, 13:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['basic_compositor_video']}, 13:04:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:04:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['a11yr', 13:04:45 INFO - 'ts_paint', 13:04:45 INFO - 'tpaint', 13:04:45 INFO - 'sessionrestore', 13:04:45 INFO - 'sessionrestore_no_auto_restore', 13:04:45 INFO - 'tabpaint']}, 13:04:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tsvgx', 13:04:45 INFO - 'tsvgr_opacity', 13:04:45 INFO - 'tart', 13:04:45 INFO - 'tscrollx', 13:04:45 INFO - 'cart']}, 13:04:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:04:45 INFO - 'tsvgr_opacity', 13:04:45 INFO - 'tart', 13:04:45 INFO - 'tscrollx', 13:04:45 INFO - 'cart']}, 13:04:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s'], 13:04:45 INFO - 'tests': ['tp5o']}, 13:04:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'tests': ['tp5o']}, 13:04:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--disable-e10s', 13:04:45 INFO - '--xperf_path', 13:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:45 INFO - 'tests': ['tp5n']}, 13:04:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:45 INFO - 'talos_options': ['--xperf_path', 13:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:45 INFO - 'tests': ['tp5n']}}, 13:04:45 INFO - 'talos.zip': {'path': '', 13:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:45 INFO - Running post-action listener: _resource_record_post_action 13:04:45 INFO - ##### 13:04:45 INFO - ##### Finished populate-webroot step (success) 13:04:45 INFO - ##### 13:04:45 INFO - ##### 13:04:45 INFO - ##### Running create-virtualenv step. 13:04:45 INFO - ##### 13:04:45 INFO - Running pre-action listener: _resource_record_pre_action 13:04:45 INFO - Running main action method: create_virtualenv 13:04:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:04:45 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 13:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:04:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:45 INFO - Using real prefix '/usr' 13:04:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:04:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:48 INFO - Installing pip.................done. 13:04:48 INFO - Return code: 0 13:04:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:04:48 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')]} 13:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 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')]} 13:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:48 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 13:04:48 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 13:04:48 INFO - Using env: {'DISPLAY': ':0', 13:04:48 INFO - 'HOME': '/home/cltbld', 13:04:48 INFO - 'LANG': 'en_US.UTF-8', 13:04:48 INFO - 'LANGUAGE': 'en_US:en', 13:04:48 INFO - 'LOGNAME': 'cltbld', 13:04:48 INFO - 'MAIL': '/var/mail/cltbld', 13:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:48 INFO - 'MOZ_NO_REMOTE': '1', 13:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:48 INFO - 'NO_EM_RESTART': '1', 13:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:48 INFO - 'PWD': '/builds/slave/test', 13:04:48 INFO - 'SHELL': '/bin/bash', 13:04:48 INFO - 'SHLVL': '1', 13:04:48 INFO - 'TERM': 'linux', 13:04:48 INFO - 'TMOUT': '86400', 13:04:48 INFO - 'USER': 'cltbld', 13:04:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:48 INFO - '_': '/tools/buildbot/bin/python'} 13:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:48 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 13:04:48 INFO - Cleaning up... 13:04:48 INFO - Return code: 0 13:04:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:04:48 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')]} 13:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 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')]} 13:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:48 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 13:04:48 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 13:04:48 INFO - Using env: {'DISPLAY': ':0', 13:04:48 INFO - 'HOME': '/home/cltbld', 13:04:48 INFO - 'LANG': 'en_US.UTF-8', 13:04:48 INFO - 'LANGUAGE': 'en_US:en', 13:04:48 INFO - 'LOGNAME': 'cltbld', 13:04:48 INFO - 'MAIL': '/var/mail/cltbld', 13:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:48 INFO - 'MOZ_NO_REMOTE': '1', 13:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:48 INFO - 'NO_EM_RESTART': '1', 13:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:48 INFO - 'PWD': '/builds/slave/test', 13:04:48 INFO - 'SHELL': '/bin/bash', 13:04:48 INFO - 'SHLVL': '1', 13:04:48 INFO - 'TERM': 'linux', 13:04:48 INFO - 'TMOUT': '86400', 13:04:48 INFO - 'USER': 'cltbld', 13:04:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:48 INFO - '_': '/tools/buildbot/bin/python'} 13:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:48 INFO - Downloading/unpacking psutil>=3.1.1 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:50 INFO - Installing collected packages: psutil 13:04:50 INFO - Running setup.py install for psutil 13:04:50 INFO - building 'psutil._psutil_linux' extension 13:04:50 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 13:04:50 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 13:04:50 INFO - building 'psutil._psutil_posix' extension 13:04:50 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 13:04:50 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 13:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:50 INFO - Successfully installed psutil 13:04:50 INFO - Cleaning up... 13:04:51 INFO - Return code: 0 13:04:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:51 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:51 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 13:04:51 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 13:04:51 INFO - Using env: {'DISPLAY': ':0', 13:04:51 INFO - 'HOME': '/home/cltbld', 13:04:51 INFO - 'LANG': 'en_US.UTF-8', 13:04:51 INFO - 'LANGUAGE': 'en_US:en', 13:04:51 INFO - 'LOGNAME': 'cltbld', 13:04:51 INFO - 'MAIL': '/var/mail/cltbld', 13:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:51 INFO - 'MOZ_NO_REMOTE': '1', 13:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:51 INFO - 'NO_EM_RESTART': '1', 13:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:51 INFO - 'PWD': '/builds/slave/test', 13:04:51 INFO - 'SHELL': '/bin/bash', 13:04:51 INFO - 'SHLVL': '1', 13:04:51 INFO - 'TERM': 'linux', 13:04:51 INFO - 'TMOUT': '86400', 13:04:51 INFO - 'USER': 'cltbld', 13:04:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:51 INFO - '_': '/tools/buildbot/bin/python'} 13:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:51 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 13:04:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:04:53 INFO - Installing collected packages: mozsystemmonitor 13:04:53 INFO - Running setup.py install for mozsystemmonitor 13:04:53 INFO - Successfully installed mozsystemmonitor 13:04:53 INFO - Cleaning up... 13:04:53 INFO - Return code: 0 13:04:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:04:53 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')]} 13:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:53 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')]} 13:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:53 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:53 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 13:04:53 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 13:04:53 INFO - Using env: {'DISPLAY': ':0', 13:04:53 INFO - 'HOME': '/home/cltbld', 13:04:53 INFO - 'LANG': 'en_US.UTF-8', 13:04:53 INFO - 'LANGUAGE': 'en_US:en', 13:04:53 INFO - 'LOGNAME': 'cltbld', 13:04:53 INFO - 'MAIL': '/var/mail/cltbld', 13:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:53 INFO - 'MOZ_NO_REMOTE': '1', 13:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:53 INFO - 'NO_EM_RESTART': '1', 13:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:53 INFO - 'PWD': '/builds/slave/test', 13:04:53 INFO - 'SHELL': '/bin/bash', 13:04:53 INFO - 'SHLVL': '1', 13:04:53 INFO - 'TERM': 'linux', 13:04:53 INFO - 'TMOUT': '86400', 13:04:53 INFO - 'USER': 'cltbld', 13:04:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:53 INFO - '_': '/tools/buildbot/bin/python'} 13:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:04:53 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 13:04:53 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 13:04:53 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 13:04:53 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 13:04:53 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 13:04:53 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 13:04:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:55 INFO - warning: no files found matching '*.txt' 13:04:55 INFO - no previously-included directories found matching 'build' 13:04:55 INFO - no previously-included directories found matching 'dist' 13:04:55 INFO - no previously-included directories found matching '.git*' 13:04:55 INFO - Installing collected packages: jsonschema, functools32 13:04:55 INFO - Running setup.py install for functools32 13:04:55 INFO - warning: no files found matching '*.txt' 13:04:55 INFO - no previously-included directories found matching 'build' 13:04:55 INFO - no previously-included directories found matching 'dist' 13:04:55 INFO - no previously-included directories found matching '.git*' 13:04:55 INFO - Successfully installed jsonschema functools32 13:04:55 INFO - Cleaning up... 13:04:55 INFO - Return code: 0 13:04:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:04:55 INFO - Using env: {'DISPLAY': ':0', 13:04:55 INFO - 'HOME': '/home/cltbld', 13:04:55 INFO - 'LANG': 'en_US.UTF-8', 13:04:55 INFO - 'LANGUAGE': 'en_US:en', 13:04:55 INFO - 'LOGNAME': 'cltbld', 13:04:55 INFO - 'MAIL': '/var/mail/cltbld', 13:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:55 INFO - 'MOZ_NO_REMOTE': '1', 13:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:55 INFO - 'NO_EM_RESTART': '1', 13:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:55 INFO - 'PWD': '/builds/slave/test', 13:04:55 INFO - 'SHELL': '/bin/bash', 13:04:55 INFO - 'SHLVL': '1', 13:04:55 INFO - 'TERM': 'linux', 13:04:55 INFO - 'TMOUT': '86400', 13:04:55 INFO - 'USER': 'cltbld', 13:04:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:55 INFO - '_': '/tools/buildbot/bin/python'} 13:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:58 INFO - Downloading docopt-0.6.1.tar.gz 13:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:58 INFO - Running setup.py install for blobuploader 13:04:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:04:59 INFO - Running setup.py install for requests 13:04:59 INFO - Running setup.py install for docopt 13:04:59 INFO - Successfully installed blobuploader requests docopt 13:04:59 INFO - Cleaning up... 13:04:59 INFO - Return code: 0 13:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:04:59 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 13:04:59 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 13:04:59 INFO - Using env: {'DISPLAY': ':0', 13:04:59 INFO - 'HOME': '/home/cltbld', 13:04:59 INFO - 'LANG': 'en_US.UTF-8', 13:04:59 INFO - 'LANGUAGE': 'en_US:en', 13:04:59 INFO - 'LOGNAME': 'cltbld', 13:04:59 INFO - 'MAIL': '/var/mail/cltbld', 13:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:59 INFO - 'MOZ_NO_REMOTE': '1', 13:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:59 INFO - 'NO_EM_RESTART': '1', 13:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:59 INFO - 'PWD': '/builds/slave/test', 13:04:59 INFO - 'SHELL': '/bin/bash', 13:04:59 INFO - 'SHLVL': '1', 13:04:59 INFO - 'TERM': 'linux', 13:04:59 INFO - 'TMOUT': '86400', 13:04:59 INFO - 'USER': 'cltbld', 13:04:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:59 INFO - '_': '/tools/buildbot/bin/python'} 13:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:59 INFO - Running setup.py (path:/tmp/pip-Elev0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:59 INFO - Running setup.py (path:/tmp/pip-GHSBU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:59 INFO - Running setup.py (path:/tmp/pip-V3N3wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:59 INFO - Running setup.py (path:/tmp/pip-9lfNpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:00 INFO - Running setup.py (path:/tmp/pip-77x07g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:00 INFO - Running setup.py (path:/tmp/pip-gs8Bir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:00 INFO - Running setup.py (path:/tmp/pip-Ed7GCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:00 INFO - Running setup.py (path:/tmp/pip-SOZdi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:00 INFO - Running setup.py (path:/tmp/pip-10bcR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:00 INFO - Running setup.py (path:/tmp/pip-TW3xdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:00 INFO - Running setup.py (path:/tmp/pip-56uXGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:00 INFO - Running setup.py (path:/tmp/pip-iHJtf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:00 INFO - Running setup.py (path:/tmp/pip-uWChhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:00 INFO - Running setup.py (path:/tmp/pip-R95or5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:00 INFO - Running setup.py (path:/tmp/pip-FelUVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:00 INFO - Running setup.py (path:/tmp/pip-XXKeWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:00 INFO - Running setup.py (path:/tmp/pip-p1D7tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:00 INFO - Running setup.py install for manifestparser 13:05:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozcrash 13:05:01 INFO - Running setup.py install for mozdebug 13:05:01 INFO - Running setup.py install for mozdevice 13:05:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozfile 13:05:01 INFO - Running setup.py install for mozhttpd 13:05:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozinfo 13:05:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozInstall 13:05:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for mozleak 13:05:01 INFO - Running setup.py install for mozlog 13:05:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:05:01 INFO - Running setup.py install for moznetwork 13:05:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozprocess 13:05:02 INFO - Running setup.py install for mozprofile 13:05:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozrunner 13:05:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Running setup.py install for mozscreenshot 13:05:02 INFO - Running setup.py install for moztest 13:05:02 INFO - Running setup.py install for mozversion 13:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:02 INFO - Cleaning up... 13:05:02 INFO - Return code: 0 13:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:02 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:05:02 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 13:05:02 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 13:05:02 INFO - Using env: {'DISPLAY': ':0', 13:05:02 INFO - 'HOME': '/home/cltbld', 13:05:02 INFO - 'LANG': 'en_US.UTF-8', 13:05:02 INFO - 'LANGUAGE': 'en_US:en', 13:05:02 INFO - 'LOGNAME': 'cltbld', 13:05:02 INFO - 'MAIL': '/var/mail/cltbld', 13:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:02 INFO - 'MOZ_NO_REMOTE': '1', 13:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:02 INFO - 'NO_EM_RESTART': '1', 13:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:02 INFO - 'PWD': '/builds/slave/test', 13:05:02 INFO - 'SHELL': '/bin/bash', 13:05:02 INFO - 'SHLVL': '1', 13:05:02 INFO - 'TERM': 'linux', 13:05:02 INFO - 'TMOUT': '86400', 13:05:02 INFO - 'USER': 'cltbld', 13:05:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:02 INFO - '_': '/tools/buildbot/bin/python'} 13:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:02 INFO - Running setup.py (path:/tmp/pip-v9gPUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:03 INFO - Running setup.py (path:/tmp/pip-ZOrfSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:03 INFO - Running setup.py (path:/tmp/pip-gGzzah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:03 INFO - Running setup.py (path:/tmp/pip-sc5Zat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:03 INFO - Running setup.py (path:/tmp/pip-pWZiqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:03 INFO - Running setup.py (path:/tmp/pip-kgFxHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:03 INFO - Running setup.py (path:/tmp/pip-fuheEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:03 INFO - Running setup.py (path:/tmp/pip-TBNUFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:03 INFO - Running setup.py (path:/tmp/pip-8wiBtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:03 INFO - Running setup.py (path:/tmp/pip-oSlFDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:03 INFO - Running setup.py (path:/tmp/pip-y7uSMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:03 INFO - Running setup.py (path:/tmp/pip-17_9Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:03 INFO - Running setup.py (path:/tmp/pip-JrmjYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:03 INFO - Running setup.py (path:/tmp/pip-Jr9l3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:03 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)) 13:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:03 INFO - Running setup.py (path:/tmp/pip-S95nCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:04 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)) 13:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:04 INFO - Running setup.py (path:/tmp/pip-UbOaqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:04 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)) 13:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:04 INFO - Running setup.py (path:/tmp/pip-bIninm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 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)) 13:05:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:06 INFO - Downloading blessings-1.6.tar.gz 13:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:06 INFO - Installing collected packages: blessings 13:05:06 INFO - Running setup.py install for blessings 13:05:06 INFO - Successfully installed blessings 13:05:06 INFO - Cleaning up... 13:05:06 INFO - Return code: 0 13:05:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:06 INFO - Reading from file tmpfile_stdout 13:05:06 INFO - Current package versions: 13:05:06 INFO - argparse == 1.2.1 13:05:06 INFO - blessings == 1.6 13:05:06 INFO - blobuploader == 1.2.4 13:05:06 INFO - docopt == 0.6.1 13:05:06 INFO - functools32 == 3.2.3-2 13:05:06 INFO - jsonschema == 2.5.1 13:05:06 INFO - manifestparser == 1.1 13:05:06 INFO - mozInstall == 1.12 13:05:06 INFO - mozcrash == 0.17 13:05:06 INFO - mozdebug == 0.1 13:05:06 INFO - mozdevice == 0.48 13:05:06 INFO - mozfile == 1.2 13:05:06 INFO - mozhttpd == 0.7 13:05:06 INFO - mozinfo == 0.9 13:05:06 INFO - mozleak == 0.1 13:05:06 INFO - mozlog == 3.2 13:05:06 INFO - moznetwork == 0.27 13:05:06 INFO - mozprocess == 0.22 13:05:06 INFO - mozprofile == 0.28 13:05:06 INFO - mozrunner == 6.11 13:05:06 INFO - mozscreenshot == 0.1 13:05:06 INFO - mozsystemmonitor == 0.3 13:05:06 INFO - moztest == 0.7 13:05:06 INFO - mozversion == 1.4 13:05:06 INFO - psutil == 3.1.1 13:05:06 INFO - requests == 1.2.3 13:05:06 INFO - wsgiref == 0.1.2 13:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:05:06 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 13:05:06 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 13:05:06 INFO - Using env: {'DISPLAY': ':0', 13:05:06 INFO - 'HOME': '/home/cltbld', 13:05:06 INFO - 'LANG': 'en_US.UTF-8', 13:05:06 INFO - 'LANGUAGE': 'en_US:en', 13:05:06 INFO - 'LOGNAME': 'cltbld', 13:05:06 INFO - 'MAIL': '/var/mail/cltbld', 13:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:06 INFO - 'MOZ_NO_REMOTE': '1', 13:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:06 INFO - 'NO_EM_RESTART': '1', 13:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:06 INFO - 'PWD': '/builds/slave/test', 13:05:06 INFO - 'SHELL': '/bin/bash', 13:05:06 INFO - 'SHLVL': '1', 13:05:06 INFO - 'TERM': 'linux', 13:05:06 INFO - 'TMOUT': '86400', 13:05:06 INFO - 'USER': 'cltbld', 13:05:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:06 INFO - '_': '/tools/buildbot/bin/python'} 13:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 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)) 13:05:06 INFO - Cleaning up... 13:05:06 INFO - Return code: 0 13:05:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:06 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:05:06 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 13:05:06 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 13:05:06 INFO - Using env: {'DISPLAY': ':0', 13:05:06 INFO - 'HOME': '/home/cltbld', 13:05:06 INFO - 'LANG': 'en_US.UTF-8', 13:05:06 INFO - 'LANGUAGE': 'en_US:en', 13:05:06 INFO - 'LOGNAME': 'cltbld', 13:05:06 INFO - 'MAIL': '/var/mail/cltbld', 13:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:06 INFO - 'MOZ_NO_REMOTE': '1', 13:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:06 INFO - 'NO_EM_RESTART': '1', 13:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:06 INFO - 'PWD': '/builds/slave/test', 13:05:06 INFO - 'SHELL': '/bin/bash', 13:05:06 INFO - 'SHLVL': '1', 13:05:06 INFO - 'TERM': 'linux', 13:05:06 INFO - 'TMOUT': '86400', 13:05:06 INFO - 'USER': 'cltbld', 13:05:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:06 INFO - '_': '/tools/buildbot/bin/python'} 13:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:05:07 INFO - Cleaning up... 13:05:07 INFO - Return code: 0 13:05:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:05: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')]} 13:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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')]} 13:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:07 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 0x7f105417df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, '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': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', '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 13:05:07 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 13:05:07 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 13:05:07 INFO - Using env: {'DISPLAY': ':0', 13:05:07 INFO - 'HOME': '/home/cltbld', 13:05:07 INFO - 'LANG': 'en_US.UTF-8', 13:05:07 INFO - 'LANGUAGE': 'en_US:en', 13:05:07 INFO - 'LOGNAME': 'cltbld', 13:05:07 INFO - 'MAIL': '/var/mail/cltbld', 13:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:07 INFO - 'MOZ_NO_REMOTE': '1', 13:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:07 INFO - 'NO_EM_RESTART': '1', 13:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:07 INFO - 'PWD': '/builds/slave/test', 13:05:07 INFO - 'SHELL': '/bin/bash', 13:05:07 INFO - 'SHLVL': '1', 13:05:07 INFO - 'TERM': 'linux', 13:05:07 INFO - 'TMOUT': '86400', 13:05:07 INFO - 'USER': 'cltbld', 13:05:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:07 INFO - '_': '/tools/buildbot/bin/python'} 13:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:07 INFO - Downloading/unpacking flake8 13:05:07 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 13:05:07 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 13:05:07 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 13:05:07 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 13:05:07 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 13:05:07 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 13:05:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:05:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:05:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 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 13:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:09 INFO - no previously-included directories found matching 'docs/_build' 13:05:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:05:09 INFO - Running setup.py install for pep8 13:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:09 INFO - no previously-included directories found matching 'docs/_build' 13:05:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:05:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:05:10 INFO - Cleaning up... 13:05:10 INFO - Return code: 0 13:05:10 INFO - Running post-action listener: _resource_record_post_action 13:05:10 INFO - Running post-action listener: _start_resource_monitoring 13:05:10 INFO - Starting resource monitoring. 13:05:10 INFO - ##### 13:05:10 INFO - ##### Finished create-virtualenv step (success) 13:05:10 INFO - ##### 13:05:10 INFO - ##### 13:05:10 INFO - ##### Running install step. 13:05:10 INFO - ##### 13:05:10 INFO - Running pre-action listener: _resource_record_pre_action 13:05:10 INFO - Running main action method: install 13:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:10 INFO - Reading from file tmpfile_stdout 13:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:05:10 INFO - Reading from file tmpfile_stdout 13:05:10 INFO - Output received: 13:05:10 INFO - Usage: mozinstall [options] installer 13:05:10 INFO - Options: 13:05:10 INFO - -h, --help show this help message and exit 13:05:10 INFO - -d DEST, --destination=DEST 13:05:10 INFO - Directory to install application into. [default: 13:05:10 INFO - "/builds/slave/test"] 13:05:10 INFO - --app=APP Application being installed. [default: firefox] 13:05:10 INFO - mkdir: /builds/slave/test/build/application 13:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:05:27 INFO - Reading from file tmpfile_stdout 13:05:27 INFO - Output received: 13:05:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:05:27 INFO - Running post-action listener: _resource_record_post_action 13:05:27 INFO - ##### 13:05:27 INFO - ##### Finished install step (success) 13:05:27 INFO - ##### 13:05:27 INFO - ##### 13:05:27 INFO - ##### Running run-tests step. 13:05:27 INFO - ##### 13:05:27 INFO - Running pre-action listener: _resource_record_pre_action 13:05:27 INFO - Running main action method: run_tests 13:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:05:27 INFO - Python 2.7.3 13:05:27 INFO - Return code: 0 13:05:27 INFO - grabbing minidump binary from tooltool 13:05: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')]} 13:05:27 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 0x1bf62e0>, '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 0x1b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b625d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:05:27 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 13:05:27 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 13:05:27 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 13:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:27 INFO - Return code: 0 13:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:05:28 INFO - Return code: 0 13:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:05:28 INFO - Using env: {'DISPLAY': ':0', 13:05:28 INFO - 'HOME': '/home/cltbld', 13:05:28 INFO - 'LANG': 'en_US.UTF-8', 13:05:28 INFO - 'LANGUAGE': 'en_US:en', 13:05:28 INFO - 'LOGNAME': 'cltbld', 13:05:28 INFO - 'MAIL': '/var/mail/cltbld', 13:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:28 INFO - 'MOZ_NO_REMOTE': '1', 13:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:28 INFO - 'NO_EM_RESTART': '1', 13:05:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:28 INFO - 'PWD': '/builds/slave/test', 13:05:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:05:28 INFO - 'SHELL': '/bin/bash', 13:05:28 INFO - 'SHLVL': '1', 13:05:28 INFO - 'TERM': 'linux', 13:05:28 INFO - 'TMOUT': '86400', 13:05:28 INFO - 'USER': 'cltbld', 13:05:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661', 13:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:28 INFO - '_': '/tools/buildbot/bin/python'} 13:05:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:05:28 INFO - mozversion application_buildid: 20160618103107 13:05:28 INFO - mozversion application_changeset: 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd 13:05:28 INFO - mozversion application_display_name: Nightly 13:05:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:28 INFO - mozversion application_name: Firefox 13:05:28 INFO - mozversion application_remotingname: firefox 13:05:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:05:28 INFO - mozversion application_vendor: Mozilla 13:05:28 INFO - mozversion application_version: 50.0a1 13:05:28 INFO - mozversion platform_buildid: 20160618103107 13:05:28 INFO - mozversion platform_changeset: 6e9946f0a1f68e1d6668eb1291d141ad45ffa0bd 13:05:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:05:28 INFO - mozversion platform_version: 50.0a1 13:05:28 INFO - using testdate: 1466280328 13:05:28 INFO - actual date: 1466280328 13:05:28 INFO - starting webserver on 'localhost:50687' 13:05:28 INFO - SUITE-START | Running 2 tests 13:05:28 INFO - TEST-START | dromaeo_css 13:05:28 INFO - operating with platform_type : linux_ 13:05:28 INFO - Initialising browser for dromaeo_css test... 13:05:28 INFO - TEST-INFO | started process 10864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdTa3oe/profile http://localhost:50687/getInfo.html) 13:05:32 INFO - PROCESS | 10864 | __metrics Screen width/height:1600/1200 13:05:32 INFO - PROCESS | 10864 | colorDepth:24 13:05:32 INFO - PROCESS | 10864 | Browser inner width/height: 1024/697 13:05:32 INFO - PROCESS | 10864 | __metrics 13:05:33 INFO - PROCESS | 10864 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:34 INFO - TEST-INFO | 10864: exit 0 13:05:34 INFO - Browser initialized. 13:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:05:34 INFO - TEST-INFO | started process 10947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdTa3oe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:46 INFO - PROCESS | 10947 | RSS: Main: 173989888 13:05:46 INFO - PROCESS | 10947 | 13:06:37 INFO - PROCESS | 10947 | 1466280397727 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] 13:08:46 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50687/tests/dromaeo/cssquery-ext.html) 13:08:47 INFO - PROCESS | 10947 | RSS: Main: 299995136 13:08:47 INFO - PROCESS | 10947 | 13:11:49 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-ext.html (next: http://localhost:50687/tests/dromaeo/cssquery-jquery.html) 13:11:50 INFO - PROCESS | 10947 | RSS: Main: 259223552 13:11:50 INFO - PROCESS | 10947 | 13:14:52 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50687/tests/dromaeo/cssquery-mootools.html) 13:14:53 INFO - PROCESS | 10947 | RSS: Main: 262361088 13:14:53 INFO - PROCESS | 10947 | 13:17:55 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50687/tests/dromaeo/cssquery-prototype.html) 13:17:55 INFO - PROCESS | 10947 | RSS: Main: 258519040 13:17:55 INFO - PROCESS | 10947 | 13:20:58 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50687/tests/dromaeo/cssquery-yui.html) 13:20:58 INFO - PROCESS | 10947 | RSS: Main: 224272384 13:20:58 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-yui.html (next: http://localhost:50687/tests/dromaeo/cssquery-dojo.html) 13:24:01 INFO - PROCESS | 10947 | RSS: Main: 321540096 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | __start_tp_report 13:24:01 INFO - PROCESS | 10947 | _x_x_mozilla_page_load 13:24:01 INFO - PROCESS | 10947 | _x_x_mozilla_page_load_details 13:24:01 INFO - PROCESS | 10947 | |i|pagename|runs| 13:24:01 INFO - PROCESS | 10947 | |0;dojo.html;3099.256178517155;3107.502799552072;3139.2622733657595;3168.3980043791676;3169.9366012679734;5132.178851383779;5186.32577764891;5332.386775520811;5447.210154527591;5454.509094181523;5234.659747116435;5294.894102117955;5336.332958380202;5406.16204488304;5411.756470958807;4801.663883528155;4832.009438065197;4846.806127754886;4952.504749525055;5040.571551418134;4764.976175119137;4910.361652985125;4944.752762361885;4959.206526955688;5000.449950505442;4696.8590942271785;4723.622110231207;4739.170645137122;4837.685550439211;4871.902561948759;4807.399075115611;4807.61539076873;4818.831340903052;4821.276808478721;4853.417589889201;4764.094821983812;4767.594754445876;4771.665983381165;4774.474807771142;4776.140294746944;5181.637285390024;5190.948090519084;5195.636305458619;5206.609504287194;5220.321358223407;5574.60977731559;5609.523190528769;5672.6312789668955;5738.024535828919;5740.512056475204;5826.038703613898;5847.502962248214;5865.002949498553;5875.676837773964;5878.764849406061;5194.168932970707;5396.298481197419;5448.83653490396;5455.972720136374;5461.836144915659;5854.034084376115;5883.823485295448;5927.2590926134235;5983.61106528083;6004.1294012368835;5763.682997435098;5769.048107062287;5771.509421699118;5780.479756821822;5782.855428614318;5503.257060296889;5622.072358060956;5825.563082768809;5830.4461076197695;5854.882902341929;5699.458551437607;5745.9425405745405;5757.769689212469;5760.798372056958;5809.3609702932645;5764;5764.510016648632;5767.394423585463;5768.942310576925;5773.24947756789;4238.406623072772;4338.392625032498;4389.495208051051;4403.295472724349;4445.599896009375;3925.92148157041;3931.0958479549863;3933.8623148189677;3960.821763020671;3969.54350249725;5422.566194704415;5424.7016414096815;5432.456754324615;5436.70098144598;5480.753366098455;5549.72251387429;5648.74580643872;5665.263515742927;5699.886002279931;5848.5321174305955;5335.573154147659;5356.866078348073;5360.946390536044;5364.114921038063;5364.195370694427;4794.9280760788615;4797.2564252540915;4799.66402351832;4817.470078291385;4844.515548445198;5790.189373487715;5805.303363596396;5814.796482123105;5831.7375718091935;5904.9704751475965;5624.493795558419;5683.545316374597;5685.118806584986;5688.857778555569;5726.742296596746;5854.824355269348;5857.824265272048;5858.560607954335;5862.648241105548;5882.382349853204;5474.315710536183;5541.667499950016;5546.362168350692;5581.665100094007;5615.438456154352;5721.5136713379825;5722.2561067061015;5723.284589426322;5726.656400615976;5729.742161602655;5581.162825576033;5581.162825576196;5594.496495315441;5599.412061733622;5604.551635869202;5394;5502.284702988586;5514.448555144614;5539.806106786243;5547.639403438763;5459.836204913859;5477.616566840283;5482.5613950884635;5486.780528778804;5493.972530137324;5438.6192966493545;5564.777408903598;5596.636218645775;5639.182318563868;5647.604667673223;5416.350037995466;5485.862853428696;5509.641873278224;5512.980098681756;5535 13:24:01 INFO - PROCESS | 10947 | |1;ext.html;581.226968132384;617.0836308082497;620.9441150296474;625.3621306267607;641.2945759664367;31309.060728178163;43211;44364.556354436485;44383.55616443835;44428.555714442846;45526.772366138124;45904.31143532841;45911.770441147746;45976;45982.310265346045;9007.279417646589;9156.084391560857;9157.130072643089;9157.175854173123;9160.267178625727;8804.119588041209;8888.511131887775;8909.376343655947;8910.064443233465;8912.287017038654;8952.8657070144;8967.461952282883;8972.775680607972;8980.685676001309;8987.191152796247;8884.33367497437;8928.196462318358;8930.240929520998;8931.062238464998;8937.061608531109;8996.415233009899;9054.592543335566;9056.411333263317;9061.048589898097;9069.093090690943;42575.7871210645;43151.13697726059;43161;43210.56789432097;43214.35178472326;3337.332533493287;3580.6777390034763;3644.5444319460066;3781.5840257571645;3791.7724936503896;30885.845570772228;31418.528722068957;31804.204894877814;32088.358232835213;34211.65788342134;4403.53762854902;4441.222786012435;4446.133004064209;4476.664250181249;4671.346011558385;363744;364873;366877;367437;367638;61903.690481548205;62223;62262.37737622656;62341.688291558254;62368.37631623716;35490.64509354874;36085.63914360875;36294.092647683494;37700.81149594235;37946.430803537965;17622.823771762374;17808.46574602764;17865.7320140198;17869.46391608254;17875.910620447074;13679.931600341935;13862.722745545234;13891.86108138926;13895.235762033186;13897.861021389657;19129.832203137983;19410.08657686499;19417.591184092395;19519.414417567496;19623.411297661092;6993.790186294419;7093.645317734093;7172.318629730167;7197.820054498679;7206.207317195104;968.2109081098882;1051.6109039655375;1119.4794420594462;1130.559081958037;1172.9178957472895;32267;32503.187420314207;32515.349693006006;32609.347813043605;32878.506822397685;1103.5475455063386;1116.9497372618252;1119.4850368830266;1160.4545863444168;1191.398343836357;16306.673866522604;17028.829711702972;17069.146542672817;17131.914340428466;17278.481645550655;153307;153481;154518.22740886224;155267;584835;59634.70182649059;60286;60442.39557604455;60527.394726052175;60614.696926515084;1226.405193481161;1331.2345401394043;1375.4910683047337;1385.231196685849;1389.603962870577;31601.20996975094;33095.33809323752;33173.83413082919;33331.333373332884;33809.49285760765;50172.498275016784;50907.2363914549;50962.23556646579;50964.490355097456;51003.48996509987;402211;409085;409395;409426;410618;24719;27205.319867003484;27463.86268068647;27820.026299079436;28018.85990570034;48788.458751629274;48952.75523622359;49703.25445118399;49766.253506196714;50051.249231262285;41193.38209926793;41752.791236043624;42021.15957680768;42069.15861682688;42826.57173428226;40088;40597.39103913384;40633.79683101566;41102.17795644011;42041.78979105085;40455.1908961825;41379.1724165521;41462;41788;41826.95432614209;35786.28427431489;37248;37262.25475490529;37783.43324850075;37811.432828507044;27251;27800.582991255553;27834.304142396602;28759.28101797388;29738.55392169076 13:24:01 INFO - PROCESS | 10947 | |2;jquery.html;390.2448761646214;390.74406263897157;398.91822176453815;399.66028875455856;415.7734034950951;14480.13119212848;16332;18087.095645217734;18799.992001279814;18814.717779233306;18351.90824045881;19121.733741178366;19764.901175494102;19921.60156796863;19924.900375498102;5315.893682126355;5525.778968841241;5573.637713548626;5671.574631902603;5714.485696287334;4086.427900093974;5656.717164141797;5728.198052272685;5739.397363276858;5852.941470585303;6199.5350348723805;6236.189295391593;6254.718537665816;6265.122882796412;6265.530085243602;6057.227056410654;6245.937540624604;6386.425221730044;6475.255345635265;6496.317886621884;5715.485606295411;5722.656640601577;5726.627769194989;5726.942730572724;5746.770129194827;23204.65193022106;24733.381665458506;24757.752422475725;24845;26340.73659263402;2438.8658623775686;2450.889709963038;2459.655648209234;2504.561701702195;2539.9111031114007;15578.532644020697;15636.530904072895;15947.601309967227;15977.281022353905;16622.36168851936;1975.1803001754254;2017.1628774058747;2052.1688716070016;2058.3310424112074;2147.95704085919;88042;98857;99749;100029.499852501;101189.49405252926;17677.558061048578;17786.66600005005;17833.821661783477;18102.45692629223;18232.908835456004;26555.46889062208;28342.71657283442;29954.40091198164;33014.50478242828;33238.66761332356;9978.301518893753;10100.494975251208;10375.636852710119;10591.470426478645;10612;8913.821723565492;8939.821203575892;8999.505027223435;9116.58975346111;9144;8719.433236839584;8802.779930501789;8976.955115224382;9181.862272065924;9210.263178945668;3213.4697774866886;3365.4110530657035;3485.790852548855;3512.3853325668415;3586.4276377588826;902.5893218585528;1032.607609108534;1033.4574348466965;1044.0081922173813;1089.8147314956318;18878;19136.521586960436;19276.301317815516;19447.319343823183;19563.413097607096;965.0638880286111;973.5473005052543;984.9950750246203;987.9506024698736;995.2784231432154;10372.688819335432;10826.079783218358;10866.67399978002;10894.727631809268;10901.563937442572;491864;503005;503785;504229;547192;88869.55565222133;93125;101763.49118254361;101841;102051.83585313158;442.9069895321954;451.6612540594554;453.9863804085883;457.6041723908795;457.7093545598635;10481.475926203811;10662.200334974752;11024.393658348547;11167.173555367139;11231.483749693687;29880.85059574775;40414.1917161661;41704.3744343829;42298.78850605727;44637;59372;59723;60583.39416605954;60892;61322.386776131665;8545;8631.6978905738;8735.388522803343;8933.330000249878;8991.325650576102;12755.74488510206;13931.860681393056;13954.95337849645;14273.57179284623;14331.426742930165;11323.263987840764;11657.708557286136;12225.633231003085;12279.324637145042;12334.876651233373;11836.349000805038;12280.508779648713;12290.078244131904;12292.50829966827;12449.128561000643;11754.529818807152;11939.46272417726;12064.215825971283;12205.389730513616;12525.123241373381;8404.243618074403;8662.177093176138;8804.383693141419;8979.595918183828;9034.728958131267;11738;11995.82006269924;12044.75910481768;12054.915057644854;12243.20419172751 13:24:01 INFO - PROCESS | 10947 | |3;mootools.html;1156.4102307823007;1431.348736324972;1459.8175228096486;1561.2193903048476;1704.4460550321141;7616.923830761691;8158.959205203973;8450.028246751617;8452.366072544553;8659.09079546648;8335.791605209874;8509.574521273928;8515.701950431736;8518.87221691675;8522.659093636246;1951.7853036166011;2192.4628466025847;2267.489814791675;2273.374821923972;2309.445733024079;2307.204014614955;2333.4516388648653;2337.55586438577;2337.7077865266842;2338.38032921276;2280.1107568048474;2290.061074959267;2311.537692461506;2312.236961802601;2313.2366319114735;1912.2351059576142;2142.1110239250693;2201.7688142745023;2215.523662412573;2220.8001279884725;2221.1892659179443;2224.744154422246;2230.163688616769;2239.955200895973;2241.9775802241934;8654.350923680686;8703.738887833375;8708.956455217747;8726.956365218133;8727.738167854974;4964.578010869081;5097.13348730713;5099.617528685327;5100;5101.69389836611;3210.020943612221;3255.7232635225796;3307.603087629476;3443.8278086095847;3450.9827450862585;1060.533365319257;1075.2365820267619;1091.1707102602;1094.9945250273697;1095.5070218401672;11684.240524365889;11696.415179241005;11698.23961442512;11703.18077734559;11716.765664686744;4378.912421751611;4430.645548356124;4527.411436513232;4532.184206842734;4536.72779633223;9956.551955162035;9958.502074896227;9961.900380996241;9968.501574921225;9985.650502232387;5132.486751324837;5139.383274007143;5144.819931302386;5147.948520514822;5151.2530683050745;3994.800259986989;4572;4711.858644240679;4715.104130215248;4777.020710754287;3759.9248015039548;3807.4479200516325;3867.0332416895776;3893.844246230119;3927.7446965947124;1208.1422190244848;1215.1858254969193;1220.6460126563197;1227.2575092069349;1233.7532493501335;936.5270538378076;959.4387283439266;960.8318544254728;966.1690945786618;981.3915372469115;5687.886242275132;5757.712114394263;5865;5877.177195192677;5970.432808883149;1028.9176865850714;1046.8325067989238;1052.1793001458875;1054.8312270036756;1088;3909.100906791454;3991.7006224532697;4022.155347377025;4027.456293400412;4036.535798383165;10294;10534.841977370346;10625.46872656364;10638.893611063944;10646.201534884915;10501.264911456125;10504.317219380715;10506;10511.52698128586;10524.105451036594;7404;7707.730229442055;7989.800254993555;8053.07389650186;8098.75703728889;5756.42435756421;5760.769569217185;5834.212381328466;5909.763609455574;6006.069059295816;9444.95277523608;9538.90461095408;9733.853992190265;9882.851757223503;9981.650642227487;9696.418214907128;10035.34770239932;10046.543251228384;10055.597776088875;10066.194704423775;6510.251321098134;7384.4830861839155;7429.219931907072;7523.924760752322;7673.194314596887;8394.538300393537;8463.026751923362;8511.233988941025;8557.529335886586;8561.61472733741;7372.520786148883;7420.925790742023;7449.776506704808;7591.848163036819;7696.576688282198;7467;7479.850402992019;7517.436192285491;7622.69509219625;7651.234876512304;6341.175647165839;6375.171227740364;6399.584027038228;6401.519886008661;6402.903956440564;4913.70517768935;5051.924221136613;5059.949400505948;5085.7711402986215;5156.2523434102595;4789.114013907439;4932.8520144395725;5006.974965125151;5094.363204599425;5266.104762190514 13:24:01 INFO - PROCESS | 10947 | |4;prototype.html;311.32753252973566;314.25521514011797;323.36136131141;327.35511043244816;329.5320644684548;5108.4125325587565;5280.947190528093;5356.919646205305;5397.298351214342;5403.297571315733;5252.553532949704;5282.128448805943;5337.386200586933;5347.331583552056;5352.57179425646;4193.475815523059;4200.51694055183;4203.285441474956;4204.705670603059;4216.093539888923;3931.528216613996;3946.9605303947023;4125.834966601347;4181.372794080882;4194.30793919003;4110.342345224764;4115.176964607075;4116.192521917214;4131.834726610947;4153.584641535853;4084.264832330179;4128.153728485653;4132.710710250299;4153.813078411479;4163;3418.3334249821296;3680.595134535199;3686.041629176407;3689.94465083024;3708.4251940948925;5105.744712764347;5118.769655365518;5121.8463446096675;5126;5130.615203859726;4692.718436893797;4695.957258592523;4698.788554515021;4704.941388187664;4708.317293992352;5279.736013199363;5410.567154627621;5516.117421212627;5530.92147031329;5533.584981126432;3952.1107750756137;3953.743006704555;3955.564887862333;3957.1294315250598;3971.7815520146382;5750.827475175752;5781.421857814227;5790.449907258846;5793.248207101635;5836.299644042742;3944.6647035001774;4031.778252196157;4038.9394159087637;4052.756834589934;4071.4096456013713;4111.506619205715;4114.485689288839;4126.607972242632;4128.422020917074;4148.771817550064;4670.159371313196;4671.602913752301;4673.532646735367;4688.789004494806;4701.882452938636;5543.7249432629915;5587.217789509472;5595.300587426572;5595.8528501657065;5629.380768115504;1349.9392527336292;1401.9579412617638;1407.8240219972504;1412.69627030189;1416.0512456654067;858.3605214115399;880.3837313880309;886.866969954512;889.7953470701775;894.280104515871;4680.5085466025575;4710.6702530823195;4759.738214398241;4772.7136371817805;4782.163121453732;4992.500749925051;5003.5997120230295;5020.849374518771;5027;5084.923726144111;4433.623142032963;4702.506236845151;4724.244120940633;4733.83431579893;4787.664863459524;2670.3858112633816;2685.5434576122107;2710.268227578543;2715.5112079825426;2724.4006318609872;5119.667221630582;5146.665466744649;5168.811173430132;5203.60972927032;5213.2701421800975;4785.774614804132;5137.304689452471;5165.874645839288;5177.896442071137;5193.896122077537;5166.416791604198;5205.531502164823;5225.843224703265;5233.581313494911;5235.617793903764;5001.57486613642;5039.790450291976;5047.899042019212;5048.242763585345;5068.366454193226;4714.043671876133;4939.802407903644;4985.551300382983;4996.450390456974;5062.595267248028;5153.45888681683;5182.663126896739;5218.478152184903;5271.551918087006;5274;3615.81920903959;3761.7178711596193;3878.3794592865006;3974.4237085623;3992.6606238470054;5592.944070559242;5610.382857885711;5653.85865353353;5657.830265092054;5663.858403539944;5472.72636368188;5482.533984611353;5484.753186106555;5501.174823776466;5516.889662206813;5218.295530103387;5457.372402173801;5476.397596264487;5479.465749590121;5493.313335833021;5375.784968601369;5383.542398895981;5389;5396;5403.351597808131;5287.968846075132;5436.293281873332;5466.835994920159;5504.458751549572;5513.531349835309;5349.438308977657;5359.196120581944;5362.383325917569;5420.918686219631;5426.240326354235 13:24:01 INFO - PROCESS | 10947 | |5;yui.html;730.6931088942644;767.1369709077288;782.9491083079599;826.0601602417543;851.3189448441245;14964.32660530276;16325.510234692963;16824.32702691891;16939.407120750762;17064.48806535806;15611.297491612877;15617.921910390432;15691.058536487819;15721;15723.449679261228;667.5293917787948;798.2576204130156;804.4007214625112;811.0429692962302;812.0945146162046;798.700487317256;826.4008593769529;827.6399766101765;828.2876726015621;828.6271177969937;826.9627866745981;835.1564919431388;836.021854430318;836.188896770132;837.7486753973814;704.626547929593;816.4448175240834;843.2789964580287;844.5608283692476;844.5988155626089;612.978545750901;615.065101046407;617.6109051297653;617.8640699046248;619.6746707978348;14147.221902795342;14179.361928713233;14184.645383865383;14207.14757114566;14207.360668769827;14640.41438342465;15001.699966000619;15036.699266014619;15116.54650360491;15154.772678409832;13087.672808179777;13130.803037954438;13439.26084065376;13567.1859688419;13707.532644124054;4530.782787777994;4534.342520334533;4545.159145558082;4562.338460923181;4624;59513.404865951656;65518;67772.3222767771;67891;77337;11744.706382340339;11797.941010295066;11831.645050648494;11964.341961192044;12177.573784917662;21518.892405537874;21544.892275538834;21576;22092.55814883693;23876.880615596812;7486.288802563748;7986.001749781278;8121.431499794958;8150.2664760171865;8418.368622353348;4598.398567663043;4883.877903052452;4937.407511098691;4956.306117143603;5126.5898728101665;3336.849841757127;3438.415469370213;3442.7417943654327;3445.3970555152746;3446.1556918555116;619.3527763487077;624.709510077816;627.4259052966485;628.7736414890636;638.2245571630399;590.6131483878066;645.1999520594429;681.9829504262334;697.2887654592288;755.2598453515585;8927.24118449926;9436.858447123299;9626.47054412;9626.95186524077;9729.805403891882;639.4660458517191;660.1978596005875;710.8898120791285;730.7369347035063;746.5520687587513;4243.2998555238655;4347.130573885235;4384.495782984997;4429.313456414261;4487.326900964816;68316.65841670759;69017.3098269021;74321;117036;117136;101923;104623.47688261663;105038.47480762548;105052;105081.47459262655;52728.736356317975;66076.33923660798;87778.56110719405;88483.55758221168;90397.99999999869;8139.674413023413;8274;8363.247307742333;8369.0375606806;8409.495430274203;53070.46929530655;54367;54614.726926366704;55177.172342415695;55603.72198139145;56701.716491417275;78884;79389;79391.60304198442;79530.6023469879;12035.338056406981;12869.420876060787;13097.869021310045;13470.461181552628;13595.388207530486;12154.513819447124;12407.813882791585;12676.683082923;12789.424475898793;12911.935440323114;12635.241885486901;12897.22616642967;13095.41070651842;13231.536896208972;13283.468661253442;11406.942965285121;11518.424078796193;11533.653990380302;12708.809367859305;14243.21662308583;13794.103383280055;14098.36557354901;14147.717045659236;14524.854751452773;14843.183624900734;10637.255392122786;10868.565257389932;10969;11594.362310073027;11702.180847340604;10032.949835250776;10115.696529104138;10172.643957461454;10194.745131371776;10218.335808172445 13:24:01 INFO - PROCESS | 10947 | __end_tp_report 13:24:01 INFO - PROCESS | 10947 | __start_cc_report 13:24:01 INFO - PROCESS | 10947 | _x_x_mozilla_cycle_collect,983 13:24:01 INFO - PROCESS | 10947 | __end_cc_report 13:24:01 INFO - PROCESS | 10947 | __startTimestamp1466281441836__endTimestamp 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | ------- Summary: start ------- 13:24:01 INFO - PROCESS | 10947 | Number of tests: 6 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#0] dojo.html Cycles:165 Average:5300.59 Median:5485.86 stddev:604.07 (11.0%) stddev-sans-first:580.71 13:24:01 INFO - PROCESS | 10947 | Values: 3099.3 3107.5 3139.3 3168.4 3169.9 5132.2 5186.3 5332.4 5447.2 5454.5 5234.7 5294.9 5336.3 5406.2 5411.8 4801.7 4832.0 4846.8 4952.5 5040.6 4765.0 4910.4 4944.8 4959.2 5000.4 4696.9 4723.6 4739.2 4837.7 4871.9 4807.4 4807.6 4818.8 4821.3 4853.4 4764.1 4767.6 4771.7 4774.5 4776.1 5181.6 5190.9 5195.6 5206.6 5220.3 5574.6 5609.5 5672.6 5738.0 5740.5 5826.0 5847.5 5865.0 5875.7 5878.8 5194.2 5396.3 5448.8 5456.0 5461.8 5854.0 5883.8 5927.3 5983.6 6004.1 5763.7 5769.0 5771.5 5780.5 5782.9 5503.3 5622.1 5825.6 5830.4 5854.9 5699.5 5745.9 5757.8 5760.8 5809.4 5764.0 5764.5 5767.4 5768.9 5773.2 4238.4 4338.4 4389.5 4403.3 4445.6 3925.9 3931.1 3933.9 3960.8 3969.5 5422.6 5424.7 5432.5 5436.7 5480.8 5549.7 5648.7 5665.3 5699.9 5848.5 5335.6 5356.9 5360.9 5364.1 5364.2 4794.9 4797.3 4799.7 4817.5 4844.5 5790.2 5805.3 5814.8 5831.7 5905.0 5624.5 5683.5 5685.1 5688.9 5726.7 5854.8 5857.8 5858.6 5862.6 5882.4 5474.3 5541.7 5546.4 5581.7 5615.4 5721.5 5722.3 5723.3 5726.7 5729.7 5581.2 5581.2 5594.5 5599.4 5604.6 5394.0 5502.3 5514.4 5539.8 5547.6 5459.8 5477.6 5482.6 5486.8 5494.0 5438.6 5564.8 5596.6 5639.2 5647.6 5416.4 5485.9 5509.6 5513.0 5535.0 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#1] ext.html Cycles:180 Average:51424.86 Median:409410.50 stddev:95330.89 (23.3%) stddev-sans-first:95521.88 13:24:01 INFO - PROCESS | 10947 | Values: 581.2 617.1 620.9 625.4 641.3 31309.1 43211.0 44364.6 44383.6 44428.6 45526.8 45904.3 45911.8 45976.0 45982.3 9007.3 9156.1 9157.1 9157.2 9160.3 8804.1 8888.5 8909.4 8910.1 8912.3 8952.9 8967.5 8972.8 8980.7 8987.2 8884.3 8928.2 8930.2 8931.1 8937.1 8996.4 9054.6 9056.4 9061.0 9069.1 42575.8 43151.1 43161.0 43210.6 43214.4 3337.3 3580.7 3644.5 3781.6 3791.8 30885.8 31418.5 31804.2 32088.4 34211.7 4403.5 4441.2 4446.1 4476.7 4671.3 363744.0 364873.0 366877.0 367437.0 367638.0 61903.7 62223.0 62262.4 62341.7 62368.4 35490.6 36085.6 36294.1 37700.8 37946.4 17622.8 17808.5 17865.7 17869.5 17875.9 13679.9 13862.7 13891.9 13895.2 13897.9 19129.8 19410.1 19417.6 19519.4 19623.4 6993.8 7093.6 7172.3 7197.8 7206.2 968.2 1051.6 1119.5 1130.6 1172.9 32267.0 32503.2 32515.3 32609.3 32878.5 1103.5 1116.9 1119.5 1160.5 1191.4 16306.7 17028.8 17069.1 17131.9 17278.5 153307.0 153481.0 154518.2 155267.0 584835.0 59634.7 60286.0 60442.4 60527.4 60614.7 1226.4 1331.2 1375.5 1385.2 1389.6 31601.2 33095.3 33173.8 33331.3 33809.5 50172.5 50907.2 50962.2 50964.5 51003.5 402211.0 409085.0 409395.0 409426.0 410618.0 24719.0 27205.3 27463.9 27820.0 28018.9 48788.5 48952.8 49703.3 49766.3 50051.2 41193.4 41752.8 42021.2 42069.2 42826.6 40088.0 40597.4 40633.8 41102.2 42041.8 40455.2 41379.2 41462.0 41788.0 41827.0 35786.3 37248.0 37262.3 37783.4 37811.4 27251.0 27800.6 27834.3 28759.3 29738.6 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#2] jquery.html Cycles:180 Average:31109.79 Median:29917.63 stddev:84360.04 (282.0%) stddev-sans-first:84565.16 13:24:01 INFO - PROCESS | 10947 | Values: 390.2 390.7 398.9 399.7 415.8 14480.1 16332.0 18087.1 18800.0 18814.7 18351.9 19121.7 19764.9 19921.6 19924.9 5315.9 5525.8 5573.6 5671.6 5714.5 4086.4 5656.7 5728.2 5739.4 5852.9 6199.5 6236.2 6254.7 6265.1 6265.5 6057.2 6245.9 6386.4 6475.3 6496.3 5715.5 5722.7 5726.6 5726.9 5746.8 23204.7 24733.4 24757.8 24845.0 26340.7 2438.9 2450.9 2459.7 2504.6 2539.9 15578.5 15636.5 15947.6 15977.3 16622.4 1975.2 2017.2 2052.2 2058.3 2148.0 88042.0 98857.0 99749.0 100029.5 101189.5 17677.6 17786.7 17833.8 18102.5 18232.9 26555.5 28342.7 29954.4 33014.5 33238.7 9978.3 10100.5 10375.6 10591.5 10612.0 8913.8 8939.8 8999.5 9116.6 9144.0 8719.4 8802.8 8977.0 9181.9 9210.3 3213.5 3365.4 3485.8 3512.4 3586.4 902.6 1032.6 1033.5 1044.0 1089.8 18878.0 19136.5 19276.3 19447.3 19563.4 965.1 973.5 985.0 988.0 995.3 10372.7 10826.1 10866.7 10894.7 10901.6 491864.0 503005.0 503785.0 504229.0 547192.0 88869.6 93125.0 101763.5 101841.0 102051.8 442.9 451.7 454.0 457.6 457.7 10481.5 10662.2 11024.4 11167.2 11231.5 29880.9 40414.2 41704.4 42298.8 44637.0 59372.0 59723.0 60583.4 60892.0 61322.4 8545.0 8631.7 8735.4 8933.3 8991.3 12755.7 13931.9 13955.0 14273.6 14331.4 11323.3 11657.7 12225.6 12279.3 12334.9 11836.3 12280.5 12290.1 12292.5 12449.1 11754.5 11939.5 12064.2 12205.4 12525.1 8404.2 8662.2 8804.4 8979.6 9034.7 11738.0 11995.8 12044.8 12054.9 12243.2 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#3] mootools.html Cycles:180 Average:5614.89 Median:4923.28 stddev:3174.72 (64.5%) stddev-sans-first:3165.94 13:24:01 INFO - PROCESS | 10947 | Values: 1156.4 1431.3 1459.8 1561.2 1704.4 7616.9 8159.0 8450.0 8452.4 8659.1 8335.8 8509.6 8515.7 8518.9 8522.7 1951.8 2192.5 2267.5 2273.4 2309.4 2307.2 2333.5 2337.6 2337.7 2338.4 2280.1 2290.1 2311.5 2312.2 2313.2 1912.2 2142.1 2201.8 2215.5 2220.8 2221.2 2224.7 2230.2 2240.0 2242.0 8654.4 8703.7 8709.0 8727.0 8727.7 4964.6 5097.1 5099.6 5100.0 5101.7 3210.0 3255.7 3307.6 3443.8 3451.0 1060.5 1075.2 1091.2 1095.0 1095.5 11684.2 11696.4 11698.2 11703.2 11716.8 4378.9 4430.6 4527.4 4532.2 4536.7 9956.6 9958.5 9961.9 9968.5 9985.7 5132.5 5139.4 5144.8 5147.9 5151.3 3994.8 4572.0 4711.9 4715.1 4777.0 3759.9 3807.4 3867.0 3893.8 3927.7 1208.1 1215.2 1220.6 1227.3 1233.8 936.5 959.4 960.8 966.2 981.4 5687.9 5757.7 5865.0 5877.2 5970.4 1028.9 1046.8 1052.2 1054.8 1088.0 3909.1 3991.7 4022.2 4027.5 4036.5 10294.0 10534.8 10625.5 10638.9 10646.2 10501.3 10504.3 10506.0 10511.5 10524.1 7404.0 7707.7 7989.8 8053.1 8098.8 5756.4 5760.8 5834.2 5909.8 6006.1 9445.0 9538.9 9733.9 9882.9 9981.7 9696.4 10035.3 10046.5 10055.6 10066.2 6510.3 7384.5 7429.2 7523.9 7673.2 8394.5 8463.0 8511.2 8557.5 8561.6 7372.5 7420.9 7449.8 7591.8 7696.6 7467.0 7479.9 7517.4 7622.7 7651.2 6341.2 6375.2 6399.6 6401.5 6402.9 4913.7 5051.9 5059.9 5085.8 5156.3 4789.1 4932.9 5007.0 5094.4 5266.1 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#4] prototype.html Cycles:180 Average:4480.02 Median:5043.84 stddev:1291.74 (25.6%) stddev-sans-first:1256.90 13:24:01 INFO - PROCESS | 10947 | Values: 311.3 314.3 323.4 327.4 329.5 5108.4 5280.9 5356.9 5397.3 5403.3 5252.6 5282.1 5337.4 5347.3 5352.6 4193.5 4200.5 4203.3 4204.7 4216.1 3931.5 3947.0 4125.8 4181.4 4194.3 4110.3 4115.2 4116.2 4131.8 4153.6 4084.3 4128.2 4132.7 4153.8 4163.0 3418.3 3680.6 3686.0 3689.9 3708.4 5105.7 5118.8 5121.8 5126.0 5130.6 4692.7 4696.0 4698.8 4704.9 4708.3 5279.7 5410.6 5516.1 5530.9 5533.6 3952.1 3953.7 3955.6 3957.1 3971.8 5750.8 5781.4 5790.4 5793.2 5836.3 3944.7 4031.8 4038.9 4052.8 4071.4 4111.5 4114.5 4126.6 4128.4 4148.8 4670.2 4671.6 4673.5 4688.8 4701.9 5543.7 5587.2 5595.3 5595.9 5629.4 1349.9 1402.0 1407.8 1412.7 1416.1 858.4 880.4 886.9 889.8 894.3 4680.5 4710.7 4759.7 4772.7 4782.2 4992.5 5003.6 5020.8 5027.0 5084.9 4433.6 4702.5 4724.2 4733.8 4787.7 2670.4 2685.5 2710.3 2715.5 2724.4 5119.7 5146.7 5168.8 5203.6 5213.3 4785.8 5137.3 5165.9 5177.9 5193.9 5166.4 5205.5 5225.8 5233.6 5235.6 5001.6 5039.8 5047.9 5048.2 5068.4 4714.0 4939.8 4985.6 4996.5 5062.6 5153.5 5182.7 5218.5 5271.6 5274.0 3615.8 3761.7 3878.4 3974.4 3992.7 5592.9 5610.4 5653.9 5657.8 5663.9 5472.7 5482.5 5484.8 5501.2 5516.9 5218.3 5457.4 5476.4 5479.5 5493.3 5375.8 5383.5 5389.0 5396.0 5403.4 5288.0 5436.3 5466.8 5504.5 5513.5 5349.4 5359.2 5362.4 5420.9 5426.2 13:24:01 INFO - PROCESS | 10947 | 13:24:01 INFO - PROCESS | 10947 | [#5] yui.html Cycles:180 Average:19790.54 Median:4580.37 stddev:27880.73 (608.7%) stddev-sans-first:27922.21 13:24:01 INFO - PROCESS | 10947 | Values: 730.7 767.1 782.9 826.1 851.3 14964.3 16325.5 16824.3 16939.4 17064.5 15611.3 15617.9 15691.1 15721.0 15723.4 667.5 798.3 804.4 811.0 812.1 798.7 826.4 827.6 828.3 828.6 827.0 835.2 836.0 836.2 837.7 704.6 816.4 843.3 844.6 844.6 613.0 615.1 617.6 617.9 619.7 14147.2 14179.4 14184.6 14207.1 14207.4 14640.4 15001.7 15036.7 15116.5 15154.8 13087.7 13130.8 13439.3 13567.2 13707.5 4530.8 4534.3 4545.2 4562.3 4624.0 59513.4 65518.0 67772.3 67891.0 77337.0 11744.7 11797.9 11831.6 11964.3 12177.6 21518.9 21544.9 21576.0 22092.6 23876.9 7486.3 7986.0 8121.4 8150.3 8418.4 4598.4 4883.9 4937.4 4956.3 5126.6 3336.8 3438.4 3442.7 3445.4 3446.2 619.4 624.7 627.4 628.8 638.2 590.6 645.2 682.0 697.3 755.3 8927.2 9436.9 9626.5 9627.0 9729.8 639.5 660.2 710.9 730.7 746.6 4243.3 4347.1 4384.5 4429.3 4487.3 68316.7 69017.3 74321.0 117036.0 117136.0 101923.0 104623.5 105038.5 105052.0 105081.5 52728.7 66076.3 87778.6 88483.6 90398.0 8139.7 8274.0 8363.2 8369.0 8409.5 53070.5 54367.0 54614.7 55177.2 55603.7 56701.7 78884.0 79389.0 79391.6 79530.6 12035.3 12869.4 13097.9 13470.5 13595.4 12154.5 12407.8 12676.7 12789.4 12911.9 12635.2 12897.2 13095.4 13231.5 13283.5 11406.9 11518.4 11533.7 12708.8 14243.2 13794.1 14098.4 14147.7 14524.9 14843.2 10637.3 10868.6 10969.0 11594.4 11702.2 10032.9 10115.7 10172.6 10194.7 10218.3 13:24:01 INFO - PROCESS | 10947 | -------- Summary: end -------- 13:24:01 INFO - PROCESS | 10947 | 13:24:02 INFO - TEST-INFO | 10947: exit 0 13:24:02 INFO - TEST-OK | dromaeo_css | took 1113965ms 13:24:02 INFO - TEST-START | kraken 13:24:02 INFO - operating with platform_type : linux_ 13:24:02 INFO - Initialising browser for kraken test... 13:24:02 INFO - TEST-INFO | started process 11133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI5stGM/profile http://localhost:50687/getInfo.html) 13:24:06 INFO - PROCESS | 11133 | __metrics Screen width/height:1600/1200 13:24:06 INFO - PROCESS | 11133 | colorDepth:24 13:24:06 INFO - PROCESS | 11133 | Browser inner width/height: 1024/697 13:24:06 INFO - PROCESS | 11133 | __metrics 13:24:07 INFO - PROCESS | 11133 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:24:08 INFO - TEST-INFO | 11133: exit 0 13:24:08 INFO - Browser initialized. 13:24:08 INFO - Running cycle 1/1 for kraken test... 13:24:08 INFO - TEST-INFO | started process 11217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI5stGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:20 INFO - PROCESS | 11217 | RSS: Main: 173834240 13:24:20 INFO - PROCESS | 11217 | 13:24:22 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:23 INFO - PROCESS | 11217 | RSS: Main: 233140224 13:24:23 INFO - PROCESS | 11217 | 13:24:26 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-dft) 13:24:26 INFO - PROCESS | 11217 | RSS: Main: 221618176 13:24:26 INFO - PROCESS | 11217 | 13:24:29 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-fft) 13:24:30 INFO - PROCESS | 11217 | RSS: Main: 287051776 13:24:30 INFO - PROCESS | 11217 | 13:24:32 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-oscillator) 13:24:33 INFO - PROCESS | 11217 | RSS: Main: 198025216 13:24:33 INFO - PROCESS | 11217 | 13:24:35 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:35 INFO - PROCESS | 11217 | RSS: Main: 201842688 13:24:35 INFO - PROCESS | 11217 | 13:24:38 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:39 INFO - PROCESS | 11217 | RSS: Main: 237043712 13:24:39 INFO - PROCESS | 11217 | 13:24:42 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:43 INFO - PROCESS | 11217 | RSS: Main: 238870528 13:24:43 INFO - PROCESS | 11217 | 13:24:46 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50687/tests/kraken/driver.html?testName=json-parse-financial) 13:24:46 INFO - PROCESS | 11217 | RSS: Main: 238260224 13:24:46 INFO - PROCESS | 11217 | 13:24:48 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:49 INFO - PROCESS | 11217 | RSS: Main: 227196928 13:24:49 INFO - PROCESS | 11217 | 13:24:50 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:51 INFO - PROCESS | 11217 | RSS: Main: 229175296 13:24:51 INFO - PROCESS | 11217 | 13:24:53 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:54 INFO - PROCESS | 11217 | RSS: Main: 237232128 13:24:54 INFO - PROCESS | 11217 | 13:24:56 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:57 INFO - PROCESS | 11217 | RSS: Main: 240230400 13:24:57 INFO - PROCESS | 11217 | 13:25:00 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:25:00 INFO - PROCESS | 11217 | RSS: Main: 241250304 13:25:00 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50687/tests/kraken/driver.html?testName=ai-astar) 13:25:02 INFO - PROCESS | 11217 | RSS: Main: 284266496 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | __start_tp_report 13:25:02 INFO - PROCESS | 11217 | _x_x_mozilla_page_load 13:25:02 INFO - PROCESS | 11217 | _x_x_mozilla_page_load_details 13:25:02 INFO - PROCESS | 11217 | |i|pagename|runs| 13:25:02 INFO - PROCESS | 11217 | |0;ai-astar;109;102;109;108;109;108;110;110;108;109 13:25:02 INFO - PROCESS | 11217 | |1;audio-beat-detection;161;126;130;175;131;131;147;129;178;127 13:25:02 INFO - PROCESS | 11217 | |2;audio-dft;162;160;160;161;160;161;164;163;163;161 13:25:02 INFO - PROCESS | 11217 | |3;audio-fft;74;75;74;122;75;76;74;73;105;75 13:25:02 INFO - PROCESS | 11217 | |4;audio-oscillator;84;86;117;86;86;85;122;85;87;125 13:25:02 INFO - PROCESS | 11217 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;117 13:25:02 INFO - PROCESS | 11217 | |6;imaging-darkroom;145;147;146;152;146;147;146;146;146;146 13:25:02 INFO - PROCESS | 11217 | |7;imaging-desaturate;96;96;95;96;95;96;96;96;96;96 13:25:02 INFO - PROCESS | 11217 | |8;json-parse-financial;54;58;55;55;57;55;54;55;57;54 13:25:02 INFO - PROCESS | 11217 | |9;json-stringify-tinderbox;63;62;61;62;63;62;62;63;64;62 13:25:02 INFO - PROCESS | 11217 | |10;stanford-crypto-aes;79;79;83;82;84;85;80;81;111;81 13:25:02 INFO - PROCESS | 11217 | |11;stanford-crypto-ccm;121;121;121;123;118;118;119;132;125;133 13:25:02 INFO - PROCESS | 11217 | |12;stanford-crypto-pbkdf2;165;163;159;163;161;158;169;158;159;159 13:25:02 INFO - PROCESS | 11217 | |13;stanford-crypto-sha256-iterative;64;63;63;64;63;62;63;62;62;64 13:25:02 INFO - PROCESS | 11217 | __end_tp_report 13:25:02 INFO - PROCESS | 11217 | __start_cc_report 13:25:02 INFO - PROCESS | 11217 | _x_x_mozilla_cycle_collect,1616 13:25:02 INFO - PROCESS | 11217 | __end_cc_report 13:25:02 INFO - PROCESS | 11217 | __startTimestamp1466281502497__endTimestamp 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | ------- Summary: start ------- 13:25:02 INFO - PROCESS | 11217 | Number of tests: 14 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.30 (2.1%) stddev-sans-first:2.42 13:25:02 INFO - PROCESS | 11217 | Values: 109.0 102.0 109.0 108.0 109.0 108.0 110.0 110.0 108.0 109.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:139.00 stddev:20.51 (14.8%) stddev-sans-first:20.75 13:25:02 INFO - PROCESS | 11217 | Values: 161.0 126.0 130.0 175.0 131.0 131.0 147.0 129.0 178.0 127.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 13:25:02 INFO - PROCESS | 11217 | Values: 162.0 160.0 160.0 161.0 160.0 161.0 164.0 163.0 163.0 161.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.50 stddev:16.94 (22.7%) stddev-sans-first:17.70 13:25:02 INFO - PROCESS | 11217 | Values: 74.0 75.0 74.0 122.0 75.0 76.0 74.0 73.0 105.0 75.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.50 stddev:17.40 (20.3%) stddev-sans-first:17.87 13:25:02 INFO - PROCESS | 11217 | Values: 84.0 86.0 117.0 86.0 86.0 85.0 122.0 85.0 87.0 125.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:25:02 INFO - PROCESS | 11217 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.00 stddev:1.95 (1.3%) stddev-sans-first:1.96 13:25:02 INFO - PROCESS | 11217 | Values: 145.0 147.0 146.0 152.0 146.0 147.0 146.0 146.0 146.0 146.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:25:02 INFO - PROCESS | 11217 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.42 13:25:02 INFO - PROCESS | 11217 | Values: 54.0 58.0 55.0 55.0 57.0 55.0 54.0 55.0 57.0 54.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 13:25:02 INFO - PROCESS | 11217 | Values: 63.0 62.0 61.0 62.0 63.0 62.0 62.0 63.0 64.0 62.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.50 stddev:9.52 (11.7%) stddev-sans-first:9.89 13:25:02 INFO - PROCESS | 11217 | Values: 79.0 79.0 83.0 82.0 84.0 85.0 80.0 81.0 111.0 81.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:122.00 stddev:5.40 (4.4%) stddev-sans-first:5.68 13:25:02 INFO - PROCESS | 11217 | Values: 121.0 121.0 121.0 123.0 118.0 118.0 119.0 132.0 125.0 133.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:3.60 (2.2%) stddev-sans-first:3.57 13:25:02 INFO - PROCESS | 11217 | Values: 165.0 163.0 159.0 163.0 161.0 158.0 169.0 158.0 159.0 159.0 13:25:02 INFO - PROCESS | 11217 | 13:25:02 INFO - PROCESS | 11217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 13:25:02 INFO - PROCESS | 11217 | Values: 64.0 63.0 63.0 64.0 63.0 62.0 63.0 62.0 62.0 64.0 13:25:02 INFO - PROCESS | 11217 | -------- Summary: end -------- 13:25:02 INFO - PROCESS | 11217 | 13:25:03 INFO - TEST-INFO | 11217: exit 0 13:25:03 INFO - TEST-OK | kraken | took 60836ms 13:25:03 INFO - SUITE-END | took 1174s 13:25:03 INFO - Completed test suite (00:19:34) 13:25:03 INFO - javascript benchmark 13:25:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.256178517155, 3107.502799552072, 3139.2622733657595, 3168.3980043791676, 3169.9366012679734, 5132.178851383779, 5186.32577764891, 5332.386775520811, 5447.210154527591, 5454.509094181523, 5234.659747116435, 5294.894102117955, 5336.332958380202, 5406.16204488304, 5411.756470958807, 4801.663883528155, 4832.009438065197, 4846.806127754886, 4952.504749525055, 5040.571551418134, 4764.976175119137, 4910.361652985125, 4944.752762361885, 4959.206526955688, 5000.449950505442, 4696.8590942271785, 4723.622110231207, 4739.170645137122, 4837.685550439211, 4871.902561948759, 4807.399075115611, 4807.61539076873, 4818.831340903052, 4821.276808478721, 4853.417589889201, 4764.094821983812, 4767.594754445876, 4771.665983381165, 4774.474807771142, 4776.140294746944, 5181.637285390024, 5190.948090519084, 5195.636305458619, 5206.609504287194, 5220.321358223407, 5574.60977731559, 5609.523190528769, 5672.6312789668955, 5738.024535828919, 5740.512056475204, 5826.038703613898, 5847.502962248214, 5865.002949498553, 5875.676837773964, 5878.764849406061, 5194.168932970707, 5396.298481197419, 5448.83653490396, 5455.972720136374, 5461.836144915659, 5854.034084376115, 5883.823485295448, 5927.2590926134235, 5983.61106528083, 6004.1294012368835, 5763.682997435098, 5769.048107062287, 5771.509421699118, 5780.479756821822, 5782.855428614318, 5503.257060296889, 5622.072358060956, 5825.563082768809, 5830.4461076197695, 5854.882902341929, 5699.458551437607, 5745.9425405745405, 5757.769689212469, 5760.798372056958, 5809.3609702932645, 5764.0, 5764.510016648632, 5767.394423585463, 5768.942310576925, 5773.24947756789, 4238.406623072772, 4338.392625032498, 4389.495208051051, 4403.295472724349, 4445.599896009375, 3925.92148157041, 3931.0958479549863, 3933.8623148189677, 3960.821763020671, 3969.54350249725, 5422.566194704415, 5424.7016414096815, 5432.456754324615, 5436.70098144598, 5480.753366098455, 5549.72251387429, 5648.74580643872, 5665.263515742927, 5699.886002279931, 5848.5321174305955, 5335.573154147659, 5356.866078348073, 5360.946390536044, 5364.114921038063, 5364.195370694427, 4794.9280760788615, 4797.2564252540915, 4799.66402351832, 4817.470078291385, 4844.515548445198, 5790.189373487715, 5805.303363596396, 5814.796482123105, 5831.7375718091935, 5904.9704751475965, 5624.493795558419, 5683.545316374597, 5685.118806584986, 5688.857778555569, 5726.742296596746, 5854.824355269348, 5857.824265272048, 5858.560607954335, 5862.648241105548, 5882.382349853204, 5474.315710536183, 5541.667499950016, 5546.362168350692, 5581.665100094007, 5615.438456154352, 5721.5136713379825, 5722.2561067061015, 5723.284589426322, 5726.656400615976, 5729.742161602655, 5581.162825576033, 5581.162825576196, 5594.496495315441, 5599.412061733622, 5604.551635869202, 5394.0, 5502.284702988586, 5514.448555144614, 5539.806106786243, 5547.639403438763, 5459.836204913859, 5477.616566840283, 5482.5613950884635, 5486.780528778804, 5493.972530137324, 5438.6192966493545, 5564.777408903598, 5596.636218645775, 5639.182318563868, 5647.604667673223, 5416.350037995466, 5485.862853428696, 5509.641873278224, 5512.980098681756, 5535.0], "value": 5260.331172280329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.226968132384, 617.0836308082497, 620.9441150296474, 625.3621306267607, 641.2945759664367, 31309.060728178163, 43211.0, 44364.556354436485, 44383.55616443835, 44428.555714442846, 45526.772366138124, 45904.31143532841, 45911.770441147746, 45976.0, 45982.310265346045, 9007.279417646589, 9156.084391560857, 9157.130072643089, 9157.175854173123, 9160.267178625727, 8804.119588041209, 8888.511131887775, 8909.376343655947, 8910.064443233465, 8912.287017038654, 8952.8657070144, 8967.461952282883, 8972.775680607972, 8980.685676001309, 8987.191152796247, 8884.33367497437, 8928.196462318358, 8930.240929520998, 8931.062238464998, 8937.061608531109, 8996.415233009899, 9054.592543335566, 9056.411333263317, 9061.048589898097, 9069.093090690943, 42575.7871210645, 43151.13697726059, 43161.0, 43210.56789432097, 43214.35178472326, 3337.332533493287, 3580.6777390034763, 3644.5444319460066, 3781.5840257571645, 3791.7724936503896, 30885.845570772228, 31418.528722068957, 31804.204894877814, 32088.358232835213, 34211.65788342134, 4403.53762854902, 4441.222786012435, 4446.133004064209, 4476.664250181249, 4671.346011558385, 363744.0, 364873.0, 366877.0, 367437.0, 367638.0, 61903.690481548205, 62223.0, 62262.37737622656, 62341.688291558254, 62368.37631623716, 35490.64509354874, 36085.63914360875, 36294.092647683494, 37700.81149594235, 37946.430803537965, 17622.823771762374, 17808.46574602764, 17865.7320140198, 17869.46391608254, 17875.910620447074, 13679.931600341935, 13862.722745545234, 13891.86108138926, 13895.235762033186, 13897.861021389657, 19129.832203137983, 19410.08657686499, 19417.591184092395, 19519.414417567496, 19623.411297661092, 6993.790186294419, 7093.645317734093, 7172.318629730167, 7197.820054498679, 7206.207317195104, 968.2109081098882, 1051.6109039655375, 1119.4794420594462, 1130.559081958037, 1172.9178957472895, 32267.0, 32503.187420314207, 32515.349693006006, 32609.347813043605, 32878.506822397685, 1103.5475455063386, 1116.9497372618252, 1119.4850368830266, 1160.4545863444168, 1191.398343836357, 16306.673866522604, 17028.829711702972, 17069.146542672817, 17131.914340428466, 17278.481645550655, 153307.0, 153481.0, 154518.22740886224, 155267.0, 584835.0, 59634.70182649059, 60286.0, 60442.39557604455, 60527.394726052175, 60614.696926515084, 1226.405193481161, 1331.2345401394043, 1375.4910683047337, 1385.231196685849, 1389.603962870577, 31601.20996975094, 33095.33809323752, 33173.83413082919, 33331.333373332884, 33809.49285760765, 50172.498275016784, 50907.2363914549, 50962.23556646579, 50964.490355097456, 51003.48996509987, 402211.0, 409085.0, 409395.0, 409426.0, 410618.0, 24719.0, 27205.319867003484, 27463.86268068647, 27820.026299079436, 28018.85990570034, 48788.458751629274, 48952.75523622359, 49703.25445118399, 49766.253506196714, 50051.249231262285, 41193.38209926793, 41752.791236043624, 42021.15957680768, 42069.15861682688, 42826.57173428226, 40088.0, 40597.39103913384, 40633.79683101566, 41102.17795644011, 42041.78979105085, 40455.1908961825, 41379.1724165521, 41462.0, 41788.0, 41826.95432614209, 35786.28427431489, 37248.0, 37262.25475490529, 37783.43324850075, 37811.432828507044, 27251.0, 27800.582991255553, 27834.304142396602, 28759.28101797388, 29738.55392169076], "value": 19708.187002574286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.2448761646214, 390.74406263897157, 398.91822176453815, 399.66028875455856, 415.7734034950951, 14480.13119212848, 16332.0, 18087.095645217734, 18799.992001279814, 18814.717779233306, 18351.90824045881, 19121.733741178366, 19764.901175494102, 19921.60156796863, 19924.900375498102, 5315.893682126355, 5525.778968841241, 5573.637713548626, 5671.574631902603, 5714.485696287334, 4086.427900093974, 5656.717164141797, 5728.198052272685, 5739.397363276858, 5852.941470585303, 6199.5350348723805, 6236.189295391593, 6254.718537665816, 6265.122882796412, 6265.530085243602, 6057.227056410654, 6245.937540624604, 6386.425221730044, 6475.255345635265, 6496.317886621884, 5715.485606295411, 5722.656640601577, 5726.627769194989, 5726.942730572724, 5746.770129194827, 23204.65193022106, 24733.381665458506, 24757.752422475725, 24845.0, 26340.73659263402, 2438.8658623775686, 2450.889709963038, 2459.655648209234, 2504.561701702195, 2539.9111031114007, 15578.532644020697, 15636.530904072895, 15947.601309967227, 15977.281022353905, 16622.36168851936, 1975.1803001754254, 2017.1628774058747, 2052.1688716070016, 2058.3310424112074, 2147.95704085919, 88042.0, 98857.0, 99749.0, 100029.499852501, 101189.49405252926, 17677.558061048578, 17786.66600005005, 17833.821661783477, 18102.45692629223, 18232.908835456004, 26555.46889062208, 28342.71657283442, 29954.40091198164, 33014.50478242828, 33238.66761332356, 9978.301518893753, 10100.494975251208, 10375.636852710119, 10591.470426478645, 10612.0, 8913.821723565492, 8939.821203575892, 8999.505027223435, 9116.58975346111, 9144.0, 8719.433236839584, 8802.779930501789, 8976.955115224382, 9181.862272065924, 9210.263178945668, 3213.4697774866886, 3365.4110530657035, 3485.790852548855, 3512.3853325668415, 3586.4276377588826, 902.5893218585528, 1032.607609108534, 1033.4574348466965, 1044.0081922173813, 1089.8147314956318, 18878.0, 19136.521586960436, 19276.301317815516, 19447.319343823183, 19563.413097607096, 965.0638880286111, 973.5473005052543, 984.9950750246203, 987.9506024698736, 995.2784231432154, 10372.688819335432, 10826.079783218358, 10866.67399978002, 10894.727631809268, 10901.563937442572, 491864.0, 503005.0, 503785.0, 504229.0, 547192.0, 88869.55565222133, 93125.0, 101763.49118254361, 101841.0, 102051.83585313158, 442.9069895321954, 451.6612540594554, 453.9863804085883, 457.6041723908795, 457.7093545598635, 10481.475926203811, 10662.200334974752, 11024.393658348547, 11167.173555367139, 11231.483749693687, 29880.85059574775, 40414.1917161661, 41704.3744343829, 42298.78850605727, 44637.0, 59372.0, 59723.0, 60583.39416605954, 60892.0, 61322.386776131665, 8545.0, 8631.6978905738, 8735.388522803343, 8933.330000249878, 8991.325650576102, 12755.74488510206, 13931.860681393056, 13954.95337849645, 14273.57179284623, 14331.426742930165, 11323.263987840764, 11657.708557286136, 12225.633231003085, 12279.324637145042, 12334.876651233373, 11836.349000805038, 12280.508779648713, 12290.078244131904, 12292.50829966827, 12449.128561000643, 11754.529818807152, 11939.46272417726, 12064.215825971283, 12205.389730513616, 12525.123241373381, 8404.243618074403, 8662.177093176138, 8804.383693141419, 8979.595918183828, 9034.728958131267, 11738.0, 11995.82006269924, 12044.75910481768, 12054.915057644854, 12243.20419172751], "value": 9931.368529646868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1156.4102307823007, 1431.348736324972, 1459.8175228096486, 1561.2193903048476, 1704.4460550321141, 7616.923830761691, 8158.959205203973, 8450.028246751617, 8452.366072544553, 8659.09079546648, 8335.791605209874, 8509.574521273928, 8515.701950431736, 8518.87221691675, 8522.659093636246, 1951.7853036166011, 2192.4628466025847, 2267.489814791675, 2273.374821923972, 2309.445733024079, 2307.204014614955, 2333.4516388648653, 2337.55586438577, 2337.7077865266842, 2338.38032921276, 2280.1107568048474, 2290.061074959267, 2311.537692461506, 2312.236961802601, 2313.2366319114735, 1912.2351059576142, 2142.1110239250693, 2201.7688142745023, 2215.523662412573, 2220.8001279884725, 2221.1892659179443, 2224.744154422246, 2230.163688616769, 2239.955200895973, 2241.9775802241934, 8654.350923680686, 8703.738887833375, 8708.956455217747, 8726.956365218133, 8727.738167854974, 4964.578010869081, 5097.13348730713, 5099.617528685327, 5100.0, 5101.69389836611, 3210.020943612221, 3255.7232635225796, 3307.603087629476, 3443.8278086095847, 3450.9827450862585, 1060.533365319257, 1075.2365820267619, 1091.1707102602, 1094.9945250273697, 1095.5070218401672, 11684.240524365889, 11696.415179241005, 11698.23961442512, 11703.18077734559, 11716.765664686744, 4378.912421751611, 4430.645548356124, 4527.411436513232, 4532.184206842734, 4536.72779633223, 9956.551955162035, 9958.502074896227, 9961.900380996241, 9968.501574921225, 9985.650502232387, 5132.486751324837, 5139.383274007143, 5144.819931302386, 5147.948520514822, 5151.2530683050745, 3994.800259986989, 4572.0, 4711.858644240679, 4715.104130215248, 4777.020710754287, 3759.9248015039548, 3807.4479200516325, 3867.0332416895776, 3893.844246230119, 3927.7446965947124, 1208.1422190244848, 1215.1858254969193, 1220.6460126563197, 1227.2575092069349, 1233.7532493501335, 936.5270538378076, 959.4387283439266, 960.8318544254728, 966.1690945786618, 981.3915372469115, 5687.886242275132, 5757.712114394263, 5865.0, 5877.177195192677, 5970.432808883149, 1028.9176865850714, 1046.8325067989238, 1052.1793001458875, 1054.8312270036756, 1088.0, 3909.100906791454, 3991.7006224532697, 4022.155347377025, 4027.456293400412, 4036.535798383165, 10294.0, 10534.841977370346, 10625.46872656364, 10638.893611063944, 10646.201534884915, 10501.264911456125, 10504.317219380715, 10506.0, 10511.52698128586, 10524.105451036594, 7404.0, 7707.730229442055, 7989.800254993555, 8053.07389650186, 8098.75703728889, 5756.42435756421, 5760.769569217185, 5834.212381328466, 5909.763609455574, 6006.069059295816, 9444.95277523608, 9538.90461095408, 9733.853992190265, 9882.851757223503, 9981.650642227487, 9696.418214907128, 10035.34770239932, 10046.543251228384, 10055.597776088875, 10066.194704423775, 6510.251321098134, 7384.4830861839155, 7429.219931907072, 7523.924760752322, 7673.194314596887, 8394.538300393537, 8463.026751923362, 8511.233988941025, 8557.529335886586, 8561.61472733741, 7372.520786148883, 7420.925790742023, 7449.776506704808, 7591.848163036819, 7696.576688282198, 7467.0, 7479.850402992019, 7517.436192285491, 7622.69509219625, 7651.234876512304, 6341.175647165839, 6375.171227740364, 6399.584027038228, 6401.519886008661, 6402.903956440564, 4913.70517768935, 5051.924221136613, 5059.949400505948, 5085.7711402986215, 5156.2523434102595, 4789.114013907439, 4932.8520144395725, 5006.974965125151, 5094.363204599425, 5266.104762190514], "value": 4509.1790303549315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.32753252973566, 314.25521514011797, 323.36136131141, 327.35511043244816, 329.5320644684548, 5108.4125325587565, 5280.947190528093, 5356.919646205305, 5397.298351214342, 5403.297571315733, 5252.553532949704, 5282.128448805943, 5337.386200586933, 5347.331583552056, 5352.57179425646, 4193.475815523059, 4200.51694055183, 4203.285441474956, 4204.705670603059, 4216.093539888923, 3931.528216613996, 3946.9605303947023, 4125.834966601347, 4181.372794080882, 4194.30793919003, 4110.342345224764, 4115.176964607075, 4116.192521917214, 4131.834726610947, 4153.584641535853, 4084.264832330179, 4128.153728485653, 4132.710710250299, 4153.813078411479, 4163.0, 3418.3334249821296, 3680.595134535199, 3686.041629176407, 3689.94465083024, 3708.4251940948925, 5105.744712764347, 5118.769655365518, 5121.8463446096675, 5126.0, 5130.615203859726, 4692.718436893797, 4695.957258592523, 4698.788554515021, 4704.941388187664, 4708.317293992352, 5279.736013199363, 5410.567154627621, 5516.117421212627, 5530.92147031329, 5533.584981126432, 3952.1107750756137, 3953.743006704555, 3955.564887862333, 3957.1294315250598, 3971.7815520146382, 5750.827475175752, 5781.421857814227, 5790.449907258846, 5793.248207101635, 5836.299644042742, 3944.6647035001774, 4031.778252196157, 4038.9394159087637, 4052.756834589934, 4071.4096456013713, 4111.506619205715, 4114.485689288839, 4126.607972242632, 4128.422020917074, 4148.771817550064, 4670.159371313196, 4671.602913752301, 4673.532646735367, 4688.789004494806, 4701.882452938636, 5543.7249432629915, 5587.217789509472, 5595.300587426572, 5595.8528501657065, 5629.380768115504, 1349.9392527336292, 1401.9579412617638, 1407.8240219972504, 1412.69627030189, 1416.0512456654067, 858.3605214115399, 880.3837313880309, 886.866969954512, 889.7953470701775, 894.280104515871, 4680.5085466025575, 4710.6702530823195, 4759.738214398241, 4772.7136371817805, 4782.163121453732, 4992.500749925051, 5003.5997120230295, 5020.849374518771, 5027.0, 5084.923726144111, 4433.623142032963, 4702.506236845151, 4724.244120940633, 4733.83431579893, 4787.664863459524, 2670.3858112633816, 2685.5434576122107, 2710.268227578543, 2715.5112079825426, 2724.4006318609872, 5119.667221630582, 5146.665466744649, 5168.811173430132, 5203.60972927032, 5213.2701421800975, 4785.774614804132, 5137.304689452471, 5165.874645839288, 5177.896442071137, 5193.896122077537, 5166.416791604198, 5205.531502164823, 5225.843224703265, 5233.581313494911, 5235.617793903764, 5001.57486613642, 5039.790450291976, 5047.899042019212, 5048.242763585345, 5068.366454193226, 4714.043671876133, 4939.802407903644, 4985.551300382983, 4996.450390456974, 5062.595267248028, 5153.45888681683, 5182.663126896739, 5218.478152184903, 5271.551918087006, 5274.0, 3615.81920903959, 3761.7178711596193, 3878.3794592865006, 3974.4237085623, 3992.6606238470054, 5592.944070559242, 5610.382857885711, 5653.85865353353, 5657.830265092054, 5663.858403539944, 5472.72636368188, 5482.533984611353, 5484.753186106555, 5501.174823776466, 5516.889662206813, 5218.295530103387, 5457.372402173801, 5476.397596264487, 5479.465749590121, 5493.313335833021, 5375.784968601369, 5383.542398895981, 5389.0, 5396.0, 5403.351597808131, 5287.968846075132, 5436.293281873332, 5466.835994920159, 5504.458751549572, 5513.531349835309, 5349.438308977657, 5359.196120581944, 5362.383325917569, 5420.918686219631, 5426.240326354235], "value": 4066.177945195752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.6931088942644, 767.1369709077288, 782.9491083079599, 826.0601602417543, 851.3189448441245, 14964.32660530276, 16325.510234692963, 16824.32702691891, 16939.407120750762, 17064.48806535806, 15611.297491612877, 15617.921910390432, 15691.058536487819, 15721.0, 15723.449679261228, 667.5293917787948, 798.2576204130156, 804.4007214625112, 811.0429692962302, 812.0945146162046, 798.700487317256, 826.4008593769529, 827.6399766101765, 828.2876726015621, 828.6271177969937, 826.9627866745981, 835.1564919431388, 836.021854430318, 836.188896770132, 837.7486753973814, 704.626547929593, 816.4448175240834, 843.2789964580287, 844.5608283692476, 844.5988155626089, 612.978545750901, 615.065101046407, 617.6109051297653, 617.8640699046248, 619.6746707978348, 14147.221902795342, 14179.361928713233, 14184.645383865383, 14207.14757114566, 14207.360668769827, 14640.41438342465, 15001.699966000619, 15036.699266014619, 15116.54650360491, 15154.772678409832, 13087.672808179777, 13130.803037954438, 13439.26084065376, 13567.1859688419, 13707.532644124054, 4530.782787777994, 4534.342520334533, 4545.159145558082, 4562.338460923181, 4624.0, 59513.404865951656, 65518.0, 67772.3222767771, 67891.0, 77337.0, 11744.706382340339, 11797.941010295066, 11831.645050648494, 11964.341961192044, 12177.573784917662, 21518.892405537874, 21544.892275538834, 21576.0, 22092.55814883693, 23876.880615596812, 7486.288802563748, 7986.001749781278, 8121.431499794958, 8150.2664760171865, 8418.368622353348, 4598.398567663043, 4883.877903052452, 4937.407511098691, 4956.306117143603, 5126.5898728101665, 3336.849841757127, 3438.415469370213, 3442.7417943654327, 3445.3970555152746, 3446.1556918555116, 619.3527763487077, 624.709510077816, 627.4259052966485, 628.7736414890636, 638.2245571630399, 590.6131483878066, 645.1999520594429, 681.9829504262334, 697.2887654592288, 755.2598453515585, 8927.24118449926, 9436.858447123299, 9626.47054412, 9626.95186524077, 9729.805403891882, 639.4660458517191, 660.1978596005875, 710.8898120791285, 730.7369347035063, 746.5520687587513, 4243.2998555238655, 4347.130573885235, 4384.495782984997, 4429.313456414261, 4487.326900964816, 68316.65841670759, 69017.3098269021, 74321.0, 117036.0, 117136.0, 101923.0, 104623.47688261663, 105038.47480762548, 105052.0, 105081.47459262655, 52728.736356317975, 66076.33923660798, 87778.56110719405, 88483.55758221168, 90397.99999999869, 8139.674413023413, 8274.0, 8363.247307742333, 8369.0375606806, 8409.495430274203, 53070.46929530655, 54367.0, 54614.726926366704, 55177.172342415695, 55603.72198139145, 56701.716491417275, 78884.0, 79389.0, 79391.60304198442, 79530.6023469879, 12035.338056406981, 12869.420876060787, 13097.869021310045, 13470.461181552628, 13595.388207530486, 12154.513819447124, 12407.813882791585, 12676.683082923, 12789.424475898793, 12911.935440323114, 12635.241885486901, 12897.22616642967, 13095.41070651842, 13231.536896208972, 13283.468661253442, 11406.942965285121, 11518.424078796193, 11533.653990380302, 12708.809367859305, 14243.21662308583, 13794.103383280055, 14098.36557354901, 14147.717045659236, 14524.854751452773, 14843.183624900734, 10637.255392122786, 10868.565257389932, 10969.0, 11594.362310073027, 11702.180847340604, 10032.949835250776, 10115.696529104138, 10172.643957461454, 10194.745131371776, 10218.335808172445], "value": 7419.617780809192, "unit": "score"}], "name": "dromaeo_css", "value": 7206.600367212006, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 102.0, 109.0, 108.0, 109.0, 108.0, 110.0, 110.0, 108.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 130.0, 175.0, 131.0, 131.0, 147.0, 129.0, 178.0, 127.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 160.0, 161.0, 164.0, 163.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 122.0, 75.0, 76.0, 74.0, 73.0, 105.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 86.0, 86.0, 85.0, 122.0, 85.0, 87.0, 125.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 152.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 55.0, 57.0, 55.0, 54.0, 55.0, 57.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 63.0, 64.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 82.0, 84.0, 85.0, 80.0, 81.0, 111.0, 81.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 121.0, 123.0, 118.0, 118.0, 119.0, 132.0, 125.0, 133.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 159.0, 163.0, 161.0, 158.0, 169.0, 158.0, 159.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 64.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1500.8999999999999, "alertThreshold": 2.0}]} 13:25:03 INFO - Return code: 0 13:25:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:25:03 INFO - # TBPL SUCCESS # 13:25:03 INFO - Running post-action listener: _resource_record_post_action 13:25:03 INFO - ##### 13:25:03 INFO - ##### Finished run-tests step (success) 13:25:03 INFO - ##### 13:25:03 INFO - Running post-run listener: _resource_record_post_run 13:25:03 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 300392448; Read time: 32; Write time: 211272 13:25:03 INFO - TinderboxPrint: CPU usage
13.3% 13:25:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 13:25:03 INFO - TinderboxPrint: I/O write bytes / time
300,392,448 / 211,272 13:25:03 INFO - TinderboxPrint: CPU idle
8,257.1 (86.7%) 13:25:03 INFO - TinderboxPrint: CPU user
1,215.7 (12.8%) 13:25:03 INFO - TinderboxPrint: Swap in / out
0 / 0 13:25:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6479872; Read time: 0; Write time: 684 13:25:03 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290242560; Read time: 32; Write time: 205724 13:25:04 INFO - Running post-run listener: _upload_blobber_files 13:25:04 INFO - Blob upload gear active. 13:25:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:25:04 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 13:25:04 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'] 13:25:04 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 13:25:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:25:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:25:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:25:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:05 INFO - (blobuploader) - INFO - Done attempting. 13:25:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:25:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:25:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:06 INFO - (blobuploader) - INFO - Done attempting. 13:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:09 INFO - (blobuploader) - INFO - Done attempting. 13:25:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:25:09 INFO - Return code: 0 13:25:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:25:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:25:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/777bac88374a76a225144472fbea30798fe4cf0e5ec26756aa81cf0aee834d44d855273a60a0b819223ae90076558e8a52286ed28d2f93e9732ef1f947820a0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/097eadfa6ef88c684cd359f5f0167d0020a2aac3c12ea9775b018ca4a2b19544d77f2d199e278eda1df8f3fca113a5993851ec5a8ad7bc76c58d9d25b393030e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1299200ac35b54ebc32e9403c5f8c7204f85aad824fc4b48f0df03fa780379f98093f39b61859228a5c803f49f69f7a68ed3224c9bf390eaed314784f3bcb26a"} 13:25:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:25:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:25:09 INFO - Contents: 13:25:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/777bac88374a76a225144472fbea30798fe4cf0e5ec26756aa81cf0aee834d44d855273a60a0b819223ae90076558e8a52286ed28d2f93e9732ef1f947820a0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/097eadfa6ef88c684cd359f5f0167d0020a2aac3c12ea9775b018ca4a2b19544d77f2d199e278eda1df8f3fca113a5993851ec5a8ad7bc76c58d9d25b393030e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1299200ac35b54ebc32e9403c5f8c7204f85aad824fc4b48f0df03fa780379f98093f39b61859228a5c803f49f69f7a68ed3224c9bf390eaed314784f3bcb26a"} 13:25:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:25:09 INFO - Copying logs to upload dir... 13:25:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:25:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.852847 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-18 13:25:09.576818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 13:25:09.580037) ========= 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=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/777bac88374a76a225144472fbea30798fe4cf0e5ec26756aa81cf0aee834d44d855273a60a0b819223ae90076558e8a52286ed28d2f93e9732ef1f947820a0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/097eadfa6ef88c684cd359f5f0167d0020a2aac3c12ea9775b018ca4a2b19544d77f2d199e278eda1df8f3fca113a5993851ec5a8ad7bc76c58d9d25b393030e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1299200ac35b54ebc32e9403c5f8c7204f85aad824fc4b48f0df03fa780379f98093f39b61859228a5c803f49f69f7a68ed3224c9bf390eaed314784f3bcb26a"} build_url:https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Ie3HInFmRN2cywT2lxNDdQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/777bac88374a76a225144472fbea30798fe4cf0e5ec26756aa81cf0aee834d44d855273a60a0b819223ae90076558e8a52286ed28d2f93e9732ef1f947820a0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/097eadfa6ef88c684cd359f5f0167d0020a2aac3c12ea9775b018ca4a2b19544d77f2d199e278eda1df8f3fca113a5993851ec5a8ad7bc76c58d9d25b393030e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1299200ac35b54ebc32e9403c5f8c7204f85aad824fc4b48f0df03fa780379f98093f39b61859228a5c803f49f69f7a68ed3224c9bf390eaed314784f3bcb26a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 13:25:09.605433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:25:09.605788) ========= 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=0333a256a5e4f052382dd180000001b1-1466271717.223689-988795661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 13:25:09.690544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 13:25:09.690876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 13:25:09.691176) ========= ========= Total master_lag: 0.17 =========