builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1466787862.28 results: success (0) buildid: 20160624073140 builduid: cc10eb24922242aca40a385e63ed4b5f revision: a277f3e065d2a4026a6c10d2dae02699ef30a504 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.275966) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.276538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.276871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.291966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.292360) ========= 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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 10:04:22-- 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% 220M=0s 2016-06-24 10:04:22 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.405259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.405654) ========= 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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015534 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.455906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:22.456335) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a277f3e065d2a4026a6c10d2dae02699ef30a504 --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 a277f3e065d2a4026a6c10d2dae02699ef30a504 --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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 10:04:22,747 truncating revision to first 12 chars 2016-06-24 10:04:22,747 Setting DEBUG logging. 2016-06-24 10:04:22,747 attempt 1/10 2016-06-24 10:04:22,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a277f3e065d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 10:04:23,028 unpacking tar archive at: mozilla-inbound-a277f3e065d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:23.131065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:23.131546) ========= script_repo_revision: a277f3e065d2a4026a6c10d2dae02699ef30a504 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:23.132111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:23.132451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 10:04:23.141956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-24 10:04:23.142337) ========= /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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:23 INFO - MultiFileLogger online at 20160624 10:04:23 in /builds/slave/test 10:04:23 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 10:04:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:23 INFO - {'append_to_log': False, 10:04:23 INFO - 'base_work_dir': '/builds/slave/test', 10:04:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:23 INFO - 'branch': 'Mozilla-Inbound', 10:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:23 INFO - 'config_files': ('talos/linux_config.py',), 10:04:23 INFO - 'default_actions': ('clobber', 10:04:23 INFO - 'read-buildbot-config', 10:04:23 INFO - 'download-and-extract', 10:04:23 INFO - 'populate-webroot', 10:04:23 INFO - 'create-virtualenv', 10:04:23 INFO - 'install', 10:04:23 INFO - 'run-tests'), 10:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:23 INFO - 'download_minidump_stackwalk': True, 10:04:23 INFO - 'download_symbols': 'ondemand', 10:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:23 INFO - 'installer_path': 'installer.exe', 10:04:23 INFO - 'log_level': 'info', 10:04:23 INFO - 'log_name': 'talos', 10:04:23 INFO - 'log_to_console': True, 10:04:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:23 INFO - 'opt_config_files': (), 10:04:23 INFO - 'pip_index': False, 10:04:23 INFO - 'sps_profile': False, 10:04:23 INFO - 'sps_profile_interval': 0, 10:04:23 INFO - 'suite': 'dromaeojs', 10:04:23 INFO - 'system_bits': '32', 10:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:23 INFO - 'title': 'talos-linux64-ix-008', 10:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:23 INFO - 'use_talos_json': True, 10:04:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:23 INFO - 'work_dir': 'build'} 10:04:23 INFO - ##### 10:04:23 INFO - ##### Running clobber step. 10:04:23 INFO - ##### 10:04:23 INFO - Running pre-action listener: _resource_record_pre_action 10:04:23 INFO - Running main action method: clobber 10:04:23 INFO - rmtree: /builds/slave/test/build 10:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:24 INFO - Running post-action listener: _resource_record_post_action 10:04:24 INFO - ##### 10:04:24 INFO - ##### Finished clobber step (success) 10:04:24 INFO - ##### 10:04:24 INFO - ##### 10:04:24 INFO - ##### Running read-buildbot-config step. 10:04:24 INFO - ##### 10:04:24 INFO - Running pre-action listener: _resource_record_pre_action 10:04:24 INFO - Running main action method: read_buildbot_config 10:04:24 INFO - Using buildbot properties: 10:04:24 INFO - { 10:04:24 INFO - "project": "", 10:04:24 INFO - "product": "firefox", 10:04:24 INFO - "script_repo_revision": "production", 10:04:24 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:04:24 INFO - "repository": "", 10:04:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:04:24 INFO - "buildid": "20160624073140", 10:04:24 INFO - "pgo_build": "True", 10:04:24 INFO - "basedir": "/builds/slave/test", 10:04:24 INFO - "buildnumber": 1233, 10:04:24 INFO - "slavename": "talos-linux64-ix-008", 10:04:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:04:24 INFO - "platform": "ubuntu64_hw", 10:04:24 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:04:24 INFO - "branch": "mozilla-inbound", 10:04:24 INFO - "repo_path": "integration/mozilla-inbound", 10:04:24 INFO - "revision": "a277f3e065d2a4026a6c10d2dae02699ef30a504", 10:04:24 INFO - "stage_platform": "linux64-pgo", 10:04:24 INFO - "builduid": "cc10eb24922242aca40a385e63ed4b5f", 10:04:24 INFO - "slavebuilddir": "test" 10:04:24 INFO - } 10:04:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:04:24 INFO - Running post-action listener: _resource_record_post_action 10:04:24 INFO - ##### 10:04:24 INFO - ##### Finished read-buildbot-config step (success) 10:04:24 INFO - ##### 10:04:24 INFO - ##### 10:04:24 INFO - ##### Running download-and-extract step. 10:04:24 INFO - ##### 10:04:24 INFO - Running pre-action listener: _resource_record_pre_action 10:04:24 INFO - Running main action method: download_and_extract 10:04:24 INFO - mkdir: /builds/slave/test/build/tests 10:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:24 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:04:24 INFO - Downloaded 1361 bytes. 10:04:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:24 INFO - Using the following test package requirements: 10:04:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:04:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'jsshell-linux-x86_64.zip'], 10:04:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:04:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:04:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:24 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:26 INFO - Downloaded 24279651 bytes. 10:04:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:27 INFO - Return code: 0 10:04:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10: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')]} 10:04:27 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:31 INFO - Downloaded 24279651 bytes. 10: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'] 10: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 10:04:32 INFO - Return code: 0 10: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')]} 10:04:32 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:04:33 INFO - Downloaded 14405188 bytes. 10:04:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:04:34 INFO - Return code: 0 10:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:34 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:04:35 INFO - Downloaded 60162562 bytes. 10:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:04:35 INFO - mkdir: /builds/slave/test/properties 10:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:35 INFO - Contents: 10:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:04:36 INFO - Running post-action listener: _resource_record_post_action 10:04:36 INFO - Running post-action listener: set_extra_try_arguments 10:04:36 INFO - ##### 10:04:36 INFO - ##### Finished download-and-extract step (success) 10:04:36 INFO - ##### 10:04:36 INFO - ##### 10:04:36 INFO - ##### Running populate-webroot step. 10:04:36 INFO - ##### 10:04:36 INFO - Running pre-action listener: _resource_record_pre_action 10:04:36 INFO - Running main action method: populate_webroot 10:04:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:36 INFO - '--tppagecycles', 10:04:36 INFO - '7'], 10:04:36 INFO - 'tests': ['tsvgm']}}, 10:04:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['damp', 'tps']}, 10:04:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'tests': ['damp', 'tps']}, 10:04:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['dromaeo_dom']}, 10:04:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['basic_compositor_video']}, 10:04:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:04:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['a11yr', 10:04:36 INFO - 'ts_paint', 10:04:36 INFO - 'tpaint', 10:04:36 INFO - 'sessionrestore', 10:04:36 INFO - 'sessionrestore_no_auto_restore', 10:04:36 INFO - 'tabpaint']}, 10:04:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['tsvgx', 10:04:36 INFO - 'tsvgr_opacity', 10:04:36 INFO - 'tart', 10:04:36 INFO - 'tscrollx', 10:04:36 INFO - 'cart']}, 10:04:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:36 INFO - 'tsvgr_opacity', 10:04:36 INFO - 'tart', 10:04:36 INFO - 'tscrollx', 10:04:36 INFO - 'cart']}, 10:04:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'talos_options': ['--disable-e10s'], 10:04:36 INFO - 'tests': ['tp5o']}, 10:04:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'tests': ['tp5o']}, 10:04:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'talos_options': ['--disable-e10s', 10:04:36 INFO - '--xperf_path', 10:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:36 INFO - 'tests': ['tp5n']}, 10:04:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:36 INFO - 'talos_options': ['--xperf_path', 10:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:36 INFO - 'tests': ['tp5n']}}, 10:04:36 INFO - 'talos.zip': {'path': '', 10:04:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:36 INFO - Running post-action listener: _resource_record_post_action 10:04:36 INFO - ##### 10:04:36 INFO - ##### Finished populate-webroot step (success) 10:04:36 INFO - ##### 10:04:36 INFO - ##### 10:04:36 INFO - ##### Running create-virtualenv step. 10:04:36 INFO - ##### 10:04:36 INFO - Running pre-action listener: _resource_record_pre_action 10:04:36 INFO - Running main action method: create_virtualenv 10:04:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:04:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:36 INFO - Using real prefix '/usr' 10:04:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:38 INFO - Installing pip.................done. 10:04:38 INFO - Return code: 0 10:04:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:04:38 INFO - Using env: {'DISPLAY': ':0', 10:04:38 INFO - 'HOME': '/home/cltbld', 10:04:38 INFO - 'LANG': 'en_US.UTF-8', 10:04:38 INFO - 'LANGUAGE': 'en_US:en', 10:04:38 INFO - 'LOGNAME': 'cltbld', 10:04:38 INFO - 'MAIL': '/var/mail/cltbld', 10:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:38 INFO - 'MOZ_NO_REMOTE': '1', 10:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:38 INFO - 'NO_EM_RESTART': '1', 10:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:38 INFO - 'PWD': '/builds/slave/test', 10:04:38 INFO - 'SHELL': '/bin/bash', 10:04:38 INFO - 'SHLVL': '1', 10:04:38 INFO - 'TERM': 'linux', 10:04:38 INFO - 'TMOUT': '86400', 10:04:38 INFO - 'USER': 'cltbld', 10:04:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:38 INFO - '_': '/tools/buildbot/bin/python'} 10:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:04:39 INFO - Cleaning up... 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:04:39 INFO - Using env: {'DISPLAY': ':0', 10:04:39 INFO - 'HOME': '/home/cltbld', 10:04:39 INFO - 'LANG': 'en_US.UTF-8', 10:04:39 INFO - 'LANGUAGE': 'en_US:en', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MAIL': '/var/mail/cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SHLVL': '1', 10:04:39 INFO - 'TERM': 'linux', 10:04:39 INFO - 'TMOUT': '86400', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - '_': '/tools/buildbot/bin/python'} 10:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:39 INFO - Downloading/unpacking psutil>=3.1.1 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:41 INFO - Installing collected packages: psutil 10:04:41 INFO - Running setup.py install for psutil 10:04:41 INFO - building 'psutil._psutil_linux' extension 10:04:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:04:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:04:41 INFO - building 'psutil._psutil_posix' extension 10:04:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:04:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:41 INFO - Successfully installed psutil 10:04:41 INFO - Cleaning up... 10:04:41 INFO - Return code: 0 10:04:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:41 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:04:41 INFO - Using env: {'DISPLAY': ':0', 10:04:41 INFO - 'HOME': '/home/cltbld', 10:04:41 INFO - 'LANG': 'en_US.UTF-8', 10:04:41 INFO - 'LANGUAGE': 'en_US:en', 10:04:41 INFO - 'LOGNAME': 'cltbld', 10:04:41 INFO - 'MAIL': '/var/mail/cltbld', 10:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:41 INFO - 'MOZ_NO_REMOTE': '1', 10:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:41 INFO - 'NO_EM_RESTART': '1', 10:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:41 INFO - 'PWD': '/builds/slave/test', 10:04:41 INFO - 'SHELL': '/bin/bash', 10:04:41 INFO - 'SHLVL': '1', 10:04:41 INFO - 'TERM': 'linux', 10:04:41 INFO - 'TMOUT': '86400', 10:04:41 INFO - 'USER': 'cltbld', 10:04:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:41 INFO - '_': '/tools/buildbot/bin/python'} 10:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:04:43 INFO - Installing collected packages: mozsystemmonitor 10:04:43 INFO - Running setup.py install for mozsystemmonitor 10:04:44 INFO - Successfully installed mozsystemmonitor 10:04:44 INFO - Cleaning up... 10:04:44 INFO - Return code: 0 10:04:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:04:44 INFO - Using env: {'DISPLAY': ':0', 10:04:44 INFO - 'HOME': '/home/cltbld', 10:04:44 INFO - 'LANG': 'en_US.UTF-8', 10:04:44 INFO - 'LANGUAGE': 'en_US:en', 10:04:44 INFO - 'LOGNAME': 'cltbld', 10:04:44 INFO - 'MAIL': '/var/mail/cltbld', 10:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:44 INFO - 'MOZ_NO_REMOTE': '1', 10:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:44 INFO - 'NO_EM_RESTART': '1', 10:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:44 INFO - 'PWD': '/builds/slave/test', 10:04:44 INFO - 'SHELL': '/bin/bash', 10:04:44 INFO - 'SHLVL': '1', 10:04:44 INFO - 'TERM': 'linux', 10:04:44 INFO - 'TMOUT': '86400', 10:04:44 INFO - 'USER': 'cltbld', 10:04:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:44 INFO - '_': '/tools/buildbot/bin/python'} 10:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:44 INFO - Downloading/unpacking jsonschema==2.5.1 10:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:46 INFO - warning: no files found matching '*.txt' 10:04:46 INFO - no previously-included directories found matching 'build' 10:04:46 INFO - no previously-included directories found matching 'dist' 10:04:46 INFO - no previously-included directories found matching '.git*' 10:04:46 INFO - Installing collected packages: jsonschema, functools32 10:04:46 INFO - Running setup.py install for functools32 10:04:46 INFO - warning: no files found matching '*.txt' 10:04:46 INFO - no previously-included directories found matching 'build' 10:04:46 INFO - no previously-included directories found matching 'dist' 10:04:46 INFO - no previously-included directories found matching '.git*' 10:04:46 INFO - Successfully installed jsonschema functools32 10:04:46 INFO - Cleaning up... 10:04:46 INFO - Return code: 0 10:04:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:46 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:46 INFO - Using env: {'DISPLAY': ':0', 10:04:46 INFO - 'HOME': '/home/cltbld', 10:04:46 INFO - 'LANG': 'en_US.UTF-8', 10:04:46 INFO - 'LANGUAGE': 'en_US:en', 10:04:46 INFO - 'LOGNAME': 'cltbld', 10:04:46 INFO - 'MAIL': '/var/mail/cltbld', 10:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:46 INFO - 'MOZ_NO_REMOTE': '1', 10:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:46 INFO - 'NO_EM_RESTART': '1', 10:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:46 INFO - 'PWD': '/builds/slave/test', 10:04:46 INFO - 'SHELL': '/bin/bash', 10:04:46 INFO - 'SHLVL': '1', 10:04:46 INFO - 'TERM': 'linux', 10:04:46 INFO - 'TMOUT': '86400', 10:04:46 INFO - 'USER': 'cltbld', 10:04:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:46 INFO - '_': '/tools/buildbot/bin/python'} 10:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10: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 10: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 10: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 10: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 10: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 10: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 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:49 INFO - Downloading docopt-0.6.1.tar.gz 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:49 INFO - Running setup.py install for blobuploader 10:04:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:49 INFO - Running setup.py install for requests 10:04:50 INFO - Running setup.py install for docopt 10:04:50 INFO - Successfully installed blobuploader requests docopt 10:04:50 INFO - Cleaning up... 10:04:50 INFO - Return code: 0 10:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:50 INFO - Using env: {'DISPLAY': ':0', 10:04:50 INFO - 'HOME': '/home/cltbld', 10:04:50 INFO - 'LANG': 'en_US.UTF-8', 10:04:50 INFO - 'LANGUAGE': 'en_US:en', 10:04:50 INFO - 'LOGNAME': 'cltbld', 10:04:50 INFO - 'MAIL': '/var/mail/cltbld', 10:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:50 INFO - 'MOZ_NO_REMOTE': '1', 10:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:50 INFO - 'NO_EM_RESTART': '1', 10:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:50 INFO - 'PWD': '/builds/slave/test', 10:04:50 INFO - 'SHELL': '/bin/bash', 10:04:50 INFO - 'SHLVL': '1', 10:04:50 INFO - 'TERM': 'linux', 10:04:50 INFO - 'TMOUT': '86400', 10:04:50 INFO - 'USER': 'cltbld', 10:04:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:50 INFO - '_': '/tools/buildbot/bin/python'} 10:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:50 INFO - Running setup.py (path:/tmp/pip-jwvQoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:50 INFO - Running setup.py (path:/tmp/pip-MUYv4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:50 INFO - Running setup.py (path:/tmp/pip-PuAcTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:50 INFO - Running setup.py (path:/tmp/pip-0SvalR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:50 INFO - Running setup.py (path:/tmp/pip-wnnSBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:50 INFO - Running setup.py (path:/tmp/pip-J9oZAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:50 INFO - Running setup.py (path:/tmp/pip-MIiGwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:50 INFO - Running setup.py (path:/tmp/pip-eN7voj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:50 INFO - Running setup.py (path:/tmp/pip-gEjllq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:51 INFO - Running setup.py (path:/tmp/pip-kyV_XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:51 INFO - Running setup.py (path:/tmp/pip-IrGVo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:51 INFO - Running setup.py (path:/tmp/pip-FOeWI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:51 INFO - Running setup.py (path:/tmp/pip-NfbWOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:51 INFO - Running setup.py (path:/tmp/pip-rJQTvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:51 INFO - Running setup.py (path:/tmp/pip-IgZy5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:51 INFO - Running setup.py (path:/tmp/pip-TqHCs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:51 INFO - Running setup.py (path:/tmp/pip-OAISQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:51 INFO - Running setup.py install for manifestparser 10:04:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:51 INFO - Running setup.py install for mozcrash 10:04:51 INFO - Running setup.py install for mozdebug 10:04:51 INFO - Running setup.py install for mozdevice 10:04:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozfile 10:04:52 INFO - Running setup.py install for mozhttpd 10:04:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozinfo 10:04:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozInstall 10:04:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozleak 10:04:52 INFO - Running setup.py install for mozlog 10:04:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for moznetwork 10:04:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozprocess 10:04:52 INFO - Running setup.py install for mozprofile 10:04:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozrunner 10:04:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozscreenshot 10:04:53 INFO - Running setup.py install for moztest 10:04:53 INFO - Running setup.py install for mozversion 10:04:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:53 INFO - Cleaning up... 10:04:53 INFO - Return code: 0 10:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10: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')]} 10:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10: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')]} 10:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:53 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:53 INFO - Using env: {'DISPLAY': ':0', 10:04:53 INFO - 'HOME': '/home/cltbld', 10:04:53 INFO - 'LANG': 'en_US.UTF-8', 10:04:53 INFO - 'LANGUAGE': 'en_US:en', 10:04:53 INFO - 'LOGNAME': 'cltbld', 10:04:53 INFO - 'MAIL': '/var/mail/cltbld', 10:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:53 INFO - 'MOZ_NO_REMOTE': '1', 10:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:53 INFO - 'NO_EM_RESTART': '1', 10:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:53 INFO - 'PWD': '/builds/slave/test', 10:04:53 INFO - 'SHELL': '/bin/bash', 10:04:53 INFO - 'SHLVL': '1', 10:04:53 INFO - 'TERM': 'linux', 10:04:53 INFO - 'TMOUT': '86400', 10:04:53 INFO - 'USER': 'cltbld', 10:04:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:53 INFO - '_': '/tools/buildbot/bin/python'} 10:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:53 INFO - Running setup.py (path:/tmp/pip-PHFW5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:53 INFO - Running setup.py (path:/tmp/pip-QU57Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:53 INFO - Running setup.py (path:/tmp/pip-BrW2Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:53 INFO - Running setup.py (path:/tmp/pip-mFMA0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:53 INFO - Running setup.py (path:/tmp/pip-nT1AkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:53 INFO - Running setup.py (path:/tmp/pip-zJcKpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:54 INFO - Running setup.py (path:/tmp/pip-wU5KCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:54 INFO - Running setup.py (path:/tmp/pip-5QAjau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:54 INFO - Running setup.py (path:/tmp/pip-1NIIaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:54 INFO - Running setup.py (path:/tmp/pip-VlAwaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:54 INFO - Running setup.py (path:/tmp/pip-jU64FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:54 INFO - Running setup.py (path:/tmp/pip-mvXg5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:54 INFO - Running setup.py (path:/tmp/pip-QL1ynB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:54 INFO - Running setup.py (path:/tmp/pip-JJauzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:54 INFO - Running setup.py (path:/tmp/pip-pRv9kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:54 INFO - Running setup.py (path:/tmp/pip-twPRYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:54 INFO - Running setup.py (path:/tmp/pip-4ikEAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - Downloading blessings-1.6.tar.gz 10:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:56 INFO - Installing collected packages: blessings 10:04:56 INFO - Running setup.py install for blessings 10:04:56 INFO - Successfully installed blessings 10:04:56 INFO - Cleaning up... 10:04:57 INFO - Return code: 0 10:04:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:57 INFO - Reading from file tmpfile_stdout 10:04:57 INFO - Current package versions: 10:04:57 INFO - argparse == 1.2.1 10:04:57 INFO - blessings == 1.6 10:04:57 INFO - blobuploader == 1.2.4 10:04:57 INFO - docopt == 0.6.1 10:04:57 INFO - functools32 == 3.2.3-2 10:04:57 INFO - jsonschema == 2.5.1 10:04:57 INFO - manifestparser == 1.1 10:04:57 INFO - mozInstall == 1.12 10:04:57 INFO - mozcrash == 0.17 10:04:57 INFO - mozdebug == 0.1 10:04:57 INFO - mozdevice == 0.48 10:04:57 INFO - mozfile == 1.2 10:04:57 INFO - mozhttpd == 0.7 10:04:57 INFO - mozinfo == 0.9 10:04:57 INFO - mozleak == 0.1 10:04:57 INFO - mozlog == 3.2 10:04:57 INFO - moznetwork == 0.27 10:04:57 INFO - mozprocess == 0.22 10:04:57 INFO - mozprofile == 0.28 10:04:57 INFO - mozrunner == 6.11 10:04:57 INFO - mozscreenshot == 0.1 10:04:57 INFO - mozsystemmonitor == 0.3 10:04:57 INFO - moztest == 0.7 10:04:57 INFO - mozversion == 1.4 10:04:57 INFO - psutil == 3.1.1 10:04:57 INFO - requests == 1.2.3 10:04:57 INFO - wsgiref == 0.1.2 10:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:04:57 INFO - Cleaning up... 10:04:57 INFO - Return code: 0 10:04:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:04:57 INFO - Cleaning up... 10:04:57 INFO - Return code: 0 10:04:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 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 0x7f27b4d89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, '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': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Downloading/unpacking flake8 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:04:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:04:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:00 INFO - no previously-included directories found matching 'docs/_build' 10:05:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:00 INFO - Running setup.py install for pep8 10:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:00 INFO - no previously-included directories found matching 'docs/_build' 10:05:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:00 INFO - Cleaning up... 10:05:00 INFO - Return code: 0 10:05:00 INFO - Running post-action listener: _resource_record_post_action 10:05:00 INFO - Running post-action listener: _start_resource_monitoring 10:05:00 INFO - Starting resource monitoring. 10:05:00 INFO - ##### 10:05:00 INFO - ##### Finished create-virtualenv step (success) 10:05:00 INFO - ##### 10:05:00 INFO - ##### 10:05:00 INFO - ##### Running install step. 10:05:00 INFO - ##### 10:05:00 INFO - Running pre-action listener: _resource_record_pre_action 10:05:00 INFO - Running main action method: install 10:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Output received: 10:05:01 INFO - Usage: mozinstall [options] installer 10:05:01 INFO - Options: 10:05:01 INFO - -h, --help show this help message and exit 10:05:01 INFO - -d DEST, --destination=DEST 10:05:01 INFO - Directory to install application into. [default: 10:05:01 INFO - "/builds/slave/test"] 10:05:01 INFO - --app=APP Application being installed. [default: firefox] 10:05:01 INFO - mkdir: /builds/slave/test/build/application 10:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:05:18 INFO - Reading from file tmpfile_stdout 10:05:18 INFO - Output received: 10:05:18 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:18 INFO - Running post-action listener: _resource_record_post_action 10:05:18 INFO - ##### 10:05:18 INFO - ##### Finished install step (success) 10:05:18 INFO - ##### 10:05:18 INFO - ##### 10:05:18 INFO - ##### Running run-tests step. 10:05:18 INFO - ##### 10:05:18 INFO - Running pre-action listener: _resource_record_pre_action 10:05:18 INFO - Running main action method: run_tests 10:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:18 INFO - Python 2.7.3 10:05:18 INFO - Return code: 0 10:05:18 INFO - grabbing minidump binary from tooltool 10:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:18 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 0x258f1c0>, '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 0x25900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2590550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:05:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:05:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:05:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:18 INFO - Return code: 0 10:05:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:19 INFO - Return code: 0 10:05:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:05:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 10:05:19 INFO - Using env: {'DISPLAY': ':0', 10:05:19 INFO - 'HOME': '/home/cltbld', 10:05:19 INFO - 'LANG': 'en_US.UTF-8', 10:05:19 INFO - 'LANGUAGE': 'en_US:en', 10:05:19 INFO - 'LOGNAME': 'cltbld', 10:05:19 INFO - 'MAIL': '/var/mail/cltbld', 10:05:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:19 INFO - 'MOZ_NO_REMOTE': '1', 10:05:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:19 INFO - 'NO_EM_RESTART': '1', 10:05:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:19 INFO - 'PWD': '/builds/slave/test', 10:05:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:19 INFO - 'SHELL': '/bin/bash', 10:05:19 INFO - 'SHLVL': '1', 10:05:19 INFO - 'TERM': 'linux', 10:05:19 INFO - 'TMOUT': '86400', 10:05:19 INFO - 'USER': 'cltbld', 10:05:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660', 10:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:19 INFO - '_': '/tools/buildbot/bin/python'} 10:05:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:05:19 INFO - mozversion application_buildid: 20160624073140 10:05:19 INFO - mozversion application_changeset: a277f3e065d2a4026a6c10d2dae02699ef30a504 10:05:19 INFO - mozversion application_display_name: Nightly 10:05:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:19 INFO - mozversion application_name: Firefox 10:05:19 INFO - mozversion application_remotingname: firefox 10:05:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:05:19 INFO - mozversion application_vendor: Mozilla 10:05:19 INFO - mozversion application_version: 50.0a1 10:05:19 INFO - mozversion platform_buildid: 20160624073140 10:05:19 INFO - mozversion platform_changeset: a277f3e065d2a4026a6c10d2dae02699ef30a504 10:05:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:05:19 INFO - mozversion platform_version: 50.0a1 10:05:19 INFO - using testdate: 1466787919 10:05:19 INFO - actual date: 1466787919 10:05:19 INFO - starting webserver on 'localhost:59305' 10:05:19 INFO - SUITE-START | Running 2 tests 10:05:19 INFO - TEST-START | dromaeo_css 10:05:19 INFO - operating with platform_type : linux_ 10:05:19 INFO - Initialising browser for dromaeo_css test... 10:05:19 INFO - TEST-INFO | started process 13123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uU_e_/profile http://localhost:59305/getInfo.html) 10:05:23 INFO - PROCESS | 13123 | __metrics Screen width/height:1600/1200 10:05:23 INFO - PROCESS | 13123 | colorDepth:24 10:05:23 INFO - PROCESS | 13123 | Browser inner width/height: 1024/697 10:05:23 INFO - PROCESS | 13123 | __metrics 10:05:24 INFO - PROCESS | 13123 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:25 INFO - TEST-INFO | 13123: exit 0 10:05:25 INFO - Browser initialized. 10:05:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:25 INFO - TEST-INFO | started process 13202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uU_e_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:37 INFO - PROCESS | 13202 | RSS: Main: 173907968 10:05:37 INFO - PROCESS | 13202 | 10:06:29 INFO - PROCESS | 13202 | 1466787989141 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:08:37 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59305/tests/dromaeo/cssquery-ext.html) 10:08:38 INFO - PROCESS | 13202 | RSS: Main: 275607552 10:08:38 INFO - PROCESS | 13202 | 10:11:40 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-ext.html (next: http://localhost:59305/tests/dromaeo/cssquery-jquery.html) 10:11:41 INFO - PROCESS | 13202 | RSS: Main: 257224704 10:11:41 INFO - PROCESS | 13202 | 10:14:43 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59305/tests/dromaeo/cssquery-mootools.html) 10:14:43 INFO - PROCESS | 13202 | RSS: Main: 254840832 10:14:43 INFO - PROCESS | 13202 | 10:17:46 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59305/tests/dromaeo/cssquery-prototype.html) 10:17:46 INFO - PROCESS | 13202 | RSS: Main: 255754240 10:17:46 INFO - PROCESS | 13202 | 10:20:49 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59305/tests/dromaeo/cssquery-yui.html) 10:20:49 INFO - PROCESS | 13202 | RSS: Main: 226807808 10:20:49 INFO - PROCESS | 13202 | 10:23:52 INFO - PROCESS | 13202 | Cycle 1(1): loaded http://localhost:59305/tests/dromaeo/cssquery-yui.html (next: http://localhost:59305/tests/dromaeo/cssquery-dojo.html) 10:23:53 INFO - PROCESS | 13202 | RSS: Main: 318283776 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | __start_tp_report 10:23:53 INFO - PROCESS | 13202 | _x_x_mozilla_page_load 10:23:53 INFO - PROCESS | 13202 | _x_x_mozilla_page_load_details 10:23:53 INFO - PROCESS | 13202 | |i|pagename|runs| 10:23:53 INFO - PROCESS | 13202 | |0;dojo.html;3076.2001879511326;3095.8606862691177;3106.953395699065;3126.968730312696;3152.684731526848;5170.793168273274;5198;5236.816711415101;5352.839414817552;5376.193570964352;5259.13224317988;5269.683818970864;5271.103912334903;5282.683039017662;5306.973465132679;4741.952580474194;4827.131116399064;4844.491328410519;4855.951440485603;4950.975245123787;4851.490593487686;4862.270659401082;4889.193283108283;4912.606991440694;4931.063098011385;4765.90468190636;4778.665493415445;4798;4803.0874133914795;4835.395575553056;4813.3983252093485;4814.831480898187;4866.829660961885;4872.756362181876;4916.410030796292;4709.952900470986;4815.735134567597;4818.132736107499;4845.878853028667;4871.12319782439;5216.58267338612;5333.519983201491;5351.411344752074;5390.4879036491475;5390.51485366315;5703.144528320744;5726.083826587767;5748.367679555287;5751.137329400582;5757.798477053325;5517.668939863621;5705.429457054262;5717.771289148429;5725.856853578653;5792.942070579283;5416.377116631598;5438.293021907166;5448.727563621843;5463.043967305705;5466.34403871538;5955.553333500005;5970.552208584373;5972.25346831646;5978.671173085522;5980.401959803985;5376.327959005124;5509.696966666872;5553.8333849984565;5571.860703482364;5739.741711622987;5560.944390556124;5589.580781441408;5599.524040456526;5648.943510564924;5657.745401456944;5554.972225138848;5567.749451274703;5571.554275657938;5575.135853942646;5600.327960644668;5462.754176062087;5647.915281270784;5651.406602306781;5658.434156584309;5755.22304488897;4359.084592235666;4376.693631445768;4380.496242932104;4389.875029849522;4419.469663640384;3843.135294558758;3911.706622003361;3937.8818635440985;3960.001791856021;3975.0658595230097;5312.362516498045;5344.43883392246;5365.356157261075;5400.162974738922;5449.373322068013;5675.858103547362;5677.886442271214;5689.687067211343;5691.772329106872;5698.430156984268;5151.484851514819;5338.225957236179;5381.48875856793;5395.487428694268;5401.7299135043095;4846.36997190363;4883.584895283941;4895.216765317532;4920.950790492049;4923.040007198633;5869.325027621793;5872.647641141545;5873.676947767828;5875.588708790429;5878.382769809108;5497.065498865282;5564.4713752193475;5656.123300888369;5675.602707810579;5723.828285151452;5808.128780682931;5881.823545293648;5884.852878678067;5896.528277737685;5912.379200184091;5538.556915446835;5566.443355664401;5572.554195664418;5573.275474188492;5575.498205161555;5489.917651235314;5597.860053498695;5628.85927851807;5712.857178570569;5725.055365864586;5534.446555344433;5546.473085056913;5554.389017208023;5583.776648933997;5587.189857470726;5487.972560137174;5509.063459212024;5529.612927095065;5530.91703624454;5532.806351777668;5212.947870521246;5419.268398766116;5441.972790136024;5465.808696695596;5481.068218402801;5676.432356764456;5684.914726279027;5720.39935806751;5723.112917497794;5731.025725626737;5493.395726470005;5564.582656300713;5565.332160140809;5565.415631358649;5591.664500130005 10:23:53 INFO - PROCESS | 13202 | |1;ext.html;590.949769269612;623.0591806372378;624;644.024303180681;654.1169421281271;32247.35505289893;42078;42826;42883.78558107213;42960.78519607405;45377.31934020992;46026.76986615062;46082.769586152106;46083;46150.7692461538;8154.469959452616;8329.458585191973;8927.01802801693;9104.31717621181;10700.625478108268;10741.83887241692;10857.619983300587;10886.40124793136;10892.074173695246;10902.182336324768;10890.455477226147;10941.28881622696;10948;10968.506417211205;10989.340639561611;8195.79510512239;8362.372822038371;10675.519601617945;10864.891351086468;10936.781264374747;10862.239643224977;10949.288296260718;10951.069159121484;10951.726206844813;10956.233063685546;41449.1710165798;41512.792436037926;41799.58200417987;41820.58179418197;41825.581744182775;3574.249407624402;3638.272345530904;3680.8895733128047;3723.7951912644794;3828.559715632682;32796.34407311864;32828.3434331312;33330.1667458313;34773.826130869435;34832.303353933035;4373.650107991385;4398.934015989763;4442.622377097919;4453.064856380164;4478.596926276618;352814;353541;354645;355874;355927;58181;58315.416845831845;58429;58649;58719.41280587225;35804.64195358065;36623;36677.449838251916;38368.6163138365;61345.69327153335;17184.484465466056;17263.74104388435;17319.826801732073;17339;17344.566385840204;13325.400356983959;13389.531366402129;13436.261005644588;13439.193648381128;13439.798403023962;19230.615387692447;19597.118129684197;19719.40841774749;19719.802801972084;19813.20747170097;7063.470239731938;7101.9289807102305;7155.463340249502;7304.4156467483535;7337.266273372727;822.4037572759702;932.6455946740195;1013.9695809125737;1018.7554986803113;1122.1864148492277;32487.350252995282;33360.49959250613;33553.496697549555;34983.12542186466;35766.82116589452;1032.2052019944601;1067.0396643021188;1083.9024487796137;1106.192479489977;1128.5260190719753;16504.83495165057;17082.316707331567;17130.486085417208;17136.143192840307;17180.22688978999;559328;562703;562819;563726;566044;55755.721221394444;57135.42864571301;57135.714321428124;57179.42820571741;57208.855822883306;1263.823064770933;1300.6683295759522;1365.8019587160004;1396.6438558167806;1413.2156653057446;30722;31857.362852742353;32188.356232874743;32974.67025329812;33073.33853322968;48178.759106205645;48624.513754862;48776.26835597398;48783.26825097697;48814.511854881;407224;407648;409351;410250;410919;21882.45293867666;25021.624675630243;25464.49071018532;26217.475650487264;26455.33861653474;47179.292310614685;47437.76281118573;47552.524474756196;48059.27911081267;48823;39340;39750.204995899345;40209.597904020586;40370.79814601026;41196.38205426981;39379.40930885982;39846.2030759389;40362.9909252271;40495.59504405036;40835.14154009191;39362.606373935894;39406.2118757629;39972.80013599913;40074;40820.97947551335;33909.830450847585;36103.63896361003;36188.819055904554;36354.45468317925;39052.2189556213;27892.721072789012;27918;28173.43653126967;28234.2941426466;28567.714322856504 10:23:53 INFO - PROCESS | 13202 | |2;jquery.html;386.1620283983756;387.11737239094873;394.4911064726503;403.32845811723485;414.9917001659967;14315.212663303515;16256.43102491413;18018;19599.608007839834;19628.803711962875;18161.182746776394;19368.322108726163;19637.607247855034;19785.901070494663;19810.60378792427;5512.255845460872;5584.6090773645865;5768.451997060272;5771.884562308751;5772.220750198711;4001.75989440633;5678.5741069419755;5762.711864406784;5775.56683248756;6124.326324104345;6331.303556608792;6454.257760357572;6454.838629034288;6485.767704136222;6493.415592596665;6234.314225435199;6457.61254324742;6458.386453286954;6468.32082631324;6471.611703297817;5667.149927510865;5677.460641239076;5678.801241956512;5680.091185410356;5695.288088988877;20611;21764.673529897063;21785.128594856185;21841.563168736695;22762.886185569132;2421.6488609151575;2484.4037431016604;2654.1506717850298;2766.0180635874176;2776.8611569421446;10101.595936162545;10151.593936242616;10218.131458826008;10673.626423075233;10781.676549703521;1931.5943651833131;1964.734760807287;1978.910949007298;1980.3959792263354;2049.6208201482773;74675;76663;80294.19705802925;80495;81839.59080204621;10763.94618026905;10804.675859724064;10900.182486313559;10932.289401189057;10942.671719848417;13143.605691829069;13738.931305343409;14556.199409032604;15204.871318015486;15234;7818.765437036898;7890.8816367754525;7925.8811117833275;7983.20167983197;8278.172182781795;7992.240737129963;8041.718539851194;8146.389020823462;8172.509649421054;8321.251087402163;4601.401817763669;4685.67200295976;4743.193657078305;4768.880777980578;4772.117158325721;1837.9908100459413;1881.5672395349147;1925.3068895197719;1929.7105434184705;1948.366780796247;860.9311255099702;947.8909675679472;976.9071938165863;992.8957459466797;1040.2822052783706;18218.908905455388;18912.810871891106;18916;18965.33621323247;19374.321898733477;962.4946902875906;978.2125389061731;988.9159421449114;1012.9240306977006;1047.502436342731;10369.325993810378;10578.57685692579;10605.628802991858;10724.839127412939;10745;488376;504280;505983;507114;517608;95047;96965;97303;97769.51115244378;97852;968.3995922528078;996.2838611977365;1008.4503945349802;1012.5392946209457;1017.8371460566274;16521.91739041345;16539.67682585366;16784.664306714043;16844.410445634345;17094.658106838044;42467.7876610615;43683;43704.12591748211;43930.56069439265;43938.34092488679;53594;54769.72615136899;56857.71571142118;63848;63950;7553.886691699519;7882.566458844589;7884.250996155356;8225;8329.6668133274;12133;14024.368903399167;14028.579142625738;14038.578842634737;14070.718585628434;11677.76644467123;12058.51765929353;12105.939470302592;12289.1397602167;12308.692282693004;11807.82288265694;12043.397830108635;12069.171971979795;12248.755024899274;12432.316222607844;12020.398980050788;12220.144589878622;12485.56300529477;12575;12628.87371126277;7688.884666730115;7705.22947705225;7919.643616037408;8278.793030174294;8456.027556830797;11128.944355278172;11513.424328783694;11563.42182890869;11634.301941883514;12281.815772763237 10:23:53 INFO - PROCESS | 13202 | |3;mootools.html;1320.775468170411;1488.642725745821;1520.2246854104408;1623.8294979027203;1758.7273972534247;8204.302634276086;8675.132486751321;8699.739007829767;8938.553072346373;8956.865647015284;8681.869771953427;8860.246879015276;8878.86681699775;8879.689210877621;8885.111488851111;1933.1880610143774;1994.2820584589535;1996.5607566335384;2282.3609389370963;2319.5824751544715;2236.642137258039;2311.884405779713;2313.3175713164574;2320.9419764505856;2326.5928462519078;2258.1870526610487;2316.6872472216205;2321.3036089173265;2332.766723327662;2337.532493501298;1930.9324173653854;2203.6804663323887;2263.7849404306567;2276.6243569810963;2283.9657405138937;2260.6609008648834;2290.7480177180496;2291.301153148289;2292.346681195868;2300.7124109486313;8561.571921403905;8610.182032706884;8620.913790862074;8622.396432249745;8623.31013518917;5105.055564720538;5267.947320526784;5279.788808447657;5284.841454756363;5294.152935530296;3146.386454641346;3285.178705323669;3441.913952151216;3468.2543253200683;3509.087637214317;1128.5937062657438;1131.377742241772;1148.6037317125579;1152.7060599547062;1159.3913195572309;12260.754784904251;12263.754724905451;12263.75472490554;12271.631851044483;12272.509099635914;4630.907381852411;4636.165490211727;4774.689645173053;4783.808647654055;4795.424549054066;10481.737956551147;10484;10484.842727359095;10492.737681558023;10494.212934029978;5349.144136938071;5433.375161856437;5434.239206511092;5436.565074794007;5440.564754819605;4358.956410435919;4776.641751868624;4910.312556242129;4920.040592084509;4970.90058198834;3938.78336691479;3952.2490726761825;4021.617946295097;4032.0726232965994;4200.243956087872;1242.8446444194476;1252.167308739678;1257.3147634539198;1265.0891358222066;1266.0441366768032;1006.1246715357686;1013.3514550687419;1013.4426065664003;1024.1039090795555;1026.2662196529518;6022.3676513966275;6043.516518678495;6149.446549810538;6207.192635635684;6308.589941653778;454.3729653078796;456.6597884576012;460.0316334116703;460.25438789161103;473.4366104335829;4319.179355922428;4319.179355922428;4378.474583050054;4428.911421771611;4488.551144885485;10634.096101831276;10944;10946;11016.834747478793;11033.724156895982;10651;10869.619563315246;10895.346279223271;11077.889221107847;11086.611968581223;8118.228768267005;8211.8357632847;8254.876176857351;8292.419530632798;8338.458000229966;5937.5249980000635;6026.15633811258;6046.3046749624355;6065.969670151621;6117.418845209698;10093.747656308651;10156.695299141038;10279.7430064246;10280.588776448858;10298.3820970742;9938.30431869791;10171.338862973884;10285.9485702571;10336.844947325946;10369.429681367597;7115.181754098345;7350.154732205865;7351.77944661661;7887.881681774663;7970.521768693897;8235.83528329418;8480.067192608685;8482.57587120629;8707.216350528483;8709.564521773758;7632.274933881273;7686.3082322591235;7697.615119243904;7841.9215807843475;7920.722774702857;7308.342249197598;7699.499532530368;7798.844023119619;7924.4056695746895;7929.326007289445;7051.753188638373;7159.57042577447;7257.782266532013;7284.344409003215;7285.380742636935;5135.409427915688;5203.453637368173;5261.842144735664;5355.678659280456;5364.30264065669;5210.374755029269;5293.841184764463;5330.466953304638;5478.945210547843;5502.339719233558 10:23:53 INFO - PROCESS | 13202 | |4;prototype.html;318.390282608804;321.9742420606351;334.0979355739502;336.7423920700663;336.94271973764455;5241.790328386869;5248.160294352904;5370.812021579245;5404.486573775485;5426.837194884155;5287.4976877196705;5298.23175639533;5308.124159513675;5320.920186197211;5368.973155134219;4175.248455278049;4195.244855925932;4195.307774217251;4198.3282674772045;4219.831206751726;3893.4743809585766;3927.4501569780255;4135.793210339471;4218.869470917182;4243.8090285937205;4150.592656259378;4160.375943608467;4188.329867221245;4193.798255915638;4197.811098500575;4157.66738660908;4169.395437661522;4180.205760905418;4184.28867092595;4204.5375008749015;3667.468217108531;3747.2505498900055;3754.4743735877;3758.586555478895;3758.8120593970193;5167.534921857051;5171;5174.24973378858;5186.974065129651;5209.895802083975;4763.54746299101;4780;4798.664093513456;4802.2316429371485;4802.334704239146;5247.422783493813;5572.4148964358565;5575.386707462176;5575.609707320489;5624.465675760796;4090.8772736817646;4092.3043082676018;4096.610821971938;4102.261592913274;4119.764070778754;5815.389384114649;5846.327672317695;5866.618669786493;5891.970540147272;5909.497692696083;4125.50493940723;4227.217964676544;4239.385289133058;4254.978725106416;4268.210381079448;4229.365595160751;4244.448221731155;4257.169851878916;4262.808173632194;4268.722533035343;4772.5943294819635;4796.232602783538;4818.060478206786;4834.5890599299455;4852.490488498657;5425.728713564306;5644.491995720323;5652.8869422611315;5659.547236221092;5679.801206957736;1457.8191664751585;1473.5358362115899;1479.3121198642468;1483.5994281543922;1490.5826368616804;930.8417569013149;932.2355668352022;955.6177528988321;957.712686194139;965.1603105298435;4884.755762211875;4885.682430641997;4900.387451568554;4903;4905.658492234398;5141.357330333708;5145.970805838847;5147.558683568607;5149.407818100892;5179.249008893765;4586.88532786683;4889.193283108248;4901.456041346964;4906.852794416173;4909.263610458388;2665.746754058361;2710.8644567771535;2724.8637568121517;2747.7527022568065;2749.560070388728;5185.107435785911;5188.533032027136;5205.687658740488;5236.869078273074;5244.868878277997;5144.639875208774;5222.877081427511;5504.394516603171;5911.142884281841;5966.463018328372;5975.312839023481;6002.879942401215;6005.678750674844;6006.669633170218;6007.969960150172;5509.944900550943;5811.331696854916;5812.389699081536;5821.661017965806;5824;5690.406686127891;5721.1990321354215;5722;5728.341240757366;5750.654960702372;5941.67320797343;5972.790952316648;5979.641221526722;5979.730912108878;5998.280206375263;3845.654021092707;3903.5901230371537;4093.263212621757;4129.15352352773;4174.812133453941;5742.856428589152;5759.481646651821;5803.39064398249;5846.912296315473;5868.823935281948;5399.892002160013;5590.468905453975;5612.158176273429;5641.5204707600315;5658.5190258826815;5644.3508996465935;5647.237622920853;5655.377908430151;5678.898807441273;5682.090865461506;5549.639273447213;5555.2778138841695;5570.972145139248;5574.857154283443;5621.381648018633;5317.787288508571;5652.4064973178865;5705.115707065412;5708;5719.742611582572;5537.9169312459535;5544.500994910478;5562;5564.55483561306;5568.777248909998 10:23:53 INFO - PROCESS | 13202 | |5;yui.html;733.8568979049088;768.1128296817178;768.1857231334785;777.5567926282018;787.8621241282776;14323.570292891216;14984.850151498467;15015.92492037541;15070.362686529854;15112.47106351278;14364.353604087815;14493.710125797477;14531.854681453182;14545.054571452874;15160.317785699643;686.0326939015988;812.6302532347783;830.3564737328559;831.4886344897875;831.7504748575403;769.6267310354474;800.0998876264202;803.2890891560982;804.4328748232512;804.5856383962264;861.5950503263456;865.9478733338992;867.7657032601194;868.274990383031;868.3096937934325;704.7040243097911;838.9286910612606;865.9870101948476;867.509856930832;867.9609417576224;622.421148332051;630.5176539946945;630.8359826445158;630.8580569371901;631.251966419794;14718.484853030199;14780.63048423798;14790.96463247573;14850;14864.182469964147;14057.297135143202;14273.785893211507;14423.49517766873;14757.631059223499;14844.406223751037;13338.19970801755;13410.396532156077;13549.458021679122;13753.449862005507;14051.43794248229;4447.911041779179;4470.26240670289;4558.316252562109;4678;4683.555062269079;78720.60639696821;79299;79561.60219198867;80113;82596.58701706454;11433.256838305484;11437.59968401102;11531.443499416657;11608.76782464346;11871.881281187078;21738.239161629266;21883.234086806886;21888.23391181301;21928.342149735534;22306;8038.276555109951;8216.958915205385;8246.83506329882;8494.447860889146;8886.911130888608;4721.787519561628;4787.18617834962;4788.11419887322;4898.951010489849;4906.509349065065;3470.6355832637714;3600.3879340512176;3602.2615363850346;3605.1167463971497;3607.1703508193264;636.6275728698763;651.342144434125;657.1850904878013;658.1148355461896;660.4089340040733;559.3679142568872;649.3182158733406;671.0839703804272;725.2421219825295;732.8680837449203;9774.571325792449;9910.504474776233;10078.344907580984;10245.129164021142;10331.586736530455;706.9222385537587;733.8238822682517;741.9666115024837;770.1489853711568;779.8869163971192;4653.906921861611;4722.574968252874;4731.716097034189;4871.050145221648;4887.877803054952;114964;115835;118229;119761.40119299348;119986;103498.48250758697;103572.48213758883;105057.47471262747;105145.47427262968;105988;88596.5570172145;91156.54421727848;93800;94043;94562;9718.007808399403;9752.659996823986;9765.819631290484;9820.17574412615;9826.705198844045;50376.244356333955;50797;51028;51030.74484627553;52761.47238527566;76025;77518.2248177511;77588;78490;80037;11784.941075294568;12034.819477707666;12165;12296.81554776697;12883.871161288642;13972.510962116277;14012.299385030912;14043.648908777363;14474.493392731203;14621.707565848836;11434.256773309708;11979.820302695642;11985.28088314704;12164.148509604243;12438.937805310916;12847.807282890577;12919.418626162033;13022.218666880017;13216.801747973981;13834.100783449043;13553.322333883068;13965.231912244517;14068.648283792578;14429.567112986628;14745.26273686333;11146.219764616724;11148.163887708617;11339.773204536028;11406.600768973047;11905.940470297593;11783.410829458664;12139.939300303795;12233.266004039786;12566.623001309976;12632.2420654761 10:23:53 INFO - PROCESS | 13202 | __end_tp_report 10:23:53 INFO - PROCESS | 13202 | __start_cc_report 10:23:53 INFO - PROCESS | 13202 | _x_x_mozilla_cycle_collect,889 10:23:53 INFO - PROCESS | 13202 | __end_cc_report 10:23:53 INFO - PROCESS | 13202 | __startTimestamp1466789033056__endTimestamp 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | ------- Summary: start ------- 10:23:53 INFO - PROCESS | 13202 | Number of tests: 6 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#0] dojo.html Cycles:165 Average:5282.61 Median:5487.97 stddev:591.09 (10.8%) stddev-sans-first:566.99 10:23:53 INFO - PROCESS | 13202 | Values: 3076.2 3095.9 3107.0 3127.0 3152.7 5170.8 5198.0 5236.8 5352.8 5376.2 5259.1 5269.7 5271.1 5282.7 5307.0 4742.0 4827.1 4844.5 4856.0 4951.0 4851.5 4862.3 4889.2 4912.6 4931.1 4765.9 4778.7 4798.0 4803.1 4835.4 4813.4 4814.8 4866.8 4872.8 4916.4 4710.0 4815.7 4818.1 4845.9 4871.1 5216.6 5333.5 5351.4 5390.5 5390.5 5703.1 5726.1 5748.4 5751.1 5757.8 5517.7 5705.4 5717.8 5725.9 5792.9 5416.4 5438.3 5448.7 5463.0 5466.3 5955.6 5970.6 5972.3 5978.7 5980.4 5376.3 5509.7 5553.8 5571.9 5739.7 5560.9 5589.6 5599.5 5648.9 5657.7 5555.0 5567.7 5571.6 5575.1 5600.3 5462.8 5647.9 5651.4 5658.4 5755.2 4359.1 4376.7 4380.5 4389.9 4419.5 3843.1 3911.7 3937.9 3960.0 3975.1 5312.4 5344.4 5365.4 5400.2 5449.4 5675.9 5677.9 5689.7 5691.8 5698.4 5151.5 5338.2 5381.5 5395.5 5401.7 4846.4 4883.6 4895.2 4921.0 4923.0 5869.3 5872.6 5873.7 5875.6 5878.4 5497.1 5564.5 5656.1 5675.6 5723.8 5808.1 5881.8 5884.9 5896.5 5912.4 5538.6 5566.4 5572.6 5573.3 5575.5 5489.9 5597.9 5628.9 5712.9 5725.1 5534.4 5546.5 5554.4 5583.8 5587.2 5488.0 5509.1 5529.6 5530.9 5532.8 5212.9 5419.3 5442.0 5465.8 5481.1 5676.4 5684.9 5720.4 5723.1 5731.0 5493.4 5564.6 5565.3 5565.4 5591.7 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#1] ext.html Cycles:180 Average:59896.54 Median:36650.22 stddev:119605.36 (326.3%) stddev-sans-first:119858.00 10:23:53 INFO - PROCESS | 13202 | Values: 590.9 623.1 624.0 644.0 654.1 32247.4 42078.0 42826.0 42883.8 42960.8 45377.3 46026.8 46082.8 46083.0 46150.8 8154.5 8329.5 8927.0 9104.3 10700.6 10741.8 10857.6 10886.4 10892.1 10902.2 10890.5 10941.3 10948.0 10968.5 10989.3 8195.8 8362.4 10675.5 10864.9 10936.8 10862.2 10949.3 10951.1 10951.7 10956.2 41449.2 41512.8 41799.6 41820.6 41825.6 3574.2 3638.3 3680.9 3723.8 3828.6 32796.3 32828.3 33330.2 34773.8 34832.3 4373.7 4398.9 4442.6 4453.1 4478.6 352814.0 353541.0 354645.0 355874.0 355927.0 58181.0 58315.4 58429.0 58649.0 58719.4 35804.6 36623.0 36677.4 38368.6 61345.7 17184.5 17263.7 17319.8 17339.0 17344.6 13325.4 13389.5 13436.3 13439.2 13439.8 19230.6 19597.1 19719.4 19719.8 19813.2 7063.5 7101.9 7155.5 7304.4 7337.3 822.4 932.6 1014.0 1018.8 1122.2 32487.4 33360.5 33553.5 34983.1 35766.8 1032.2 1067.0 1083.9 1106.2 1128.5 16504.8 17082.3 17130.5 17136.1 17180.2 559328.0 562703.0 562819.0 563726.0 566044.0 55755.7 57135.4 57135.7 57179.4 57208.9 1263.8 1300.7 1365.8 1396.6 1413.2 30722.0 31857.4 32188.4 32974.7 33073.3 48178.8 48624.5 48776.3 48783.3 48814.5 407224.0 407648.0 409351.0 410250.0 410919.0 21882.5 25021.6 25464.5 26217.5 26455.3 47179.3 47437.8 47552.5 48059.3 48823.0 39340.0 39750.2 40209.6 40370.8 41196.4 39379.4 39846.2 40363.0 40495.6 40835.1 39362.6 39406.2 39972.8 40074.0 40821.0 33909.8 36103.6 36188.8 36354.5 39052.2 27892.7 27918.0 28173.4 28234.3 28567.7 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#2] jquery.html Cycles:180 Average:29483.02 Median:1581.51 stddev:83239.54 (5263.3%) stddev-sans-first:83444.38 10:23:53 INFO - PROCESS | 13202 | Values: 386.2 387.1 394.5 403.3 415.0 14315.2 16256.4 18018.0 19599.6 19628.8 18161.2 19368.3 19637.6 19785.9 19810.6 5512.3 5584.6 5768.5 5771.9 5772.2 4001.8 5678.6 5762.7 5775.6 6124.3 6331.3 6454.3 6454.8 6485.8 6493.4 6234.3 6457.6 6458.4 6468.3 6471.6 5667.1 5677.5 5678.8 5680.1 5695.3 20611.0 21764.7 21785.1 21841.6 22762.9 2421.6 2484.4 2654.2 2766.0 2776.9 10101.6 10151.6 10218.1 10673.6 10781.7 1931.6 1964.7 1978.9 1980.4 2049.6 74675.0 76663.0 80294.2 80495.0 81839.6 10763.9 10804.7 10900.2 10932.3 10942.7 13143.6 13738.9 14556.2 15204.9 15234.0 7818.8 7890.9 7925.9 7983.2 8278.2 7992.2 8041.7 8146.4 8172.5 8321.3 4601.4 4685.7 4743.2 4768.9 4772.1 1838.0 1881.6 1925.3 1929.7 1948.4 860.9 947.9 976.9 992.9 1040.3 18218.9 18912.8 18916.0 18965.3 19374.3 962.5 978.2 988.9 1012.9 1047.5 10369.3 10578.6 10605.6 10724.8 10745.0 488376.0 504280.0 505983.0 507114.0 517608.0 95047.0 96965.0 97303.0 97769.5 97852.0 968.4 996.3 1008.5 1012.5 1017.8 16521.9 16539.7 16784.7 16844.4 17094.7 42467.8 43683.0 43704.1 43930.6 43938.3 53594.0 54769.7 56857.7 63848.0 63950.0 7553.9 7882.6 7884.3 8225.0 8329.7 12133.0 14024.4 14028.6 14038.6 14070.7 11677.8 12058.5 12105.9 12289.1 12308.7 11807.8 12043.4 12069.2 12248.8 12432.3 12020.4 12220.1 12485.6 12575.0 12628.9 7688.9 7705.2 7919.6 8278.8 8456.0 11128.9 11513.4 11563.4 11634.3 12281.8 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#3] mootools.html Cycles:180 Average:5821.08 Median:455.52 stddev:3329.07 (730.8%) stddev-sans-first:3321.23 10:23:53 INFO - PROCESS | 13202 | Values: 1320.8 1488.6 1520.2 1623.8 1758.7 8204.3 8675.1 8699.7 8938.6 8956.9 8681.9 8860.2 8878.9 8879.7 8885.1 1933.2 1994.3 1996.6 2282.4 2319.6 2236.6 2311.9 2313.3 2320.9 2326.6 2258.2 2316.7 2321.3 2332.8 2337.5 1930.9 2203.7 2263.8 2276.6 2284.0 2260.7 2290.7 2291.3 2292.3 2300.7 8561.6 8610.2 8620.9 8622.4 8623.3 5105.1 5267.9 5279.8 5284.8 5294.2 3146.4 3285.2 3441.9 3468.3 3509.1 1128.6 1131.4 1148.6 1152.7 1159.4 12260.8 12263.8 12263.8 12271.6 12272.5 4630.9 4636.2 4774.7 4783.8 4795.4 10481.7 10484.0 10484.8 10492.7 10494.2 5349.1 5433.4 5434.2 5436.6 5440.6 4359.0 4776.6 4910.3 4920.0 4970.9 3938.8 3952.2 4021.6 4032.1 4200.2 1242.8 1252.2 1257.3 1265.1 1266.0 1006.1 1013.4 1013.4 1024.1 1026.3 6022.4 6043.5 6149.4 6207.2 6308.6 454.4 456.7 460.0 460.3 473.4 4319.2 4319.2 4378.5 4428.9 4488.6 10634.1 10944.0 10946.0 11016.8 11033.7 10651.0 10869.6 10895.3 11077.9 11086.6 8118.2 8211.8 8254.9 8292.4 8338.5 5937.5 6026.2 6046.3 6066.0 6117.4 10093.7 10156.7 10279.7 10280.6 10298.4 9938.3 10171.3 10285.9 10336.8 10369.4 7115.2 7350.2 7351.8 7887.9 7970.5 8235.8 8480.1 8482.6 8707.2 8709.6 7632.3 7686.3 7697.6 7841.9 7920.7 7308.3 7699.5 7798.8 7924.4 7929.3 7051.8 7159.6 7257.8 7284.3 7285.4 5135.4 5203.5 5261.8 5355.7 5364.3 5210.4 5293.8 5330.5 5478.9 5502.3 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#4] prototype.html Cycles:180 Average:4660.92 Median:5187.75 stddev:1367.26 (26.4%) stddev-sans-first:1331.68 10:23:53 INFO - PROCESS | 13202 | Values: 318.4 322.0 334.1 336.7 336.9 5241.8 5248.2 5370.8 5404.5 5426.8 5287.5 5298.2 5308.1 5320.9 5369.0 4175.2 4195.2 4195.3 4198.3 4219.8 3893.5 3927.5 4135.8 4218.9 4243.8 4150.6 4160.4 4188.3 4193.8 4197.8 4157.7 4169.4 4180.2 4184.3 4204.5 3667.5 3747.3 3754.5 3758.6 3758.8 5167.5 5171.0 5174.2 5187.0 5209.9 4763.5 4780.0 4798.7 4802.2 4802.3 5247.4 5572.4 5575.4 5575.6 5624.5 4090.9 4092.3 4096.6 4102.3 4119.8 5815.4 5846.3 5866.6 5892.0 5909.5 4125.5 4227.2 4239.4 4255.0 4268.2 4229.4 4244.4 4257.2 4262.8 4268.7 4772.6 4796.2 4818.1 4834.6 4852.5 5425.7 5644.5 5652.9 5659.5 5679.8 1457.8 1473.5 1479.3 1483.6 1490.6 930.8 932.2 955.6 957.7 965.2 4884.8 4885.7 4900.4 4903.0 4905.7 5141.4 5146.0 5147.6 5149.4 5179.2 4586.9 4889.2 4901.5 4906.9 4909.3 2665.7 2710.9 2724.9 2747.8 2749.6 5185.1 5188.5 5205.7 5236.9 5244.9 5144.6 5222.9 5504.4 5911.1 5966.5 5975.3 6002.9 6005.7 6006.7 6008.0 5509.9 5811.3 5812.4 5821.7 5824.0 5690.4 5721.2 5722.0 5728.3 5750.7 5941.7 5972.8 5979.6 5979.7 5998.3 3845.7 3903.6 4093.3 4129.2 4174.8 5742.9 5759.5 5803.4 5846.9 5868.8 5399.9 5590.5 5612.2 5641.5 5658.5 5644.4 5647.2 5655.4 5678.9 5682.1 5549.6 5555.3 5571.0 5574.9 5621.4 5317.8 5652.4 5705.1 5708.0 5719.7 5537.9 5544.5 5562.0 5564.6 5568.8 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - PROCESS | 13202 | [#5] yui.html Cycles:180 Average:21447.75 Median:4606.11 stddev:31307.12 (679.7%) stddev-sans-first:31356.31 10:23:53 INFO - PROCESS | 13202 | Values: 733.9 768.1 768.2 777.6 787.9 14323.6 14984.9 15015.9 15070.4 15112.5 14364.4 14493.7 14531.9 14545.1 15160.3 686.0 812.6 830.4 831.5 831.8 769.6 800.1 803.3 804.4 804.6 861.6 865.9 867.8 868.3 868.3 704.7 838.9 866.0 867.5 868.0 622.4 630.5 630.8 630.9 631.3 14718.5 14780.6 14791.0 14850.0 14864.2 14057.3 14273.8 14423.5 14757.6 14844.4 13338.2 13410.4 13549.5 13753.4 14051.4 4447.9 4470.3 4558.3 4678.0 4683.6 78720.6 79299.0 79561.6 80113.0 82596.6 11433.3 11437.6 11531.4 11608.8 11871.9 21738.2 21883.2 21888.2 21928.3 22306.0 8038.3 8217.0 8246.8 8494.4 8886.9 4721.8 4787.2 4788.1 4899.0 4906.5 3470.6 3600.4 3602.3 3605.1 3607.2 636.6 651.3 657.2 658.1 660.4 559.4 649.3 671.1 725.2 732.9 9774.6 9910.5 10078.3 10245.1 10331.6 706.9 733.8 742.0 770.1 779.9 4653.9 4722.6 4731.7 4871.1 4887.9 114964.0 115835.0 118229.0 119761.4 119986.0 103498.5 103572.5 105057.5 105145.5 105988.0 88596.6 91156.5 93800.0 94043.0 94562.0 9718.0 9752.7 9765.8 9820.2 9826.7 50376.2 50797.0 51028.0 51030.7 52761.5 76025.0 77518.2 77588.0 78490.0 80037.0 11784.9 12034.8 12165.0 12296.8 12883.9 13972.5 14012.3 14043.6 14474.5 14621.7 11434.3 11979.8 11985.3 12164.1 12438.9 12847.8 12919.4 13022.2 13216.8 13834.1 13553.3 13965.2 14068.6 14429.6 14745.3 11146.2 11148.2 11339.8 11406.6 11905.9 11783.4 12139.9 12233.3 12566.6 12632.2 10:23:53 INFO - PROCESS | 13202 | -------- Summary: end -------- 10:23:53 INFO - PROCESS | 13202 | 10:23:53 INFO - TEST-INFO | 13202: exit 0 10:23:53 INFO - TEST-OK | dromaeo_css | took 1114452ms 10:23:53 INFO - TEST-START | kraken 10:23:53 INFO - operating with platform_type : linux_ 10:23:53 INFO - Initialising browser for kraken test... 10:23:53 INFO - TEST-INFO | started process 13396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjrW6CX/profile http://localhost:59305/getInfo.html) 10:23:57 INFO - PROCESS | 13396 | __metrics Screen width/height:1600/1200 10:23:57 INFO - PROCESS | 13396 | colorDepth:24 10:23:57 INFO - PROCESS | 13396 | Browser inner width/height: 1024/697 10:23:57 INFO - PROCESS | 13396 | __metrics 10:23:58 INFO - PROCESS | 13396 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:23:59 INFO - TEST-INFO | 13396: exit 0 10:23:59 INFO - Browser initialized. 10:23:59 INFO - Running cycle 1/1 for kraken test... 10:23:59 INFO - TEST-INFO | started process 13475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjrW6CX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:11 INFO - PROCESS | 13475 | RSS: Main: 173670400 10:24:11 INFO - PROCESS | 13475 | 10:24:14 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59305/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:14 INFO - PROCESS | 13475 | RSS: Main: 232431616 10:24:14 INFO - PROCESS | 13475 | 10:24:17 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59305/tests/kraken/driver.html?testName=audio-dft) 10:24:18 INFO - PROCESS | 13475 | RSS: Main: 219967488 10:24:18 INFO - PROCESS | 13475 | 10:24:21 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59305/tests/kraken/driver.html?testName=audio-fft) 10:24:21 INFO - PROCESS | 13475 | RSS: Main: 285679616 10:24:21 INFO - PROCESS | 13475 | 10:24:24 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59305/tests/kraken/driver.html?testName=audio-oscillator) 10:24:24 INFO - PROCESS | 13475 | RSS: Main: 197050368 10:24:24 INFO - PROCESS | 13475 | 10:24:26 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:27 INFO - PROCESS | 13475 | RSS: Main: 202350592 10:24:27 INFO - PROCESS | 13475 | 10:24:30 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59305/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:30 INFO - PROCESS | 13475 | RSS: Main: 235933696 10:24:30 INFO - PROCESS | 13475 | 10:24:34 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59305/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:34 INFO - PROCESS | 13475 | RSS: Main: 237993984 10:24:34 INFO - PROCESS | 13475 | 10:24:37 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59305/tests/kraken/driver.html?testName=json-parse-financial) 10:24:38 INFO - PROCESS | 13475 | RSS: Main: 237342720 10:24:38 INFO - PROCESS | 13475 | 10:24:39 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:40 INFO - PROCESS | 13475 | RSS: Main: 226197504 10:24:40 INFO - PROCESS | 13475 | 10:24:42 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:42 INFO - PROCESS | 13475 | RSS: Main: 230633472 10:24:42 INFO - PROCESS | 13475 | 10:24:44 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:45 INFO - PROCESS | 13475 | RSS: Main: 236433408 10:24:45 INFO - PROCESS | 13475 | 10:24:48 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:48 INFO - PROCESS | 13475 | RSS: Main: 238096384 10:24:48 INFO - PROCESS | 13475 | 10:24:51 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:52 INFO - PROCESS | 13475 | RSS: Main: 239259648 10:24:52 INFO - PROCESS | 13475 | 10:24:53 INFO - PROCESS | 13475 | Cycle 1(1): loaded http://localhost:59305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59305/tests/kraken/driver.html?testName=ai-astar) 10:24:54 INFO - PROCESS | 13475 | RSS: Main: 282972160 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | __start_tp_report 10:24:54 INFO - PROCESS | 13475 | _x_x_mozilla_page_load 10:24:54 INFO - PROCESS | 13475 | _x_x_mozilla_page_load_details 10:24:54 INFO - PROCESS | 13475 | |i|pagename|runs| 10:24:54 INFO - PROCESS | 13475 | |0;ai-astar;99;109;109;109;111;108;109;110;108;109 10:24:54 INFO - PROCESS | 13475 | |1;audio-beat-detection;152;127;129;177;128;128;165;134;182;126 10:24:54 INFO - PROCESS | 13475 | |2;audio-dft;162;161;161;161;160;162;161;161;162;162 10:24:54 INFO - PROCESS | 13475 | |3;audio-fft;75;76;77;122;75;76;74;75;104;75 10:24:54 INFO - PROCESS | 13475 | |4;audio-oscillator;85;86;110;84;84;85;113;85;84;125 10:24:54 INFO - PROCESS | 13475 | |5;imaging-gaussian-blur;116;116;117;117;118;117;116;117;117;117 10:24:54 INFO - PROCESS | 13475 | |6;imaging-darkroom;146;145;146;146;146;145;146;146;146;146 10:24:54 INFO - PROCESS | 13475 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;95 10:24:54 INFO - PROCESS | 13475 | |8;json-parse-financial;52;54;52;54;54;53;54;55;53;53 10:24:54 INFO - PROCESS | 13475 | |9;json-stringify-tinderbox;61;63;63;62;63;63;63;64;63;62 10:24:54 INFO - PROCESS | 13475 | |10;stanford-crypto-aes;80;79;79;79;82;82;80;87;90;84 10:24:54 INFO - PROCESS | 13475 | |11;stanford-crypto-ccm;120;131;128;129;124;133;120;124;144;127 10:24:54 INFO - PROCESS | 13475 | |12;stanford-crypto-pbkdf2;161;164;164;165;162;163;163;169;163;162 10:24:54 INFO - PROCESS | 13475 | |13;stanford-crypto-sha256-iterative;64;64;65;64;62;63;69;64;63;62 10:24:54 INFO - PROCESS | 13475 | __end_tp_report 10:24:54 INFO - PROCESS | 13475 | __start_cc_report 10:24:54 INFO - PROCESS | 13475 | _x_x_mozilla_cycle_collect,1625 10:24:54 INFO - PROCESS | 13475 | __end_cc_report 10:24:54 INFO - PROCESS | 13475 | __startTimestamp1466789093996__endTimestamp 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | ------- Summary: start ------- 10:24:54 INFO - PROCESS | 13475 | Number of tests: 14 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:0.93 10:24:54 INFO - PROCESS | 13475 | Values: 99.0 109.0 109.0 109.0 111.0 108.0 109.0 110.0 108.0 109.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:143.00 stddev:22.31 (15.6%) stddev-sans-first:23.52 10:24:54 INFO - PROCESS | 13475 | Values: 152.0 127.0 129.0 177.0 128.0 128.0 165.0 134.0 182.0 126.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 10:24:54 INFO - PROCESS | 13475 | Values: 162.0 161.0 161.0 161.0 160.0 162.0 161.0 161.0 162.0 162.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:16.44 (21.9%) stddev-sans-first:17.19 10:24:54 INFO - PROCESS | 13475 | Values: 75.0 76.0 77.0 122.0 75.0 76.0 74.0 75.0 104.0 75.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.50 stddev:15.58 (18.4%) stddev-sans-first:16.17 10:24:54 INFO - PROCESS | 13475 | Values: 85.0 86.0 110.0 84.0 84.0 85.0 113.0 85.0 84.0 125.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:24:54 INFO - PROCESS | 13475 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:24:54 INFO - PROCESS | 13475 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:24:54 INFO - PROCESS | 13475 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 10:24:54 INFO - PROCESS | 13475 | Values: 52.0 54.0 52.0 54.0 54.0 53.0 54.0 55.0 53.0 53.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 10:24:54 INFO - PROCESS | 13475 | Values: 61.0 63.0 63.0 62.0 63.0 63.0 63.0 64.0 63.0 62.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:3.77 (4.6%) stddev-sans-first:3.91 10:24:54 INFO - PROCESS | 13475 | Values: 80.0 79.0 79.0 79.0 82.0 82.0 80.0 87.0 90.0 84.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:128.50 stddev:7.09 (5.5%) stddev-sans-first:6.90 10:24:54 INFO - PROCESS | 13475 | Values: 120.0 131.0 128.0 129.0 124.0 133.0 120.0 124.0 144.0 127.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.50 stddev:2.22 (1.4%) stddev-sans-first:2.15 10:24:54 INFO - PROCESS | 13475 | Values: 161.0 164.0 164.0 165.0 162.0 163.0 163.0 169.0 163.0 162.0 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - PROCESS | 13475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.00 (3.1%) stddev-sans-first:2.12 10:24:54 INFO - PROCESS | 13475 | Values: 64.0 64.0 65.0 64.0 62.0 63.0 69.0 64.0 63.0 62.0 10:24:54 INFO - PROCESS | 13475 | -------- Summary: end -------- 10:24:54 INFO - PROCESS | 13475 | 10:24:54 INFO - TEST-INFO | 13475: exit 0 10:24:55 INFO - TEST-OK | kraken | took 61198ms 10:24:55 INFO - SUITE-END | took 1175s 10:24:55 INFO - Completed test suite (00:19:35) 10:24:55 INFO - javascript benchmark 10:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.2001879511326, 3095.8606862691177, 3106.953395699065, 3126.968730312696, 3152.684731526848, 5170.793168273274, 5198.0, 5236.816711415101, 5352.839414817552, 5376.193570964352, 5259.13224317988, 5269.683818970864, 5271.103912334903, 5282.683039017662, 5306.973465132679, 4741.952580474194, 4827.131116399064, 4844.491328410519, 4855.951440485603, 4950.975245123787, 4851.490593487686, 4862.270659401082, 4889.193283108283, 4912.606991440694, 4931.063098011385, 4765.90468190636, 4778.665493415445, 4798.0, 4803.0874133914795, 4835.395575553056, 4813.3983252093485, 4814.831480898187, 4866.829660961885, 4872.756362181876, 4916.410030796292, 4709.952900470986, 4815.735134567597, 4818.132736107499, 4845.878853028667, 4871.12319782439, 5216.58267338612, 5333.519983201491, 5351.411344752074, 5390.4879036491475, 5390.51485366315, 5703.144528320744, 5726.083826587767, 5748.367679555287, 5751.137329400582, 5757.798477053325, 5517.668939863621, 5705.429457054262, 5717.771289148429, 5725.856853578653, 5792.942070579283, 5416.377116631598, 5438.293021907166, 5448.727563621843, 5463.043967305705, 5466.34403871538, 5955.553333500005, 5970.552208584373, 5972.25346831646, 5978.671173085522, 5980.401959803985, 5376.327959005124, 5509.696966666872, 5553.8333849984565, 5571.860703482364, 5739.741711622987, 5560.944390556124, 5589.580781441408, 5599.524040456526, 5648.943510564924, 5657.745401456944, 5554.972225138848, 5567.749451274703, 5571.554275657938, 5575.135853942646, 5600.327960644668, 5462.754176062087, 5647.915281270784, 5651.406602306781, 5658.434156584309, 5755.22304488897, 4359.084592235666, 4376.693631445768, 4380.496242932104, 4389.875029849522, 4419.469663640384, 3843.135294558758, 3911.706622003361, 3937.8818635440985, 3960.001791856021, 3975.0658595230097, 5312.362516498045, 5344.43883392246, 5365.356157261075, 5400.162974738922, 5449.373322068013, 5675.858103547362, 5677.886442271214, 5689.687067211343, 5691.772329106872, 5698.430156984268, 5151.484851514819, 5338.225957236179, 5381.48875856793, 5395.487428694268, 5401.7299135043095, 4846.36997190363, 4883.584895283941, 4895.216765317532, 4920.950790492049, 4923.040007198633, 5869.325027621793, 5872.647641141545, 5873.676947767828, 5875.588708790429, 5878.382769809108, 5497.065498865282, 5564.4713752193475, 5656.123300888369, 5675.602707810579, 5723.828285151452, 5808.128780682931, 5881.823545293648, 5884.852878678067, 5896.528277737685, 5912.379200184091, 5538.556915446835, 5566.443355664401, 5572.554195664418, 5573.275474188492, 5575.498205161555, 5489.917651235314, 5597.860053498695, 5628.85927851807, 5712.857178570569, 5725.055365864586, 5534.446555344433, 5546.473085056913, 5554.389017208023, 5583.776648933997, 5587.189857470726, 5487.972560137174, 5509.063459212024, 5529.612927095065, 5530.91703624454, 5532.806351777668, 5212.947870521246, 5419.268398766116, 5441.972790136024, 5465.808696695596, 5481.068218402801, 5676.432356764456, 5684.914726279027, 5720.39935806751, 5723.112917497794, 5731.025725626737, 5493.395726470005, 5564.582656300713, 5565.332160140809, 5565.415631358649, 5591.664500130005], "value": 5243.587794156067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.949769269612, 623.0591806372378, 624.0, 644.024303180681, 654.1169421281271, 32247.35505289893, 42078.0, 42826.0, 42883.78558107213, 42960.78519607405, 45377.31934020992, 46026.76986615062, 46082.769586152106, 46083.0, 46150.7692461538, 8154.469959452616, 8329.458585191973, 8927.01802801693, 9104.31717621181, 10700.625478108268, 10741.83887241692, 10857.619983300587, 10886.40124793136, 10892.074173695246, 10902.182336324768, 10890.455477226147, 10941.28881622696, 10948.0, 10968.506417211205, 10989.340639561611, 8195.79510512239, 8362.372822038371, 10675.519601617945, 10864.891351086468, 10936.781264374747, 10862.239643224977, 10949.288296260718, 10951.069159121484, 10951.726206844813, 10956.233063685546, 41449.1710165798, 41512.792436037926, 41799.58200417987, 41820.58179418197, 41825.581744182775, 3574.249407624402, 3638.272345530904, 3680.8895733128047, 3723.7951912644794, 3828.559715632682, 32796.34407311864, 32828.3434331312, 33330.1667458313, 34773.826130869435, 34832.303353933035, 4373.650107991385, 4398.934015989763, 4442.622377097919, 4453.064856380164, 4478.596926276618, 352814.0, 353541.0, 354645.0, 355874.0, 355927.0, 58181.0, 58315.416845831845, 58429.0, 58649.0, 58719.41280587225, 35804.64195358065, 36623.0, 36677.449838251916, 38368.6163138365, 61345.69327153335, 17184.484465466056, 17263.74104388435, 17319.826801732073, 17339.0, 17344.566385840204, 13325.400356983959, 13389.531366402129, 13436.261005644588, 13439.193648381128, 13439.798403023962, 19230.615387692447, 19597.118129684197, 19719.40841774749, 19719.802801972084, 19813.20747170097, 7063.470239731938, 7101.9289807102305, 7155.463340249502, 7304.4156467483535, 7337.266273372727, 822.4037572759702, 932.6455946740195, 1013.9695809125737, 1018.7554986803113, 1122.1864148492277, 32487.350252995282, 33360.49959250613, 33553.496697549555, 34983.12542186466, 35766.82116589452, 1032.2052019944601, 1067.0396643021188, 1083.9024487796137, 1106.192479489977, 1128.5260190719753, 16504.83495165057, 17082.316707331567, 17130.486085417208, 17136.143192840307, 17180.22688978999, 559328.0, 562703.0, 562819.0, 563726.0, 566044.0, 55755.721221394444, 57135.42864571301, 57135.714321428124, 57179.42820571741, 57208.855822883306, 1263.823064770933, 1300.6683295759522, 1365.8019587160004, 1396.6438558167806, 1413.2156653057446, 30722.0, 31857.362852742353, 32188.356232874743, 32974.67025329812, 33073.33853322968, 48178.759106205645, 48624.513754862, 48776.26835597398, 48783.26825097697, 48814.511854881, 407224.0, 407648.0, 409351.0, 410250.0, 410919.0, 21882.45293867666, 25021.624675630243, 25464.49071018532, 26217.475650487264, 26455.33861653474, 47179.292310614685, 47437.76281118573, 47552.524474756196, 48059.27911081267, 48823.0, 39340.0, 39750.204995899345, 40209.597904020586, 40370.79814601026, 41196.38205426981, 39379.40930885982, 39846.2030759389, 40362.9909252271, 40495.59504405036, 40835.14154009191, 39362.606373935894, 39406.2118757629, 39972.80013599913, 40074.0, 40820.97947551335, 33909.830450847585, 36103.63896361003, 36188.819055904554, 36354.45468317925, 39052.2189556213, 27892.721072789012, 27918.0, 28173.43653126967, 28234.2941426466, 28567.714322856504], "value": 20302.705563826734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.1620283983756, 387.11737239094873, 394.4911064726503, 403.32845811723485, 414.9917001659967, 14315.212663303515, 16256.43102491413, 18018.0, 19599.608007839834, 19628.803711962875, 18161.182746776394, 19368.322108726163, 19637.607247855034, 19785.901070494663, 19810.60378792427, 5512.255845460872, 5584.6090773645865, 5768.451997060272, 5771.884562308751, 5772.220750198711, 4001.75989440633, 5678.5741069419755, 5762.711864406784, 5775.56683248756, 6124.326324104345, 6331.303556608792, 6454.257760357572, 6454.838629034288, 6485.767704136222, 6493.415592596665, 6234.314225435199, 6457.61254324742, 6458.386453286954, 6468.32082631324, 6471.611703297817, 5667.149927510865, 5677.460641239076, 5678.801241956512, 5680.091185410356, 5695.288088988877, 20611.0, 21764.673529897063, 21785.128594856185, 21841.563168736695, 22762.886185569132, 2421.6488609151575, 2484.4037431016604, 2654.1506717850298, 2766.0180635874176, 2776.8611569421446, 10101.595936162545, 10151.593936242616, 10218.131458826008, 10673.626423075233, 10781.676549703521, 1931.5943651833131, 1964.734760807287, 1978.910949007298, 1980.3959792263354, 2049.6208201482773, 74675.0, 76663.0, 80294.19705802925, 80495.0, 81839.59080204621, 10763.94618026905, 10804.675859724064, 10900.182486313559, 10932.289401189057, 10942.671719848417, 13143.605691829069, 13738.931305343409, 14556.199409032604, 15204.871318015486, 15234.0, 7818.765437036898, 7890.8816367754525, 7925.8811117833275, 7983.20167983197, 8278.172182781795, 7992.240737129963, 8041.718539851194, 8146.389020823462, 8172.509649421054, 8321.251087402163, 4601.401817763669, 4685.67200295976, 4743.193657078305, 4768.880777980578, 4772.117158325721, 1837.9908100459413, 1881.5672395349147, 1925.3068895197719, 1929.7105434184705, 1948.366780796247, 860.9311255099702, 947.8909675679472, 976.9071938165863, 992.8957459466797, 1040.2822052783706, 18218.908905455388, 18912.810871891106, 18916.0, 18965.33621323247, 19374.321898733477, 962.4946902875906, 978.2125389061731, 988.9159421449114, 1012.9240306977006, 1047.502436342731, 10369.325993810378, 10578.57685692579, 10605.628802991858, 10724.839127412939, 10745.0, 488376.0, 504280.0, 505983.0, 507114.0, 517608.0, 95047.0, 96965.0, 97303.0, 97769.51115244378, 97852.0, 968.3995922528078, 996.2838611977365, 1008.4503945349802, 1012.5392946209457, 1017.8371460566274, 16521.91739041345, 16539.67682585366, 16784.664306714043, 16844.410445634345, 17094.658106838044, 42467.7876610615, 43683.0, 43704.12591748211, 43930.56069439265, 43938.34092488679, 53594.0, 54769.72615136899, 56857.71571142118, 63848.0, 63950.0, 7553.886691699519, 7882.566458844589, 7884.250996155356, 8225.0, 8329.6668133274, 12133.0, 14024.368903399167, 14028.579142625738, 14038.578842634737, 14070.718585628434, 11677.76644467123, 12058.51765929353, 12105.939470302592, 12289.1397602167, 12308.692282693004, 11807.82288265694, 12043.397830108635, 12069.171971979795, 12248.755024899274, 12432.316222607844, 12020.398980050788, 12220.144589878622, 12485.56300529477, 12575.0, 12628.87371126277, 7688.884666730115, 7705.22947705225, 7919.643616037408, 8278.793030174294, 8456.027556830797, 11128.944355278172, 11513.424328783694, 11563.42182890869, 11634.301941883514, 12281.815772763237], "value": 9256.312416250606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.775468170411, 1488.642725745821, 1520.2246854104408, 1623.8294979027203, 1758.7273972534247, 8204.302634276086, 8675.132486751321, 8699.739007829767, 8938.553072346373, 8956.865647015284, 8681.869771953427, 8860.246879015276, 8878.86681699775, 8879.689210877621, 8885.111488851111, 1933.1880610143774, 1994.2820584589535, 1996.5607566335384, 2282.3609389370963, 2319.5824751544715, 2236.642137258039, 2311.884405779713, 2313.3175713164574, 2320.9419764505856, 2326.5928462519078, 2258.1870526610487, 2316.6872472216205, 2321.3036089173265, 2332.766723327662, 2337.532493501298, 1930.9324173653854, 2203.6804663323887, 2263.7849404306567, 2276.6243569810963, 2283.9657405138937, 2260.6609008648834, 2290.7480177180496, 2291.301153148289, 2292.346681195868, 2300.7124109486313, 8561.571921403905, 8610.182032706884, 8620.913790862074, 8622.396432249745, 8623.31013518917, 5105.055564720538, 5267.947320526784, 5279.788808447657, 5284.841454756363, 5294.152935530296, 3146.386454641346, 3285.178705323669, 3441.913952151216, 3468.2543253200683, 3509.087637214317, 1128.5937062657438, 1131.377742241772, 1148.6037317125579, 1152.7060599547062, 1159.3913195572309, 12260.754784904251, 12263.754724905451, 12263.75472490554, 12271.631851044483, 12272.509099635914, 4630.907381852411, 4636.165490211727, 4774.689645173053, 4783.808647654055, 4795.424549054066, 10481.737956551147, 10484.0, 10484.842727359095, 10492.737681558023, 10494.212934029978, 5349.144136938071, 5433.375161856437, 5434.239206511092, 5436.565074794007, 5440.564754819605, 4358.956410435919, 4776.641751868624, 4910.312556242129, 4920.040592084509, 4970.90058198834, 3938.78336691479, 3952.2490726761825, 4021.617946295097, 4032.0726232965994, 4200.243956087872, 1242.8446444194476, 1252.167308739678, 1257.3147634539198, 1265.0891358222066, 1266.0441366768032, 1006.1246715357686, 1013.3514550687419, 1013.4426065664003, 1024.1039090795555, 1026.2662196529518, 6022.3676513966275, 6043.516518678495, 6149.446549810538, 6207.192635635684, 6308.589941653778, 454.3729653078796, 456.6597884576012, 460.0316334116703, 460.25438789161103, 473.4366104335829, 4319.179355922428, 4319.179355922428, 4378.474583050054, 4428.911421771611, 4488.551144885485, 10634.096101831276, 10944.0, 10946.0, 11016.834747478793, 11033.724156895982, 10651.0, 10869.619563315246, 10895.346279223271, 11077.889221107847, 11086.611968581223, 8118.228768267005, 8211.8357632847, 8254.876176857351, 8292.419530632798, 8338.458000229966, 5937.5249980000635, 6026.15633811258, 6046.3046749624355, 6065.969670151621, 6117.418845209698, 10093.747656308651, 10156.695299141038, 10279.7430064246, 10280.588776448858, 10298.3820970742, 9938.30431869791, 10171.338862973884, 10285.9485702571, 10336.844947325946, 10369.429681367597, 7115.181754098345, 7350.154732205865, 7351.77944661661, 7887.881681774663, 7970.521768693897, 8235.83528329418, 8480.067192608685, 8482.57587120629, 8707.216350528483, 8709.564521773758, 7632.274933881273, 7686.3082322591235, 7697.615119243904, 7841.9215807843475, 7920.722774702857, 7308.342249197598, 7699.499532530368, 7798.844023119619, 7924.4056695746895, 7929.326007289445, 7051.753188638373, 7159.57042577447, 7257.782266532013, 7284.344409003215, 7285.380742636935, 5135.409427915688, 5203.453637368173, 5261.842144735664, 5355.678659280456, 5364.30264065669, 5210.374755029269, 5293.841184764463, 5330.466953304638, 5478.945210547843, 5502.339719233558], "value": 4569.714736165239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.390282608804, 321.9742420606351, 334.0979355739502, 336.7423920700663, 336.94271973764455, 5241.790328386869, 5248.160294352904, 5370.812021579245, 5404.486573775485, 5426.837194884155, 5287.4976877196705, 5298.23175639533, 5308.124159513675, 5320.920186197211, 5368.973155134219, 4175.248455278049, 4195.244855925932, 4195.307774217251, 4198.3282674772045, 4219.831206751726, 3893.4743809585766, 3927.4501569780255, 4135.793210339471, 4218.869470917182, 4243.8090285937205, 4150.592656259378, 4160.375943608467, 4188.329867221245, 4193.798255915638, 4197.811098500575, 4157.66738660908, 4169.395437661522, 4180.205760905418, 4184.28867092595, 4204.5375008749015, 3667.468217108531, 3747.2505498900055, 3754.4743735877, 3758.586555478895, 3758.8120593970193, 5167.534921857051, 5171.0, 5174.24973378858, 5186.974065129651, 5209.895802083975, 4763.54746299101, 4780.0, 4798.664093513456, 4802.2316429371485, 4802.334704239146, 5247.422783493813, 5572.4148964358565, 5575.386707462176, 5575.609707320489, 5624.465675760796, 4090.8772736817646, 4092.3043082676018, 4096.610821971938, 4102.261592913274, 4119.764070778754, 5815.389384114649, 5846.327672317695, 5866.618669786493, 5891.970540147272, 5909.497692696083, 4125.50493940723, 4227.217964676544, 4239.385289133058, 4254.978725106416, 4268.210381079448, 4229.365595160751, 4244.448221731155, 4257.169851878916, 4262.808173632194, 4268.722533035343, 4772.5943294819635, 4796.232602783538, 4818.060478206786, 4834.5890599299455, 4852.490488498657, 5425.728713564306, 5644.491995720323, 5652.8869422611315, 5659.547236221092, 5679.801206957736, 1457.8191664751585, 1473.5358362115899, 1479.3121198642468, 1483.5994281543922, 1490.5826368616804, 930.8417569013149, 932.2355668352022, 955.6177528988321, 957.712686194139, 965.1603105298435, 4884.755762211875, 4885.682430641997, 4900.387451568554, 4903.0, 4905.658492234398, 5141.357330333708, 5145.970805838847, 5147.558683568607, 5149.407818100892, 5179.249008893765, 4586.88532786683, 4889.193283108248, 4901.456041346964, 4906.852794416173, 4909.263610458388, 2665.746754058361, 2710.8644567771535, 2724.8637568121517, 2747.7527022568065, 2749.560070388728, 5185.107435785911, 5188.533032027136, 5205.687658740488, 5236.869078273074, 5244.868878277997, 5144.639875208774, 5222.877081427511, 5504.394516603171, 5911.142884281841, 5966.463018328372, 5975.312839023481, 6002.879942401215, 6005.678750674844, 6006.669633170218, 6007.969960150172, 5509.944900550943, 5811.331696854916, 5812.389699081536, 5821.661017965806, 5824.0, 5690.406686127891, 5721.1990321354215, 5722.0, 5728.341240757366, 5750.654960702372, 5941.67320797343, 5972.790952316648, 5979.641221526722, 5979.730912108878, 5998.280206375263, 3845.654021092707, 3903.5901230371537, 4093.263212621757, 4129.15352352773, 4174.812133453941, 5742.856428589152, 5759.481646651821, 5803.39064398249, 5846.912296315473, 5868.823935281948, 5399.892002160013, 5590.468905453975, 5612.158176273429, 5641.5204707600315, 5658.5190258826815, 5644.3508996465935, 5647.237622920853, 5655.377908430151, 5678.898807441273, 5682.090865461506, 5549.639273447213, 5555.2778138841695, 5570.972145139248, 5574.857154283443, 5621.381648018633, 5317.787288508571, 5652.4064973178865, 5705.115707065412, 5708.0, 5719.742611582572, 5537.9169312459535, 5544.500994910478, 5562.0, 5564.55483561306, 5568.777248909998], "value": 4226.422736618525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8568979049088, 768.1128296817178, 768.1857231334785, 777.5567926282018, 787.8621241282776, 14323.570292891216, 14984.850151498467, 15015.92492037541, 15070.362686529854, 15112.47106351278, 14364.353604087815, 14493.710125797477, 14531.854681453182, 14545.054571452874, 15160.317785699643, 686.0326939015988, 812.6302532347783, 830.3564737328559, 831.4886344897875, 831.7504748575403, 769.6267310354474, 800.0998876264202, 803.2890891560982, 804.4328748232512, 804.5856383962264, 861.5950503263456, 865.9478733338992, 867.7657032601194, 868.274990383031, 868.3096937934325, 704.7040243097911, 838.9286910612606, 865.9870101948476, 867.509856930832, 867.9609417576224, 622.421148332051, 630.5176539946945, 630.8359826445158, 630.8580569371901, 631.251966419794, 14718.484853030199, 14780.63048423798, 14790.96463247573, 14850.0, 14864.182469964147, 14057.297135143202, 14273.785893211507, 14423.49517766873, 14757.631059223499, 14844.406223751037, 13338.19970801755, 13410.396532156077, 13549.458021679122, 13753.449862005507, 14051.43794248229, 4447.911041779179, 4470.26240670289, 4558.316252562109, 4678.0, 4683.555062269079, 78720.60639696821, 79299.0, 79561.60219198867, 80113.0, 82596.58701706454, 11433.256838305484, 11437.59968401102, 11531.443499416657, 11608.76782464346, 11871.881281187078, 21738.239161629266, 21883.234086806886, 21888.23391181301, 21928.342149735534, 22306.0, 8038.276555109951, 8216.958915205385, 8246.83506329882, 8494.447860889146, 8886.911130888608, 4721.787519561628, 4787.18617834962, 4788.11419887322, 4898.951010489849, 4906.509349065065, 3470.6355832637714, 3600.3879340512176, 3602.2615363850346, 3605.1167463971497, 3607.1703508193264, 636.6275728698763, 651.342144434125, 657.1850904878013, 658.1148355461896, 660.4089340040733, 559.3679142568872, 649.3182158733406, 671.0839703804272, 725.2421219825295, 732.8680837449203, 9774.571325792449, 9910.504474776233, 10078.344907580984, 10245.129164021142, 10331.586736530455, 706.9222385537587, 733.8238822682517, 741.9666115024837, 770.1489853711568, 779.8869163971192, 4653.906921861611, 4722.574968252874, 4731.716097034189, 4871.050145221648, 4887.877803054952, 114964.0, 115835.0, 118229.0, 119761.40119299348, 119986.0, 103498.48250758697, 103572.48213758883, 105057.47471262747, 105145.47427262968, 105988.0, 88596.5570172145, 91156.54421727848, 93800.0, 94043.0, 94562.0, 9718.007808399403, 9752.659996823986, 9765.819631290484, 9820.17574412615, 9826.705198844045, 50376.244356333955, 50797.0, 51028.0, 51030.74484627553, 52761.47238527566, 76025.0, 77518.2248177511, 77588.0, 78490.0, 80037.0, 11784.941075294568, 12034.819477707666, 12165.0, 12296.81554776697, 12883.871161288642, 13972.510962116277, 14012.299385030912, 14043.648908777363, 14474.493392731203, 14621.707565848836, 11434.256773309708, 11979.820302695642, 11985.28088314704, 12164.148509604243, 12438.937805310916, 12847.807282890577, 12919.418626162033, 13022.218666880017, 13216.801747973981, 13834.100783449043, 13553.322333883068, 13965.231912244517, 14068.648283792578, 14429.567112986628, 14745.26273686333, 11146.219764616724, 11148.163887708617, 11339.773204536028, 11406.600768973047, 11905.940470297593, 11783.410829458664, 12139.939300303795, 12233.266004039786, 12566.623001309976, 12632.2420654761], "value": 7671.533132978403, "unit": "score"}], "name": "dromaeo_css", "value": 7256.6333800957, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 109.0, 109.0, 111.0, 108.0, 109.0, 110.0, 108.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 129.0, 177.0, 128.0, 128.0, 165.0, 134.0, 182.0, 126.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 122.0, 75.0, 76.0, 74.0, 75.0, 104.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 110.0, 84.0, 84.0, 85.0, 113.0, 85.0, 84.0, 125.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 118.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": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 54.0, 54.0, 53.0, 54.0, 55.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 82.0, 82.0, 80.0, 87.0, 90.0, 84.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 128.0, 129.0, 124.0, 133.0, 120.0, 124.0, 144.0, 127.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 165.0, 162.0, 163.0, 163.0, 169.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 62.0, 63.0, 69.0, 64.0, 63.0, 62.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1503.6, "alertThreshold": 2.0}]} 10:24:55 INFO - Return code: 0 10:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:24:55 INFO - # TBPL SUCCESS # 10:24:55 INFO - Running post-action listener: _resource_record_post_action 10:24:55 INFO - ##### 10:24:55 INFO - ##### Finished run-tests step (success) 10:24:55 INFO - ##### 10:24:55 INFO - Running post-run listener: _resource_record_post_run 10:24:55 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557830144; Read time: 8; Write time: 493028 10:24:55 INFO - TinderboxPrint: CPU usage
13.2% 10:24:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:24:55 INFO - TinderboxPrint: I/O write bytes / time
557,830,144 / 493,028 10:24:55 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 10:24:55 INFO - TinderboxPrint: CPU user
1,211.7 (12.7%) 10:24:55 INFO - TinderboxPrint: Swap in / out
0 / 0 10:24:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267862016; Read time: 0; Write time: 254788 10:24:55 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289968128; Read time: 8; Write time: 238240 10:24:55 INFO - Running post-run listener: _upload_blobber_files 10:24:55 INFO - Blob upload gear active. 10:24:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:59 INFO - (blobuploader) - INFO - Done attempting. 10:24:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:24:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:00 INFO - (blobuploader) - INFO - Done attempting. 10:25:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:01 INFO - (blobuploader) - INFO - Done attempting. 10:25:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:01 INFO - Return code: 0 10:25:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2bbcb2ce418af5d0e03bf978b405eb51ebf3d60f81ce764e55f29436a5ac83b8d1c28e43df7c4780eabe315e9d8cd864f1998801947668dfd691fb7b9f1e796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8169cff2b5fe6f9006f63254c172cc2c5fd1d18db4186337ac2a69a49aca6d4e2351b37dd174b8a5f51a686254eb4b494551d5071eeb423206733dc72ef48b9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21b3d6f2110a153e4f64f05e2a0e4d8a2e8ec158b23cb3518a3ba2c04d0c4e33cbef958129ab69130c3c5861f7786bf31baae3bd9093345e2d1ceaa26a7f6f96"} 10:25:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:01 INFO - Contents: 10:25:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2bbcb2ce418af5d0e03bf978b405eb51ebf3d60f81ce764e55f29436a5ac83b8d1c28e43df7c4780eabe315e9d8cd864f1998801947668dfd691fb7b9f1e796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8169cff2b5fe6f9006f63254c172cc2c5fd1d18db4186337ac2a69a49aca6d4e2351b37dd174b8a5f51a686254eb4b494551d5071eeb423206733dc72ef48b9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21b3d6f2110a153e4f64f05e2a0e4d8a2e8ec158b23cb3518a3ba2c04d0c4e33cbef958129ab69130c3c5861f7786bf31baae3bd9093345e2d1ceaa26a7f6f96"} 10:25:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:01 INFO - Copying logs to upload dir... 10:25:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.820523 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-24 10:25:00.992873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:25:00.997708) ========= 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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 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/c2bbcb2ce418af5d0e03bf978b405eb51ebf3d60f81ce764e55f29436a5ac83b8d1c28e43df7c4780eabe315e9d8cd864f1998801947668dfd691fb7b9f1e796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8169cff2b5fe6f9006f63254c172cc2c5fd1d18db4186337ac2a69a49aca6d4e2351b37dd174b8a5f51a686254eb4b494551d5071eeb423206733dc72ef48b9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21b3d6f2110a153e4f64f05e2a0e4d8a2e8ec158b23cb3518a3ba2c04d0c4e33cbef958129ab69130c3c5861f7786bf31baae3bd9093345e2d1ceaa26a7f6f96"} build_url:https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/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/c2bbcb2ce418af5d0e03bf978b405eb51ebf3d60f81ce764e55f29436a5ac83b8d1c28e43df7c4780eabe315e9d8cd864f1998801947668dfd691fb7b9f1e796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8169cff2b5fe6f9006f63254c172cc2c5fd1d18db4186337ac2a69a49aca6d4e2351b37dd174b8a5f51a686254eb4b494551d5071eeb423206733dc72ef48b9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21b3d6f2110a153e4f64f05e2a0e4d8a2e8ec158b23cb3518a3ba2c04d0c4e33cbef958129ab69130c3c5861f7786bf31baae3bd9093345e2d1ceaa26a7f6f96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:25:01.026644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:25:01.027051) ========= 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=32c5991c409366f7fec8a718000001d2-1466787861.833164-143337660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:25:01.106178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:25:01.109591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:25:01.109882) ========= ========= Total master_lag: 0.19 =========