builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0032 starttime: 1462629146.4 results: success (0) buildid: 20160507050149 builduid: 7aff6ce9d7944ec0a8359b19e03ec161 revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:26.401246) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:26.401675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:26.401938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:26.467944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:26.468219) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-07 06:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2016-05-07 06:52:27 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.640816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:27.125661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:27.125931) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:27.174324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:27.174612) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-07 06:52:27,246 truncating revision to first 12 chars 2016-05-07 06:52:27,246 Setting DEBUG logging. 2016-05-07 06:52:27,246 attempt 1/10 2016-05-07 06:52:27,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bae525a694e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 06:52:27,832 unpacking tar archive at: mozilla-central-bae525a694e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:28.027535) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:28.027792) ========= script_repo_revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:28.028165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:28.028425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 06:52:28.042554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-05-07 06:52:28.042823) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:52:28 INFO - MultiFileLogger online at 20160507 06:52:28 in /builds/slave/test 06:52:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:52:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:52:28 INFO - {'append_to_log': False, 06:52:28 INFO - 'base_work_dir': '/builds/slave/test', 06:52:28 INFO - 'blob_upload_branch': 'Firefox', 06:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:52:28 INFO - 'branch': 'Firefox', 06:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:28 INFO - 'config_files': ('talos/mac_config.py',), 06:52:28 INFO - 'default_actions': ('clobber', 06:52:28 INFO - 'read-buildbot-config', 06:52:28 INFO - 'download-and-extract', 06:52:28 INFO - 'populate-webroot', 06:52:28 INFO - 'create-virtualenv', 06:52:28 INFO - 'install', 06:52:28 INFO - 'run-tests'), 06:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:28 INFO - 'download_minidump_stackwalk': True, 06:52:28 INFO - 'download_symbols': 'ondemand', 06:52:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:28 INFO - 'installer_path': 'installer.exe', 06:52:28 INFO - 'log_level': 'info', 06:52:28 INFO - 'log_name': 'talos', 06:52:28 INFO - 'log_to_console': True, 06:52:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:52:28 INFO - 'opt_config_files': (), 06:52:28 INFO - 'pip_index': False, 06:52:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:52:28 INFO - 'cmd': ('bash', 06:52:28 INFO - '-c', 06:52:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:52:28 INFO - 'enabled': True, 06:52:28 INFO - 'halt_on_failure': False, 06:52:28 INFO - 'name': 'check_screen_resolution'},), 06:52:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:52:28 INFO - 'cmd': ('bash', 06:52:28 INFO - '-c', 06:52:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:52:28 INFO - 'enabled': True, 06:52:28 INFO - 'halt_on_failure': False, 06:52:28 INFO - 'name': 'check_screen_resolution'},), 06:52:28 INFO - 'run_cmd_checks_enabled': True, 06:52:28 INFO - 'sps_profile': False, 06:52:28 INFO - 'sps_profile_interval': 0, 06:52:28 INFO - 'suite': 'dromaeojs-e10s', 06:52:28 INFO - 'system_bits': '32', 06:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:28 INFO - 'title': 't-yosemite-r7-0032', 06:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:28 INFO - 'use_talos_json': True, 06:52:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:28 INFO - 'work_dir': 'build'} 06:52:28 INFO - ##### 06:52:28 INFO - ##### Running clobber step. 06:52:28 INFO - ##### 06:52:28 INFO - Running pre-action listener: _resource_record_pre_action 06:52:28 INFO - Running main action method: clobber 06:52:28 INFO - rmtree: /builds/slave/test/build 06:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:52:30 INFO - Running post-action listener: _resource_record_post_action 06:52:30 INFO - ##### 06:52:30 INFO - ##### Finished clobber step (success) 06:52:30 INFO - ##### 06:52:30 INFO - ##### 06:52:30 INFO - ##### Running read-buildbot-config step. 06:52:30 INFO - ##### 06:52:30 INFO - Running pre-action listener: _resource_record_pre_action 06:52:30 INFO - Running main action method: read_buildbot_config 06:52:30 INFO - Using buildbot properties: 06:52:30 INFO - { 06:52:30 INFO - "project": "", 06:52:30 INFO - "product": "firefox", 06:52:30 INFO - "script_repo_revision": "production", 06:52:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:52:30 INFO - "repository": "", 06:52:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:52:30 INFO - "buildid": "20160507050149", 06:52:30 INFO - "pgo_build": "False", 06:52:30 INFO - "basedir": "/builds/slave/test", 06:52:30 INFO - "buildnumber": 2, 06:52:30 INFO - "slavename": "t-yosemite-r7-0032", 06:52:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:52:30 INFO - "platform": "yosemite_r7", 06:52:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:52:30 INFO - "branch": "mozilla-central", 06:52:30 INFO - "repo_path": "mozilla-central", 06:52:30 INFO - "revision": "bae525a694e2dc0aa433885be8751330d4995a49", 06:52:30 INFO - "stage_platform": "macosx64", 06:52:30 INFO - "builduid": "7aff6ce9d7944ec0a8359b19e03ec161", 06:52:30 INFO - "slavebuilddir": "test" 06:52:30 INFO - } 06:52:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:52:30 INFO - Running post-action listener: _resource_record_post_action 06:52:30 INFO - ##### 06:52:30 INFO - ##### Finished read-buildbot-config step (success) 06:52:30 INFO - ##### 06:52:30 INFO - ##### 06:52:30 INFO - ##### Running download-and-extract step. 06:52:30 INFO - ##### 06:52:30 INFO - Running pre-action listener: _resource_record_pre_action 06:52:30 INFO - Running main action method: download_and_extract 06:52:30 INFO - mkdir: /builds/slave/test/build/tests 06:52:30 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')]} 06:52:30 INFO - https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 06:52:39 INFO - Downloaded 1199 bytes. 06:52:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:52:39 INFO - Using the following test package requirements: 06:52:39 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:52:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:52:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:52:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'jsshell-mac.zip'], 06:52:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:52:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:52:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:52:39 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:52:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:52:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:52:39 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:52:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:52: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')]} 06:52:39 INFO - https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:52:47 INFO - Downloaded 18145054 bytes. 06:52:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:52:50 INFO - Return code: 0 06:52:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:52: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')]} 06:52:50 INFO - https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:52:58 INFO - Downloaded 18145054 bytes. 06:52:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:52:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:53:02 INFO - Return code: 0 06:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:02 INFO - https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:53:03 INFO - Downloaded 10840152 bytes. 06:53:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:53:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:53:03 INFO - Return code: 0 06:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:03 INFO - https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 06:53:07 INFO - Downloaded 110449596 bytes. 06:53:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:53:07 INFO - mkdir: /builds/slave/test/properties 06:53:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:53:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:53:07 INFO - Contents: 06:53:07 INFO - build_url:https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:53:08 INFO - Running post-action listener: _resource_record_post_action 06:53:08 INFO - Running post-action listener: set_extra_try_arguments 06:53:08 INFO - ##### 06:53:08 INFO - ##### Finished download-and-extract step (success) 06:53:08 INFO - ##### 06:53:08 INFO - ##### 06:53:08 INFO - ##### Running populate-webroot step. 06:53:08 INFO - ##### 06:53:08 INFO - Running pre-action listener: _resource_record_pre_action 06:53:08 INFO - Running main action method: populate_webroot 06:53:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:53:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:53:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:53:08 INFO - '--tppagecycles', 06:53:08 INFO - '7'], 06:53:08 INFO - 'tests': ['tsvgm']}}, 06:53:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:53:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:53:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:53:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:53:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['damp', 'tps']}, 06:53:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'tests': ['damp', 'tps']}, 06:53:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['dromaeo_dom']}, 06:53:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:53:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'other-e10s': {'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['a11yr', 06:53:08 INFO - 'ts_paint', 06:53:08 INFO - 'tpaint', 06:53:08 INFO - 'sessionrestore', 06:53:08 INFO - 'sessionrestore_no_auto_restore', 06:53:08 INFO - 'tabpaint']}, 06:53:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['tsvgx', 06:53:08 INFO - 'tsvgr_opacity', 06:53:08 INFO - 'tart', 06:53:08 INFO - 'tscrollx', 06:53:08 INFO - 'cart']}, 06:53:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:53:08 INFO - 'tsvgr_opacity', 06:53:08 INFO - 'tart', 06:53:08 INFO - 'tscrollx', 06:53:08 INFO - 'cart']}, 06:53:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'talos_options': ['--disable-e10s'], 06:53:08 INFO - 'tests': ['tp5o']}, 06:53:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'tests': ['tp5o']}, 06:53:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'talos_options': ['--disable-e10s', 06:53:08 INFO - '--xperf_path', 06:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:08 INFO - 'tests': ['tp5n']}, 06:53:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:08 INFO - 'talos_options': ['--xperf_path', 06:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:08 INFO - 'tests': ['tp5n']}}, 06:53:08 INFO - 'talos.zip': {'path': '', 06:53:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:53:08 INFO - Running post-action listener: _resource_record_post_action 06:53:08 INFO - ##### 06:53:08 INFO - ##### Finished populate-webroot step (success) 06:53:08 INFO - ##### 06:53:08 INFO - ##### 06:53:08 INFO - ##### Running create-virtualenv step. 06:53:08 INFO - ##### 06:53:08 INFO - Running pre-action listener: _resource_record_pre_action 06:53:08 INFO - Running main action method: create_virtualenv 06:53:08 INFO - Creating virtualenv /builds/slave/test/build/venv 06:53:08 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 06:53:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:53:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:53:08 INFO - Using real prefix '/tools/python27' 06:53:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:53:08 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:11 INFO - Installing pip.................done. 06:53:11 INFO - Return code: 0 06:53:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:11 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 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:11 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 06:53:11 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 06:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:11 INFO - 'HOME': '/Users/cltbld', 06:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:11 INFO - 'LOGNAME': 'cltbld', 06:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:11 INFO - 'MOZ_NO_REMOTE': '1', 06:53:11 INFO - 'NO_EM_RESTART': '1', 06:53:11 INFO - 'PAGER': '/bin/cat', 06:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:11 INFO - 'PWD': '/builds/slave/test', 06:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:11 INFO - 'SHELL': '/bin/bash', 06:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:11 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:11 INFO - 'USER': 'cltbld', 06:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:11 INFO - 'XPC_FLAGS': '0x0', 06:53:11 INFO - 'XPC_SERVICE_NAME': '0', 06:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:11 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 06:53:11 INFO - Cleaning up... 06:53:12 INFO - Return code: 0 06:53:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:53:12 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')]} 06:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:12 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')]} 06:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:12 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:12 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>=0.7.1'] in /builds/slave/test/build 06:53:12 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>=0.7.1 06:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:12 INFO - 'HOME': '/Users/cltbld', 06:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:12 INFO - 'LOGNAME': 'cltbld', 06:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:12 INFO - 'MOZ_NO_REMOTE': '1', 06:53:12 INFO - 'NO_EM_RESTART': '1', 06:53:12 INFO - 'PAGER': '/bin/cat', 06:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:12 INFO - 'PWD': '/builds/slave/test', 06:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:12 INFO - 'SHELL': '/bin/bash', 06:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:12 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:12 INFO - 'USER': 'cltbld', 06:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:12 INFO - 'XPC_FLAGS': '0x0', 06:53:12 INFO - 'XPC_SERVICE_NAME': '0', 06:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:12 INFO - Downloading/unpacking psutil>=0.7.1 06:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:15 INFO - Installing collected packages: psutil 06:53:15 INFO - Running setup.py install for psutil 06:53:15 INFO - building 'psutil._psutil_osx' extension 06:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:53:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:53:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:53:16 INFO - building 'psutil._psutil_posix' extension 06:53:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:53:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:53:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:53:16 INFO - ^ 06:53:16 INFO - 1 warning generated. 06:53:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:16 INFO - Successfully installed psutil 06:53:16 INFO - Cleaning up... 06:53:16 INFO - Return code: 0 06:53:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:53:16 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')]} 06:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:16 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')]} 06:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:16 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:16 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.0.0'] in /builds/slave/test/build 06:53:16 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.0.0 06:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:16 INFO - 'HOME': '/Users/cltbld', 06:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:16 INFO - 'LOGNAME': 'cltbld', 06:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:16 INFO - 'MOZ_NO_REMOTE': '1', 06:53:16 INFO - 'NO_EM_RESTART': '1', 06:53:16 INFO - 'PAGER': '/bin/cat', 06:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:16 INFO - 'PWD': '/builds/slave/test', 06:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:16 INFO - 'SHELL': '/bin/bash', 06:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:16 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:16 INFO - 'USER': 'cltbld', 06:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:16 INFO - 'XPC_FLAGS': '0x0', 06:53:16 INFO - 'XPC_SERVICE_NAME': '0', 06:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:53:19 INFO - Installing collected packages: mozsystemmonitor 06:53:19 INFO - Running setup.py install for mozsystemmonitor 06:53:19 INFO - Successfully installed mozsystemmonitor 06:53:19 INFO - Cleaning up... 06:53:19 INFO - Return code: 0 06:53:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:19 INFO - 'HOME': '/Users/cltbld', 06:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:19 INFO - 'LOGNAME': 'cltbld', 06:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:19 INFO - 'MOZ_NO_REMOTE': '1', 06:53:19 INFO - 'NO_EM_RESTART': '1', 06:53:19 INFO - 'PAGER': '/bin/cat', 06:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:19 INFO - 'PWD': '/builds/slave/test', 06:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:19 INFO - 'SHELL': '/bin/bash', 06:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:19 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:19 INFO - 'USER': 'cltbld', 06:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:19 INFO - 'XPC_FLAGS': '0x0', 06:53:19 INFO - 'XPC_SERVICE_NAME': '0', 06:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:19 INFO - Downloading/unpacking blobuploader==1.2.4 06:53:19 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 06:53:19 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 06:53:19 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 06:53:19 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 06:53:19 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 06:53:19 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 06:53:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:53:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:53:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:22 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 06:53:23 INFO - Downloading docopt-0.6.1.tar.gz 06:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:53:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:53:23 INFO - Running setup.py install for blobuploader 06:53:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:53:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:53:23 INFO - Running setup.py install for requests 06:53:24 INFO - Running setup.py install for docopt 06:53:24 INFO - Successfully installed blobuploader requests docopt 06:53:24 INFO - Cleaning up... 06:53:24 INFO - Return code: 0 06:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:24 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 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:24 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 06:53:24 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 06:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:24 INFO - 'HOME': '/Users/cltbld', 06:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:24 INFO - 'LOGNAME': 'cltbld', 06:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:24 INFO - 'MOZ_NO_REMOTE': '1', 06:53:24 INFO - 'NO_EM_RESTART': '1', 06:53:24 INFO - 'PAGER': '/bin/cat', 06:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:24 INFO - 'PWD': '/builds/slave/test', 06:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:24 INFO - 'SHELL': '/bin/bash', 06:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:24 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:24 INFO - 'USER': 'cltbld', 06:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:24 INFO - 'XPC_FLAGS': '0x0', 06:53:24 INFO - 'XPC_SERVICE_NAME': '0', 06:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_yxVK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Zv8sta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-MOesrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-29RbWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-QsiGMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-r2RH6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Sma9TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ok3wkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qcysov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EGbJQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pjJtNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-v7HqMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Uhy3j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LGDA6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xMz9kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3dcA8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-K1Q2gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:53:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:53:26 INFO - Running setup.py install for manifestparser 06:53:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:53:26 INFO - Running setup.py install for mozcrash 06:53:26 INFO - Running setup.py install for mozdebug 06:53:26 INFO - Running setup.py install for mozdevice 06:53:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:53:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Running setup.py install for mozfile 06:53:27 INFO - Running setup.py install for mozhttpd 06:53:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Running setup.py install for mozinfo 06:53:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Running setup.py install for mozInstall 06:53:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Running setup.py install for mozleak 06:53:27 INFO - Running setup.py install for mozlog 06:53:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:53:27 INFO - Running setup.py install for moznetwork 06:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Running setup.py install for mozprocess 06:53:28 INFO - Running setup.py install for mozprofile 06:53:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Running setup.py install for mozrunner 06:53:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Running setup.py install for mozscreenshot 06:53:28 INFO - Running setup.py install for moztest 06:53:28 INFO - Running setup.py install for mozversion 06:53:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:53:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:53:28 INFO - Cleaning up... 06:53:28 INFO - Return code: 0 06:53:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53:28 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')]} 06:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 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')]} 06:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 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 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:28 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 06:53:28 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 06:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:28 INFO - 'HOME': '/Users/cltbld', 06:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:28 INFO - 'LOGNAME': 'cltbld', 06:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:28 INFO - 'MOZ_NO_REMOTE': '1', 06:53:28 INFO - 'NO_EM_RESTART': '1', 06:53:28 INFO - 'PAGER': '/bin/cat', 06:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:28 INFO - 'PWD': '/builds/slave/test', 06:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:28 INFO - 'SHELL': '/bin/bash', 06:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:28 INFO - 'USER': 'cltbld', 06:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:28 INFO - 'XPC_FLAGS': '0x0', 06:53:28 INFO - 'XPC_SERVICE_NAME': '0', 06:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2lv0T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-JHL40A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4mK_Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-miXgM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ExYuii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-XWii2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CPE6WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:53:29 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)) 06:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-N__klz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-n4ffbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-flT9aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bzq5ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PBsHXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5g8ajF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kQRTLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-eOc8y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_SlH9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:53:30 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)) 06:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-svpKPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:53:31 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)) 06:53:31 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)) 06:53:31 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)) 06:53:31 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)) 06:53:31 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)) 06:53:31 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)) 06:53:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:33 INFO - Downloading blessings-1.6.tar.gz 06:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:33 INFO - Installing collected packages: blessings 06:53:33 INFO - Running setup.py install for blessings 06:53:34 INFO - Successfully installed blessings 06:53:34 INFO - Cleaning up... 06:53:34 INFO - Return code: 0 06:53:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:53:34 INFO - Reading from file tmpfile_stdout 06:53:34 INFO - Current package versions: 06:53:34 INFO - blessings == 1.6 06:53:34 INFO - blobuploader == 1.2.4 06:53:34 INFO - docopt == 0.6.1 06:53:34 INFO - manifestparser == 1.1 06:53:34 INFO - mozInstall == 1.12 06:53:34 INFO - mozcrash == 0.17 06:53:34 INFO - mozdebug == 0.1 06:53:34 INFO - mozdevice == 0.48 06:53:34 INFO - mozfile == 1.2 06:53:34 INFO - mozhttpd == 0.7 06:53:34 INFO - mozinfo == 0.9 06:53:34 INFO - mozleak == 0.1 06:53:34 INFO - mozlog == 3.1 06:53:34 INFO - moznetwork == 0.27 06:53:34 INFO - mozprocess == 0.22 06:53:34 INFO - mozprofile == 0.28 06:53:34 INFO - mozrunner == 6.11 06:53:34 INFO - mozscreenshot == 0.1 06:53:34 INFO - mozsystemmonitor == 0.0 06:53:34 INFO - moztest == 0.7 06:53:34 INFO - mozversion == 1.4 06:53:34 INFO - psutil == 3.1.1 06:53:34 INFO - requests == 1.2.3 06:53:34 INFO - wsgiref == 0.1.2 06:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:34 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 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:34 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 06:53:34 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 06:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:34 INFO - 'HOME': '/Users/cltbld', 06:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:34 INFO - 'LOGNAME': 'cltbld', 06:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:34 INFO - 'MOZ_NO_REMOTE': '1', 06:53:34 INFO - 'NO_EM_RESTART': '1', 06:53:34 INFO - 'PAGER': '/bin/cat', 06:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:34 INFO - 'PWD': '/builds/slave/test', 06:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:34 INFO - 'SHELL': '/bin/bash', 06:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:34 INFO - 'USER': 'cltbld', 06:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:34 INFO - 'XPC_FLAGS': '0x0', 06:53:34 INFO - 'XPC_SERVICE_NAME': '0', 06:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 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)) 06:53:34 INFO - Cleaning up... 06:53:34 INFO - Return code: 0 06:53:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:34 INFO - 'HOME': '/Users/cltbld', 06:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:34 INFO - 'LOGNAME': 'cltbld', 06:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:34 INFO - 'MOZ_NO_REMOTE': '1', 06:53:34 INFO - 'NO_EM_RESTART': '1', 06:53:34 INFO - 'PAGER': '/bin/cat', 06:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:34 INFO - 'PWD': '/builds/slave/test', 06:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:34 INFO - 'SHELL': '/bin/bash', 06:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:34 INFO - 'USER': 'cltbld', 06:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:34 INFO - 'XPC_FLAGS': '0x0', 06:53:34 INFO - 'XPC_SERVICE_NAME': '0', 06:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:34 INFO - Downloading/unpacking jsonschema 06:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:53:37 INFO - Downloading/unpacking functools32 (from jsonschema) 06:53:37 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 06:53:37 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 06:53:37 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 06:53:37 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 06:53:37 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 06:53:37 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 06:53:37 INFO - Downloading functools32-3.2.3-2.tar.gz 06:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:53:37 INFO - warning: no files found matching '*.txt' 06:53:37 INFO - no previously-included directories found matching 'build' 06:53:37 INFO - no previously-included directories found matching 'dist' 06:53:37 INFO - no previously-included directories found matching '.git*' 06:53:37 INFO - Installing collected packages: jsonschema, functools32 06:53:37 INFO - Running setup.py install for functools32 06:53:37 INFO - warning: no files found matching '*.txt' 06:53:37 INFO - no previously-included directories found matching 'build' 06:53:37 INFO - no previously-included directories found matching 'dist' 06:53:37 INFO - no previously-included directories found matching '.git*' 06:53:37 INFO - Successfully installed jsonschema functools32 06:53:37 INFO - Cleaning up... 06:53:38 INFO - Return code: 0 06:53:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c19570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ac60270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:38 INFO - 'HOME': '/Users/cltbld', 06:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:38 INFO - 'LOGNAME': 'cltbld', 06:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:38 INFO - 'MOZ_NO_REMOTE': '1', 06:53:38 INFO - 'NO_EM_RESTART': '1', 06:53:38 INFO - 'PAGER': '/bin/cat', 06:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:38 INFO - 'PWD': '/builds/slave/test', 06:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:38 INFO - 'SHELL': '/bin/bash', 06:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:53:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:38 INFO - 'USER': 'cltbld', 06:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:38 INFO - 'XPC_FLAGS': '0x0', 06:53:38 INFO - 'XPC_SERVICE_NAME': '0', 06:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:38 INFO - Downloading/unpacking flake8 06:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:53:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:53:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:42 INFO - no previously-included directories found matching 'docs/_build' 06:53:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:53:42 INFO - Running setup.py install for pep8 06:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:42 INFO - no previously-included directories found matching 'docs/_build' 06:53:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:53:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:53:42 INFO - Cleaning up... 06:53:42 INFO - Return code: 0 06:53:42 INFO - Running post-action listener: _resource_record_post_action 06:53:42 INFO - Running post-action listener: _start_resource_monitoring 06:53:42 INFO - Starting resource monitoring. 06:53:42 INFO - ##### 06:53:42 INFO - ##### Finished create-virtualenv step (success) 06:53:42 INFO - ##### 06:53:42 INFO - ##### 06:53:42 INFO - ##### Running install step. 06:53:42 INFO - ##### 06:53:42 INFO - Running pre-action listener: _resource_record_pre_action 06:53:42 INFO - Running main action method: install 06:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:53:42 INFO - Reading from file tmpfile_stdout 06:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:53:42 INFO - Reading from file tmpfile_stdout 06:53:42 INFO - Output received: 06:53:42 INFO - Usage: mozinstall [options] installer 06:53:42 INFO - Options: 06:53:42 INFO - -h, --help show this help message and exit 06:53:42 INFO - -d DEST, --destination=DEST 06:53:42 INFO - Directory to install application into. [default: 06:53:42 INFO - "/builds/slave/test"] 06:53:42 INFO - --app=APP Application being installed. [default: firefox] 06:53:42 INFO - mkdir: /builds/slave/test/build/application 06:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:54:16 INFO - Reading from file tmpfile_stdout 06:54:16 INFO - Output received: 06:54:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:54:16 INFO - Running post-action listener: _resource_record_post_action 06:54:16 INFO - ##### 06:54:16 INFO - ##### Finished install step (success) 06:54:16 INFO - ##### 06:54:16 INFO - ##### 06:54:16 INFO - ##### Running run-tests step. 06:54:16 INFO - ##### 06:54:16 INFO - Running pre-action listener: _resource_record_pre_action 06:54:16 INFO - Running main action method: run_tests 06:54:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:54:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:54:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:54:16 INFO - 2016-05-07 06:54:16.589 screenresolution[1984:12452] starting screenresolution argv=screenresolution get 06:54:16 INFO - 2016-05-07 06:54:16.592 screenresolution[1984:12452] Display 0: 1600x1200x32@60 06:54:16 INFO - 2016-05-07 06:54:16.598 screenresolution[1985:12454] starting screenresolution argv=screenresolution list 06:54:16 INFO - Available Modes on Display 0 06:54:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:54:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:54:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:54:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:54:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:54:16 INFO - Intel Iris: 06:54:16 INFO - Chipset Model: Intel Iris 06:54:16 INFO - Type: GPU 06:54:16 INFO - Bus: Built-In 06:54:16 INFO - VRAM (Dynamic, Max): 1536 MB 06:54:16 INFO - Vendor: Intel (0x8086) 06:54:16 INFO - Device ID: 0x0a2e 06:54:16 INFO - Revision ID: 0x0009 06:54:16 INFO - Displays: 06:54:16 INFO - Display: 06:54:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:54:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:54:16 INFO - Display Serial Number: 1600x1200 60 06:54:16 INFO - Main Display: Yes 06:54:16 INFO - Mirror: Off 06:54:16 INFO - Online: Yes 06:54:16 INFO - Rotation: Supported 06:54:16 INFO - Return code: 0 06:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:54:16 INFO - Python 2.7.3 06:54:16 INFO - Return code: 0 06:54:16 INFO - grabbing minidump binary from tooltool 06:54:16 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')]} 06:54:16 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7d30>, '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 0x1088dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108aaeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:54:16 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:54:16 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:54:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:16 INFO - Return code: 0 06:54:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:54:18 INFO - Return code: 0 06:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:54:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FiBQfF9pIX/Render', 06:54:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:18 INFO - 'HOME': '/Users/cltbld', 06:54:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:18 INFO - 'LOGNAME': 'cltbld', 06:54:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:54:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:18 INFO - 'MOZ_NO_REMOTE': '1', 06:54:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:54:18 INFO - 'NO_EM_RESTART': '1', 06:54:18 INFO - 'PAGER': '/bin/cat', 06:54:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:18 INFO - 'PWD': '/builds/slave/test', 06:54:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:54:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:18 INFO - 'SHELL': '/bin/bash', 06:54:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners', 06:54:18 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 06:54:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:18 INFO - 'USER': 'cltbld', 06:54:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:18 INFO - 'XPC_FLAGS': '0x0', 06:54:18 INFO - 'XPC_SERVICE_NAME': '0', 06:54:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:54:18 INFO - mozversion application_buildid: 20160507050149 06:54:18 INFO - mozversion application_changeset: bae525a694e2dc0aa433885be8751330d4995a49 06:54:18 INFO - mozversion application_display_name: Nightly 06:54:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:18 INFO - mozversion application_name: Firefox 06:54:18 INFO - mozversion application_remotingname: firefox 06:54:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:54:18 INFO - mozversion application_vendor: Mozilla 06:54:18 INFO - mozversion application_version: 49.0a1 06:54:18 INFO - mozversion platform_buildid: 20160507050149 06:54:18 INFO - mozversion platform_changeset: bae525a694e2dc0aa433885be8751330d4995a49 06:54:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:54:18 INFO - mozversion platform_version: 49.0a1 06:54:18 INFO - using testdate: 1462629258 06:54:18 INFO - actual date: 1462629258 06:54:18 INFO - starting webserver on 'localhost:49393' 06:54:18 INFO - SUITE-START | Running 2 tests 06:54:18 INFO - TEST-START | dromaeo_css 06:54:18 INFO - operating with platform_type : mac_ 06:54:18 INFO - Initialising browser for dromaeo_css test... 06:54:18 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpTXF20V/profile http://localhost:49393/getInfo.html) 06:54:21 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 06:54:21 INFO - PROCESS | 2003 | colorDepth:24 06:54:21 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 06:54:21 INFO - PROCESS | 2003 | __metrics 06:54:21 ERROR - PROCESS | 2003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:54:22 INFO - TEST-INFO | 2003: exit 0 06:54:22 INFO - Browser initialized. 06:54:22 INFO - Running cycle 1/1 for dromaeo_css test... 06:54:22 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpTXF20V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:34 INFO - PROCESS | 2006 | RSS: Main: 249995264 06:54:34 INFO - PROCESS | 2006 | 06:55:23 INFO - PROCESS | 2006 | 1462629323773 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] 06:57:33 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49393/tests/dromaeo/cssquery-ext.html) 06:57:35 INFO - PROCESS | 2006 | RSS: Main: 261914624 06:57:35 INFO - PROCESS | 2006 | 07:00:37 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-ext.html (next: http://localhost:49393/tests/dromaeo/cssquery-jquery.html) 07:00:38 INFO - PROCESS | 2006 | RSS: Main: 273485824 07:00:38 INFO - PROCESS | 2006 | 07:03:40 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49393/tests/dromaeo/cssquery-mootools.html) 07:03:40 INFO - PROCESS | 2006 | RSS: Main: 275353600 07:03:40 INFO - PROCESS | 2006 | 07:06:42 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49393/tests/dromaeo/cssquery-prototype.html) 07:06:43 INFO - PROCESS | 2006 | RSS: Main: 277151744 07:06:43 INFO - PROCESS | 2006 | 07:09:45 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49393/tests/dromaeo/cssquery-yui.html) 07:09:46 INFO - PROCESS | 2006 | RSS: Main: 279969792 07:09:46 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-yui.html (next: http://localhost:49393/tests/dromaeo/cssquery-dojo.html) 07:12:49 INFO - PROCESS | 2006 | RSS: Main: 280997888 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | __start_tp_report 07:12:49 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 07:12:49 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 07:12:49 INFO - PROCESS | 2006 | |i|pagename|runs| 07:12:49 INFO - PROCESS | 2006 | |0;dojo.html;3405.6253812080668;3425.880094196703;3459.3427248822723;3478.930421391573;3490.982545087274;5105.285260063594;5269.7879487717755;5663.207150998864;5675.772969081237;5772.307323121221;5579.218909352694;5673.773049078032;5704.743286552105;5750.7412166452505;5790.913136302959;5100.081985242673;5175.24958880962;5277.498637629419;5303.416624171338;5316.9202461963105;484.52762426662946;5164.173732202848;5188.558972487324;5192.610554208431;5274.05067087924;5149.613778966593;5190.896182076356;5193;5196.168613021917;5251.369835619712;5144.176931690949;5186.870328241786;5208.374995000586;5213.869653258661;5234.685918844882;4005.959940400588;5108.489151084899;5166.405863325728;5194.92207616886;5206.817761378372;4655.790489427984;5541.141123125922;5610.298712660918;5653.123765816305;5700.686462244575;6084.756609735606;6138.1431767337435;6231.9688401557705;6234.407731265523;6257.655828929407;6180.6291622502795;6229.813105606839;6238.313785483593;6242.656653884034;6245.437910588069;5171.586273098105;5902.468777809975;5958.433948774859;5959.940400595982;5990.281166260033;6178.752849885954;6179;6179.567430279927;6293.024581189831;6312.621242725451;6062.818115456544;6103.962326404522;6117.265928088569;6126.969365153146;6133.570650054453;6164.48278790489;6180.907286390708;6184.8763024739255;6219.284782250009;6226.066090086523;6104.572679912452;6122.581127188433;6124.319907527303;6139.109829074849;6175.104609831639;6095.801078121664;6120.60216085953;6218.906716399258;6220.533459990428;6256.749730010749;3868.651821336037;4978.77595508203;4980.157341783563;5007.39911210657;5037.596992240612;4325.286327755948;4396.340548917688;4399.626031787334;4447.73313601185;4511.390962220058;4716.976415117971;5672.517835983987;5714.571407144397;5749.7700091996685;5779.8555036124435;6224.688765561795;6249.531285153632;6253.874922501524;6266.436020758154;6284.183056202664;5598.992181407304;5686.715664216773;5695.060315047971;5702.45826646468;5771.163181338682;5349.973250133725;5352.116900711417;5364.463553644682;5381.461853814665;5386.13821788512;6175.3515880831865;6301.6534090625455;6304.117423560705;6315.242170939425;6324.968375158187;6205.131281620667;6222.222222222223;6237.781677641261;6254.530910181664;6263.09185168139;6348.650824204713;6353.428191462605;6355.713992870239;6362;6369.108324834619;5938.61399009063;6123.038605230386;6230.657313847601;6246.187995560548;6247.781327653511;6167.84580385494;6231.657258850807;6235.75056997715;6259.1550140730415;6260.968695156495;5405.648632838853;6152.507799376129;6167.167432396569;6196.318404975539;6201.658908760061;6024.427679370453;6071.878562428815;6073.757049717962;6156.722947467285;6175;4576.8626941191815;4828.637852161031;5103.87240318995;5911.704414779329;5979.684469416721;5288.65623734456;6104.084387341757;6122.785702500391;6132.724027418688;6146;5874.236349274738;5991.520678345635;6070.2108725865355;6080.726367313393;6084.6349219047 07:12:49 INFO - PROCESS | 2006 | |1;ext.html;488.0750976898777;495.5960891873123;495.8051096856575;540.3758658749144;569.9344575373829;37371.252574948485;40559.39160912585;42834.99999999996;42877.92805179872;42991.57008429915;35114.47328290078;42951.926201844966;43184;43718;43740;9602.519874006306;9694.22446204302;9754.804903901917;9765.658201962933;9781.266405019653;9646.180074693659;9694.757631059209;9703.417794932291;9705.708828735149;9760.219182465422;9757.170640495566;9760.804783904317;9795.971423000588;9797.412155270671;9806.068423499755;8309.709160179365;9725.0761177688;9765.951170244174;9770.413775173476;9796.706098817047;9507.619695212252;9533.570989305497;9558.044195580456;9571.712848614552;9643.90356096437;40124.598754012375;40170.59829401727;40578.39132413016;40597;40843.795781020905;2668.3729323608936;2850.757685596727;2927.956080658792;3371;3404.880829170992;27197.86401068002;27962.3009424764;28079.71920280812;28333.716662833314;28937.421251575062;2641.1284276189003;2659.574468085116;2668.2262143978223;2712.864356782153;2786.9966811947684;403259;440226.9999999968;441790;444754;446587;36007.81996090003;36040.27919441649;36163.27673446569;36168.91493255206;36233.09417264589;37799.62200378016;38046.858594242214;38583.42124868129;39392.409113863316;39549.406758898636;17132.229049692793;17243.827561724473;17258.309667613405;17294.308227671005;17315.04767237814;11059.447027648584;12724.872751272369;13177.275249861157;13189.736205276033;13196.274204918629;20324.390268291976;20447.693284600744;20755.066022029045;20761.961901904844;20846.478838028866;8359.498430094214;8377.115149091527;8437.704680336159;8473.618687159093;8541.871871921927;903.5346796399859;926.8692195521453;981.3277904635347;1073.7705327400083;1100.983485247722;23681.358649663904;28778.136655900358;30041.699583004327;30811.691883080883;30974.380512389627;988.2983082011708;1003.9347442416366;1056.345066059033;1124.224285243196;1248.8126780982743;15014.399424022917;15022.774658380133;15329.616759580877;15390.076595404087;15760.842391576167;593488;631022;632380;637522;640513;61198;62827.6858615704;63319;63449.68275158687;63635.363646362945;1416.3343228682502;1437.583100900748;1453.5929939616924;1457.453454954392;1457.8615031571983;22564.887175564018;29294.7070529292;29342.853285733436;29431.411371772872;29698.960536381124;45539.86150346268;53959.73020134874;54474.727626361615;54518.72740636271;54600.72699636636;545689;562087.1895640496;562204.3779562152;563101;566591;27734.722652773213;27834.721652784025;27868.024619138232;28089.876404943574;28159.71840281571;39865;45339;47371.76314118407;47869.28196076992;48395.5160448391;29716.70283297226;39556.80221598989;39736;40059.799701001306;40459.39310910398;38278.42582361322;38834.6116538831;39222.01944951399;39397.01507462336;39756.801215993735;38308.616913830505;38489.80755096207;38876.6112338873;39236.41145382878;39334.80332598319;33685.83157084199;34167.65832341645;34399;34932.47601285932;35005.824970876005;21268;21925.245980321855;25684.871575642002;25709;25770.613440798028 07:12:49 INFO - PROCESS | 2006 | |2;jquery.html;389.76029741708845;390.6620773031329;392.2468859789206;392.3780807420239;416.5480453707727;20168.69746953797;21002.89498552509;21314.254001109963;21395;22022;20859.478513037142;20934.790652093474;21498.89250553745;21527;21562.676559851614;5844.941550584493;5953.107033944922;5959.433853783905;6072;6110.144579758838;5677.744501497443;5900.970495147519;5997.40025997399;5999.220101386835;6057.636541807506;5747.856303592423;5841.503472204868;5846.9707651461895;5869.2369991901205;5876.265466816648;5608.270924779773;5737.856553586152;5812.534997200235;5813.47678708914;5866.090755932816;4667.809708524304;5112.616553758446;5146.253793199965;5149.3305870237;5154.639175257734;21275.46811329714;25994.87002564994;26032;26216.820243088918;26228.475430491282;2187.475005998549;2210.469487323047;2373.6320870265135;2414.37226321156;2416.782489575929;13109.689031096814;14575.271236438135;15246.085234885832;15369.538913832603;15392.230388480531;1696.9830301697073;1708.709519381708;1720.5698575356162;1735.9913200433916;1738.226489212301;91633.54183229108;122529;124451.3777431116;124931;125626;8961.865572016424;10808.297460665031;11284.71788205285;11573.363465009505;11757.470913808898;14184.361703723358;14233.003689741825;14245.857541424453;14255.429782808571;14258.572242832732;7279.59962202084;8646.178613031752;8748.387612867038;8911.631058673433;9027.684031059012;7343.63281835906;8827.337949653802;8971.910280897238;8998.280137588978;9113.270938324918;6667.6666166691475;6834.624095674686;6863.416609588241;6867.244603093655;6869.141357330333;1612.4034107380344;1614.2574415768643;1843.1060935446299;1909.8376637985648;1911.7228001939918;962.8748262725801;965.9565319560637;981.7202097402206;999.1008092716613;1102.32207192576;16249.025058496292;19391.739536930054;20200.393988180378;21559.24542641;22138;904.6434039327588;974.2985050763439;989.1493315748451;991.5438898106952;1008.7679833638158;9552.42685438876;11437.542498300141;11551.422428878523;11552.711182220512;11595.18833681651;597564.0608984723;608188;621376;624740;625582;116428;120782;121969.39015304866;122164.38917805353;123233.38383308025;1043.0820877627639;1058.539535302146;1095.7315457712912;1105.9668209953713;1116.1963386361806;18030.90984545069;18842.6231475367;19073.046347682837;19079.713804293224;19081.71377429312;51153.488465114875;51262.74368628133;51830.48169518256;52172.73913630407;52563;67742.6451470958;71879;72183.63908180426;74425;79993;5839.591228613956;6718.8320291993095;6878.38094571491;6911.723531058701;7402.444816638881;8821.250193733604;8835.293176545732;8884.244839188483;9273.165415112673;9333.393329433566;7849.5682737447705;8054.275115239657;8083.7170699025255;8218.712345067894;8243.83512329738;7983.962084929154;8161.061477930114;8218.178182181973;8259.710910118118;8325;8314.168583141638;8332.708355207538;8373.455725377831;8452.36607254446;8664.00363958153;12180.695482613006;12547.372631368213;12628.87371126277;12711.936440317739;12839.550615728405;11900.345480998629;12010.699732506757;12124.27254364741;12142.332171730639;12170.817437738264 07:12:49 INFO - PROCESS | 2006 | |3;mootools.html;1594.3303812398794;1615.5557221764016;1653.1734132933534;1866.4214093630976;1952.5313924658087;8115.431919765619;8125.471844330114;8638.611262493187;9157.130072643089;9179.816403671932;8135.22715342043;8753.124687531244;8930.91069089309;8964.686235981742;8974.865377019334;2471.048646271185;2487.6019836826113;2487.7387874273213;2499.7250302466805;2506.2982364937848;2459.053264493165;2508.122157244968;2509.2346834215555;2513.42191296002;2520.6849143857016;2072.585482903418;2451.2156110044793;2458.21337172105;2498.225550079472;2504.373906523369;2444.095684596693;2451.350392146074;2459.827812053157;2463.9137630183036;2470.7776300132896;2439.5730747119183;2448.6939132608422;2455.791257743094;2457.041753716052;2478.6529885816;8865.246454051414;8936.374453788238;8939.821203575957;8954.238889694383;8975.596098175598;5430.5927055471;5576.776928922838;5579.330480342344;5586.91619625706;5590.664560126405;3580.982095089534;3581.4090675038588;3619.149499867529;3646.562412510489;3665.0287673766475;988.9208863290919;1036.8496567997674;1037.2013549566866;1038.6105210546045;1068.417712346773;11686.006689431408;11829.290242585472;11864.169508134433;11869.228500147463;11903.94048029763;4861.854144375674;4895.216765317532;5007.424146223231;5037.5214354636255;5069.695818250917;10088.949555252177;10090.646827361006;10147.695569132939;10160;10161.593536258615;5442.346918369821;5488.862778430571;5500.257465242221;5542.861428464321;5550.056490396642;4536.206163921301;4852.490488498657;4990.700557966534;5008.373953255843;5048.697078175248;4060.837566497366;4063.9796801015805;4072.5927407259037;4102.715757306927;4136.482939632546;1371.9862801372058;1380.9309534523234;1385.2935003148266;1390.8539603341706;1396.5461225101678;863.7970077031893;883.4875772052194;916.6654171227455;946.3328353510758;956.6508224498148;5970.880582388328;6000.579959402888;6069.817905462844;6108.045425463898;6158.507319414436;381.186167532315;403.4372050988913;450.5381983466907;454.10767841192217;459.0909998203576;4021.939670904939;4065.3901914712437;4110.05468742191;4125.546189919107;4126.154138401621;10204.744881377876;10906.400147991937;10969.341839489496;10994.175436842268;11049.28179668335;10609.098226650667;10692.465376731132;10830.296030757976;10915.508802103925;11039.668809935714;8294.502329860228;8324.791880203165;8371.49771013729;8414.873776893352;8470.195331443503;5837.708114594168;5867.503786534407;5878.911816322844;5984.611000284967;6102.4812890902995;7746.651400687096;10131.341462804894;10295.742606434898;10317.896821031694;10355.378677279386;10232.897671023493;10459.477026148814;10497.26519143683;10558.894411056099;10620;6720.764773232913;7090.645467726697;7641.847163056596;7678.61606919663;7846.843063138819;8433.156684331518;8448.746537603882;8448.957755211184;8518.82962340762;8531;6343.841403964938;7379.926200737924;7447.180810110775;7587.861820726936;7658;7295.804091384286;7382.4094072473;7400.814979625552;7410.147832999274;7463.440241981764;7042.647867606497;7087.82280442993;7093.32613401726;7146.464015198777;7150.7497237596435;4636.513166117509;4716.1510928033285;4728.834490792806;4761.571458568606;4887.095887260868;5004.074246264453;5050.520200580939;5080.339555857715;5144.742762861767;5260.815871444481 07:12:49 INFO - PROCESS | 2006 | |4;prototype.html;262.79370694005206;318.9585353903992;323.2145885498238;323.5502651314673;326.4874147588287;5057.620678449117;5104.489551044893;5307.920381194281;5528.723563821813;5613.800133923665;4693.719565488825;4912.7297998610065;5553.500184983351;5560.944390556093;5578.86052848679;3885.397763346679;4086.816093275795;4243.469566304212;4270.97864510677;4282.207791558571;3311.122552523583;3900.941485877714;3905.9804700976456;3919.863239660495;4078.164825828389;3525.7708248963863;3892.773776260469;4212.441396683216;4229.604230603909;4268.317069268917;3641.761800987677;3885.805709714503;4098;4138.193052354792;4277.165952639252;3581.606023337431;3598.676119149289;3602.225521512861;3615.5119058927235;3627.9818600907092;4785.880352991203;4932.309476673268;5343.332083489564;5369.731513424314;5378.542823859977;3879.903002424962;4579.267317229227;4611.907761844778;4837.588804951583;4857.73282469464;5802.5938184327115;5805.5065319447895;5825.417458254183;5828.300603927513;5833.941660583382;3382.4249877520633;3675.981620091909;3987.1626958338784;3988.182422603388;4006.8797936061965;5704.176432665857;5800.100984347433;6158;6209.565330426872;6229.31477537466;3359.8656053758064;3439.9312013759586;4014.2774300625583;4041.595840415935;4059.7970101494807;3805.6765174959883;4099.97950010248;4126.154138401621;4127.690423218271;4129.834806607702;4304.923769057736;4780.378550788375;4798.712077275374;4801.735904525215;4802.471728109905;5182.6372153949615;5518.365387980433;5889.705514724246;5903.881922361528;5932.436418540232;1200.6038007457519;1228.5134986666055;1312.6587087357357;1330.8554643007005;1331.3875617215995;746.1866565443693;867.7136544940155;873.9606717697719;885.6493846883426;912.9726108216764;5153.4073581538605;5162.535371816554;5175.508326708957;5208.947910520847;5263.763015691309;4995.575376093;5017.949820501822;5234.502722241457;5514.751836167382;5699.772009119672;4358.978205108954;4746.264329029006;4898.982834076095;4986.252062190628;5096.827729622208;2647.5896236083436;2779.069011881002;2785.3454438207004;2985.268609190762;3001.2496875781053;5193.480651934852;5708.143778433268;5871.093808564702;6038.516918646497;6050.304215015241;5502.394736578973;5552.7223638817895;5713.428657134336;5933.350989141733;5940.910886336708;5966.746983133504;6067.848303792529;6073.908891366633;6078.957493267105;6081.817545473643;5568.498835104698;5811.244538210006;5812;5830.970845145747;5925.792597259076;5022.924656130088;5525.834224973257;5620.662760234399;5696.892149904396;5704.971475142598;5047.87380315495;5389.056915039931;5733.76724004341;5739.540836733135;5900.498457630978;3259.674032596721;3316.1212278746634;3332.0507503110953;3400.7449441291506;3842.4457376925675;5238.4237733850005;5480.835574932758;6019.4883434908525;6031.306399763907;6086.452219300284;5193.870153246199;5234.916764923366;5877.4122587740885;5880.882382352414;5884.882302353843;4948.177535333499;5280.310300703738;5292.988664307539;5547.389787123332;5800.896520361586;4634.443866736014;5217.399999000012;5464.016477034013;5678.126218348018;5779.913301300399;4933.851984440473;5134.5635620972635;5793.565482588739;5967.492763115184;5975.25309336333;5380.838574842604;5812.866491034208;5825.737841797214;5826.475617194473;5843.357230704534 07:12:49 INFO - PROCESS | 2006 | |5;yui.html;651.504856309205;707.1337611426001;717.9246179151189;721.754603434832;757.5454727163699;14775.335109920052;15130.546083617495;15276.083434993894;15339.616509587266;16147.566373892096;15806.209689515506;16186.919065404656;16277.51167464975;16280.94173878697;16402.83597164028;912.41149458599;913.4108500017485;921.5760750054983;921.940073895198;922.8431166701677;710.3358359933479;720.394868310619;901.1844280925773;902.0438335364502;909.1090731083542;958.1328897347911;962.4946902875976;964.4888209249109;965.4303960663208;967.032967032967;934.2806039349697;953.914147726701;958.988267377916;959.0697023886819;959.1271942532331;624.1511544299749;689.9241083480813;714.9821254468628;717.7918403662932;719.6257945868119;14670.046446980912;14692.632684182981;15052.473163439226;15065.774013389808;15078.924605377013;12254.938725306405;12360.690982725413;12364.134510584263;12366.567170149001;12592.118551701384;9945.75135621608;9953.40537325273;10000.699979000641;10073.194144468425;10148.492575371276;3371.7808342457906;3417.3165366926714;3427.8628854846024;3430.622631510532;3566.233259849145;77090;77449.22550774533;77546.61226693887;77791.61104194443;77795;9276.675316363895;9283.704718038092;9312.115349041831;9559.426434413957;9583.041695830361;20627.8968605156;20910.686339704916;21107.577848443252;21142.894285528782;21169.68245476319;7170.96414517924;7330.7434239802415;7343.1555371133;7368.484206105629;7394.260573942563;3967.2263908537557;4088.7342322748927;4093.85671501496;4094.488188976378;4094.6314831665295;3351.379994700988;3451.361498122855;3452.706519945833;3472.045187573387;3472.409690352646;514.8146667199806;527.6517498451004;558.4499268220799;615.4276522833718;617.561531312773;510.8492994566612;514.1131548079533;520.4613225311784;539.4443722965352;565.5221337969409;6565.573237739532;7552.471327007057;8095.5142691438705;8172.959135204286;8365.1216622255;484.9490803465656;516.9276301317818;533.2907233379595;594.8037147741235;601.1716409410808;3820.6152794901755;3849.749766265184;3970.82131304092;4005.2790497710694;4018.417329487208;81798.59100704458;85949;89200;89611.55194224117;90806.09193908109;75720.02059701312;77903.22096779072;77970.61014694891;78448;78861.60569197117;52753.99999999923;66994;68152;68686.313136869;68835.65582172057;8324.583770811314;8331.458455200393;8371.455855369382;8429.831403372022;8466.91533084686;43960;44161.33757993569;44310.778446107564;44576.55423445854;45061.77469112633;58853;61074.38925610687;61485;61738.38261617506;61920.380796191464;11090.001899829054;11139.33164010162;11146.777064458503;11187.384693841917;11553.916276838165;11901.642950711492;11961.820572691242;11990.40047997614;12263.202891812003;12307.69230769238;11361.54553817838;11562.653120406065;11623.418829058344;11627.186096973131;11827.036070667273;10888.510017049093;11333.546658133911;11611.197219017287;11677.824832627348;11789.115816313639;11200.607978720705;11493.540258389905;11616.825747613624;11617.361045142261;11669.649910502698;9452.527373631154;9671.371360861522;9734.75663108428;9942.850857237292;10209.591616335263;9639.662611808553;9672.613095476103;9688.612455501701;9698.75753106178;9710.70867873965 07:12:49 INFO - PROCESS | 2006 | __end_tp_report 07:12:49 INFO - PROCESS | 2006 | __start_cc_report 07:12:49 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,412 07:12:49 INFO - PROCESS | 2006 | __end_cc_report 07:12:49 INFO - PROCESS | 2006 | __startTimestamp1462630369289__endTimestamp 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | ------- Summary: start ------- 07:12:49 INFO - PROCESS | 2006 | Number of tests: 6 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#0] dojo.html Cycles:165 Average:5656.09 Median:5979.68 stddev:786.90 (13.2%) stddev-sans-first:769.25 07:12:49 INFO - PROCESS | 2006 | Values: 3405.6 3425.9 3459.3 3478.9 3491.0 5105.3 5269.8 5663.2 5675.8 5772.3 5579.2 5673.8 5704.7 5750.7 5790.9 5100.1 5175.2 5277.5 5303.4 5316.9 484.5 5164.2 5188.6 5192.6 5274.1 5149.6 5190.9 5193.0 5196.2 5251.4 5144.2 5186.9 5208.4 5213.9 5234.7 4006.0 5108.5 5166.4 5194.9 5206.8 4655.8 5541.1 5610.3 5653.1 5700.7 6084.8 6138.1 6232.0 6234.4 6257.7 6180.6 6229.8 6238.3 6242.7 6245.4 5171.6 5902.5 5958.4 5959.9 5990.3 6178.8 6179.0 6179.6 6293.0 6312.6 6062.8 6104.0 6117.3 6127.0 6133.6 6164.5 6180.9 6184.9 6219.3 6226.1 6104.6 6122.6 6124.3 6139.1 6175.1 6095.8 6120.6 6218.9 6220.5 6256.7 3868.7 4978.8 4980.2 5007.4 5037.6 4325.3 4396.3 4399.6 4447.7 4511.4 4717.0 5672.5 5714.6 5749.8 5779.9 6224.7 6249.5 6253.9 6266.4 6284.2 5599.0 5686.7 5695.1 5702.5 5771.2 5350.0 5352.1 5364.5 5381.5 5386.1 6175.4 6301.7 6304.1 6315.2 6325.0 6205.1 6222.2 6237.8 6254.5 6263.1 6348.7 6353.4 6355.7 6362.0 6369.1 5938.6 6123.0 6230.7 6246.2 6247.8 6167.8 6231.7 6235.8 6259.2 6261.0 5405.6 6152.5 6167.2 6196.3 6201.7 6024.4 6071.9 6073.8 6156.7 6175.0 4576.9 4828.6 5103.9 5911.7 5979.7 5288.7 6104.1 6122.8 6132.7 6146.0 5874.2 5991.5 6070.2 6080.7 6084.6 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#1] ext.html Cycles:180 Average:66707.82 Median:39394.71 stddev:146127.25 (370.9%) stddev-sans-first:146452.59 07:12:49 INFO - PROCESS | 2006 | Values: 488.1 495.6 495.8 540.4 569.9 37371.3 40559.4 42835.0 42877.9 42991.6 35114.5 42951.9 43184.0 43718.0 43740.0 9602.5 9694.2 9754.8 9765.7 9781.3 9646.2 9694.8 9703.4 9705.7 9760.2 9757.2 9760.8 9796.0 9797.4 9806.1 8309.7 9725.1 9766.0 9770.4 9796.7 9507.6 9533.6 9558.0 9571.7 9643.9 40124.6 40170.6 40578.4 40597.0 40843.8 2668.4 2850.8 2928.0 3371.0 3404.9 27197.9 27962.3 28079.7 28333.7 28937.4 2641.1 2659.6 2668.2 2712.9 2787.0 403259.0 440227.0 441790.0 444754.0 446587.0 36007.8 36040.3 36163.3 36168.9 36233.1 37799.6 38046.9 38583.4 39392.4 39549.4 17132.2 17243.8 17258.3 17294.3 17315.0 11059.4 12724.9 13177.3 13189.7 13196.3 20324.4 20447.7 20755.1 20762.0 20846.5 8359.5 8377.1 8437.7 8473.6 8541.9 903.5 926.9 981.3 1073.8 1101.0 23681.4 28778.1 30041.7 30811.7 30974.4 988.3 1003.9 1056.3 1124.2 1248.8 15014.4 15022.8 15329.6 15390.1 15760.8 593488.0 631022.0 632380.0 637522.0 640513.0 61198.0 62827.7 63319.0 63449.7 63635.4 1416.3 1437.6 1453.6 1457.5 1457.9 22564.9 29294.7 29342.9 29431.4 29699.0 45539.9 53959.7 54474.7 54518.7 54600.7 545689.0 562087.2 562204.4 563101.0 566591.0 27734.7 27834.7 27868.0 28089.9 28159.7 39865.0 45339.0 47371.8 47869.3 48395.5 29716.7 39556.8 39736.0 40059.8 40459.4 38278.4 38834.6 39222.0 39397.0 39756.8 38308.6 38489.8 38876.6 39236.4 39334.8 33685.8 34167.7 34399.0 34932.5 35005.8 21268.0 21925.2 25684.9 25709.0 25770.6 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#2] jquery.html Cycles:180 Average:35099.38 Median:28133.05 stddev:102389.12 (363.9%) stddev-sans-first:102643.18 07:12:49 INFO - PROCESS | 2006 | Values: 389.8 390.7 392.2 392.4 416.5 20168.7 21002.9 21314.3 21395.0 22022.0 20859.5 20934.8 21498.9 21527.0 21562.7 5844.9 5953.1 5959.4 6072.0 6110.1 5677.7 5901.0 5997.4 5999.2 6057.6 5747.9 5841.5 5847.0 5869.2 5876.3 5608.3 5737.9 5812.5 5813.5 5866.1 4667.8 5112.6 5146.3 5149.3 5154.6 21275.5 25994.9 26032.0 26216.8 26228.5 2187.5 2210.5 2373.6 2414.4 2416.8 13109.7 14575.3 15246.1 15369.5 15392.2 1697.0 1708.7 1720.6 1736.0 1738.2 91633.5 122529.0 124451.4 124931.0 125626.0 8961.9 10808.3 11284.7 11573.4 11757.5 14184.4 14233.0 14245.9 14255.4 14258.6 7279.6 8646.2 8748.4 8911.6 9027.7 7343.6 8827.3 8971.9 8998.3 9113.3 6667.7 6834.6 6863.4 6867.2 6869.1 1612.4 1614.3 1843.1 1909.8 1911.7 962.9 966.0 981.7 999.1 1102.3 16249.0 19391.7 20200.4 21559.2 22138.0 904.6 974.3 989.1 991.5 1008.8 9552.4 11437.5 11551.4 11552.7 11595.2 597564.1 608188.0 621376.0 624740.0 625582.0 116428.0 120782.0 121969.4 122164.4 123233.4 1043.1 1058.5 1095.7 1106.0 1116.2 18030.9 18842.6 19073.0 19079.7 19081.7 51153.5 51262.7 51830.5 52172.7 52563.0 67742.6 71879.0 72183.6 74425.0 79993.0 5839.6 6718.8 6878.4 6911.7 7402.4 8821.3 8835.3 8884.2 9273.2 9333.4 7849.6 8054.3 8083.7 8218.7 8243.8 7984.0 8161.1 8218.2 8259.7 8325.0 8314.2 8332.7 8373.5 8452.4 8664.0 12180.7 12547.4 12628.9 12711.9 12839.6 11900.3 12010.7 12124.3 12142.3 12170.8 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#3] mootools.html Cycles:180 Average:5793.53 Median:4722.49 stddev:3239.64 (68.6%) stddev-sans-first:3233.36 07:12:49 INFO - PROCESS | 2006 | Values: 1594.3 1615.6 1653.2 1866.4 1952.5 8115.4 8125.5 8638.6 9157.1 9179.8 8135.2 8753.1 8930.9 8964.7 8974.9 2471.0 2487.6 2487.7 2499.7 2506.3 2459.1 2508.1 2509.2 2513.4 2520.7 2072.6 2451.2 2458.2 2498.2 2504.4 2444.1 2451.4 2459.8 2463.9 2470.8 2439.6 2448.7 2455.8 2457.0 2478.7 8865.2 8936.4 8939.8 8954.2 8975.6 5430.6 5576.8 5579.3 5586.9 5590.7 3581.0 3581.4 3619.1 3646.6 3665.0 988.9 1036.8 1037.2 1038.6 1068.4 11686.0 11829.3 11864.2 11869.2 11903.9 4861.9 4895.2 5007.4 5037.5 5069.7 10088.9 10090.6 10147.7 10160.0 10161.6 5442.3 5488.9 5500.3 5542.9 5550.1 4536.2 4852.5 4990.7 5008.4 5048.7 4060.8 4064.0 4072.6 4102.7 4136.5 1372.0 1380.9 1385.3 1390.9 1396.5 863.8 883.5 916.7 946.3 956.7 5970.9 6000.6 6069.8 6108.0 6158.5 381.2 403.4 450.5 454.1 459.1 4021.9 4065.4 4110.1 4125.5 4126.2 10204.7 10906.4 10969.3 10994.2 11049.3 10609.1 10692.5 10830.3 10915.5 11039.7 8294.5 8324.8 8371.5 8414.9 8470.2 5837.7 5867.5 5878.9 5984.6 6102.5 7746.7 10131.3 10295.7 10317.9 10355.4 10232.9 10459.5 10497.3 10558.9 10620.0 6720.8 7090.6 7641.8 7678.6 7846.8 8433.2 8448.7 8449.0 8518.8 8531.0 6343.8 7379.9 7447.2 7587.9 7658.0 7295.8 7382.4 7400.8 7410.1 7463.4 7042.6 7087.8 7093.3 7146.5 7150.7 4636.5 4716.2 4728.8 4761.6 4887.1 5004.1 5050.5 5080.3 5144.7 5260.8 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#4] prototype.html Cycles:180 Average:4601.15 Median:5169.02 stddev:1444.46 (27.9%) stddev-sans-first:1411.33 07:12:49 INFO - PROCESS | 2006 | Values: 262.8 319.0 323.2 323.6 326.5 5057.6 5104.5 5307.9 5528.7 5613.8 4693.7 4912.7 5553.5 5560.9 5578.9 3885.4 4086.8 4243.5 4271.0 4282.2 3311.1 3900.9 3906.0 3919.9 4078.2 3525.8 3892.8 4212.4 4229.6 4268.3 3641.8 3885.8 4098.0 4138.2 4277.2 3581.6 3598.7 3602.2 3615.5 3628.0 4785.9 4932.3 5343.3 5369.7 5378.5 3879.9 4579.3 4611.9 4837.6 4857.7 5802.6 5805.5 5825.4 5828.3 5833.9 3382.4 3676.0 3987.2 3988.2 4006.9 5704.2 5800.1 6158.0 6209.6 6229.3 3359.9 3439.9 4014.3 4041.6 4059.8 3805.7 4100.0 4126.2 4127.7 4129.8 4304.9 4780.4 4798.7 4801.7 4802.5 5182.6 5518.4 5889.7 5903.9 5932.4 1200.6 1228.5 1312.7 1330.9 1331.4 746.2 867.7 874.0 885.6 913.0 5153.4 5162.5 5175.5 5208.9 5263.8 4995.6 5017.9 5234.5 5514.8 5699.8 4359.0 4746.3 4899.0 4986.3 5096.8 2647.6 2779.1 2785.3 2985.3 3001.2 5193.5 5708.1 5871.1 6038.5 6050.3 5502.4 5552.7 5713.4 5933.4 5940.9 5966.7 6067.8 6073.9 6079.0 6081.8 5568.5 5811.2 5812.0 5831.0 5925.8 5022.9 5525.8 5620.7 5696.9 5705.0 5047.9 5389.1 5733.8 5739.5 5900.5 3259.7 3316.1 3332.1 3400.7 3842.4 5238.4 5480.8 6019.5 6031.3 6086.5 5193.9 5234.9 5877.4 5880.9 5884.9 4948.2 5280.3 5293.0 5547.4 5800.9 4634.4 5217.4 5464.0 5678.1 5779.9 4933.9 5134.6 5793.6 5967.5 5975.3 5380.8 5812.9 5825.7 5826.5 5843.4 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - PROCESS | 2006 | [#5] yui.html Cycles:180 Average:17638.01 Median:29709.26 stddev:24280.45 (81.7%) stddev-sans-first:24315.06 07:12:49 INFO - PROCESS | 2006 | Values: 651.5 707.1 717.9 721.8 757.5 14775.3 15130.5 15276.1 15339.6 16147.6 15806.2 16186.9 16277.5 16280.9 16402.8 912.4 913.4 921.6 921.9 922.8 710.3 720.4 901.2 902.0 909.1 958.1 962.5 964.5 965.4 967.0 934.3 953.9 959.0 959.1 959.1 624.2 689.9 715.0 717.8 719.6 14670.0 14692.6 15052.5 15065.8 15078.9 12254.9 12360.7 12364.1 12366.6 12592.1 9945.8 9953.4 10000.7 10073.2 10148.5 3371.8 3417.3 3427.9 3430.6 3566.2 77090.0 77449.2 77546.6 77791.6 77795.0 9276.7 9283.7 9312.1 9559.4 9583.0 20627.9 20910.7 21107.6 21142.9 21169.7 7171.0 7330.7 7343.2 7368.5 7394.3 3967.2 4088.7 4093.9 4094.5 4094.6 3351.4 3451.4 3452.7 3472.0 3472.4 514.8 527.7 558.4 615.4 617.6 510.8 514.1 520.5 539.4 565.5 6565.6 7552.5 8095.5 8173.0 8365.1 484.9 516.9 533.3 594.8 601.2 3820.6 3849.7 3970.8 4005.3 4018.4 81798.6 85949.0 89200.0 89611.6 90806.1 75720.0 77903.2 77970.6 78448.0 78861.6 52754.0 66994.0 68152.0 68686.3 68835.7 8324.6 8331.5 8371.5 8429.8 8466.9 43960.0 44161.3 44310.8 44576.6 45061.8 58853.0 61074.4 61485.0 61738.4 61920.4 11090.0 11139.3 11146.8 11187.4 11553.9 11901.6 11961.8 11990.4 12263.2 12307.7 11361.5 11562.7 11623.4 11627.2 11827.0 10888.5 11333.5 11611.2 11677.8 11789.1 11200.6 11493.5 11616.8 11617.4 11669.6 9452.5 9671.4 9734.8 9942.9 10209.6 9639.7 9672.6 9688.6 9698.8 9710.7 07:12:49 INFO - PROCESS | 2006 | -------- Summary: end -------- 07:12:49 INFO - PROCESS | 2006 | 07:12:49 INFO - TEST-INFO | 2006: exit 0 07:12:49 INFO - TEST-OK | dromaeo_css | took 1111626ms 07:12:49 INFO - TEST-START | kraken 07:12:49 INFO - operating with platform_type : mac_ 07:12:49 INFO - Initialising browser for kraken test... 07:12:49 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp9xomWr/profile http://localhost:49393/getInfo.html) 07:12:52 INFO - PROCESS | 2010 | __metrics Screen width/height:1600/1200 07:12:52 INFO - PROCESS | 2010 | colorDepth:24 07:12:52 INFO - PROCESS | 2010 | Browser inner width/height: 1024/689 07:12:52 INFO - PROCESS | 2010 | __metrics 07:12:52 ERROR - PROCESS | 2010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:12:53 INFO - TEST-INFO | 2010: exit 0 07:12:53 INFO - Browser initialized. 07:12:53 INFO - Running cycle 1/1 for kraken test... 07:12:53 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp9xomWr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:05 INFO - PROCESS | 2013 | RSS: Main: 250142720 07:13:05 INFO - PROCESS | 2013 | 07:13:08 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:09 INFO - PROCESS | 2013 | RSS: Main: 262012928 07:13:09 INFO - PROCESS | 2013 | 07:13:11 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-dft) 07:13:12 INFO - PROCESS | 2013 | RSS: Main: 267255808 07:13:12 INFO - PROCESS | 2013 | 07:13:15 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-fft) 07:13:16 INFO - PROCESS | 2013 | RSS: Main: 267091968 07:13:16 INFO - PROCESS | 2013 | 07:13:18 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator) 07:13:19 INFO - PROCESS | 2013 | RSS: Main: 268161024 07:13:19 INFO - PROCESS | 2013 | 07:13:21 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:21 INFO - PROCESS | 2013 | RSS: Main: 268140544 07:13:21 INFO - PROCESS | 2013 | 07:13:24 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:25 INFO - PROCESS | 2013 | RSS: Main: 268070912 07:13:25 INFO - PROCESS | 2013 | 07:13:28 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:29 INFO - PROCESS | 2013 | RSS: Main: 268718080 07:13:29 INFO - PROCESS | 2013 | 07:13:31 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial) 07:13:32 INFO - PROCESS | 2013 | RSS: Main: 268689408 07:13:32 INFO - PROCESS | 2013 | 07:13:34 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:13:34 INFO - PROCESS | 2013 | RSS: Main: 268222464 07:13:34 INFO - PROCESS | 2013 | 07:13:36 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:37 INFO - PROCESS | 2013 | RSS: Main: 269037568 07:13:37 INFO - PROCESS | 2013 | 07:13:39 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:13:40 INFO - PROCESS | 2013 | RSS: Main: 268849152 07:13:40 INFO - PROCESS | 2013 | 07:13:43 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:13:43 INFO - PROCESS | 2013 | RSS: Main: 268460032 07:13:43 INFO - PROCESS | 2013 | 07:13:46 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:13:47 INFO - PROCESS | 2013 | RSS: Main: 268423168 07:13:47 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49393/tests/kraken/driver.html?testName=ai-astar) 07:13:49 INFO - PROCESS | 2013 | RSS: Main: 270319616 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | __start_tp_report 07:13:49 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 07:13:49 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 07:13:49 INFO - PROCESS | 2013 | |i|pagename|runs| 07:13:49 INFO - PROCESS | 2013 | |0;ai-astar;112;115;107;115;116;116;106;114;116;117 07:13:49 INFO - PROCESS | 2013 | |1;audio-beat-detection;154;121;145;162;120;148;141;153;207;140 07:13:49 INFO - PROCESS | 2013 | |2;audio-dft;196;199;200;207;269;280;196;196;194;195 07:13:49 INFO - PROCESS | 2013 | |3;audio-fft;87;90;82;136;49;49;54;77;122;74 07:13:49 INFO - PROCESS | 2013 | |4;audio-oscillator;79;96;133;78;79;91;138;102;119;125 07:13:49 INFO - PROCESS | 2013 | |5;imaging-gaussian-blur;122;110;93;89;90;87;92;89;95;99 07:13:49 INFO - PROCESS | 2013 | |6;imaging-darkroom;151;95;96;95;97;95;103;96;96;152 07:13:49 INFO - PROCESS | 2013 | |7;imaging-desaturate;92;93;95;89;90;93;89;92;98;93 07:13:49 INFO - PROCESS | 2013 | |8;json-parse-financial;58;70;61;58;58;75;59;83;72;96 07:13:49 INFO - PROCESS | 2013 | |9;json-stringify-tinderbox;69;68;76;71;77;69;68;68;67;70 07:13:49 INFO - PROCESS | 2013 | |10;stanford-crypto-aes;88;89;104;79;99;75;106;109;109;109 07:13:49 INFO - PROCESS | 2013 | |11;stanford-crypto-ccm;138;135;153;152;154;145;141;151;192;160 07:13:49 INFO - PROCESS | 2013 | |12;stanford-crypto-pbkdf2;171;168;169;164;169;167;170;180;172;170 07:13:49 INFO - PROCESS | 2013 | |13;stanford-crypto-sha256-iterative;63;85;92;88;88;91;74;68;68;66 07:13:49 INFO - PROCESS | 2013 | __end_tp_report 07:13:49 INFO - PROCESS | 2013 | __start_cc_report 07:13:49 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,1064 07:13:49 INFO - PROCESS | 2013 | __end_cc_report 07:13:49 INFO - PROCESS | 2013 | __startTimestamp1462630429263__endTimestamp 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | ------- Summary: start ------- 07:13:49 INFO - PROCESS | 2013 | Number of tests: 14 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.50 stddev:3.89 (3.4%) stddev-sans-first:4.10 07:13:49 INFO - PROCESS | 2013 | Values: 112.0 115.0 107.0 115.0 116.0 116.0 106.0 114.0 116.0 117.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:150.50 stddev:24.41 (16.2%) stddev-sans-first:25.82 07:13:49 INFO - PROCESS | 2013 | Values: 154.0 121.0 145.0 162.0 120.0 148.0 141.0 153.0 207.0 140.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#2] audio-dft Cycles:10 Average:213.20 Median:199.50 stddev:32.62 (16.4%) stddev-sans-first:34.00 07:13:49 INFO - PROCESS | 2013 | Values: 196.0 199.0 200.0 207.0 269.0 280.0 196.0 196.0 194.0 195.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:29.17 (38.6%) stddev-sans-first:30.88 07:13:49 INFO - PROCESS | 2013 | Values: 87.0 90.0 82.0 136.0 49.0 49.0 54.0 77.0 122.0 74.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:78.50 stddev:23.16 (29.5%) stddev-sans-first:22.73 07:13:49 INFO - PROCESS | 2013 | Values: 79.0 96.0 133.0 78.0 79.0 91.0 138.0 102.0 119.0 125.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:91.00 stddev:11.15 (12.2%) stddev-sans-first:7.08 07:13:49 INFO - PROCESS | 2013 | Values: 122.0 110.0 93.0 89.0 90.0 87.0 92.0 89.0 95.0 99.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:95.50 stddev:23.26 (24.4%) stddev-sans-first:18.63 07:13:49 INFO - PROCESS | 2013 | Values: 151.0 95.0 96.0 95.0 97.0 95.0 103.0 96.0 96.0 152.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:2.76 (3.0%) stddev-sans-first:2.92 07:13:49 INFO - PROCESS | 2013 | Values: 92.0 93.0 95.0 89.0 90.0 93.0 89.0 92.0 98.0 93.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:71.00 stddev:12.90 (18.2%) stddev-sans-first:13.06 07:13:49 INFO - PROCESS | 2013 | Values: 58.0 70.0 61.0 58.0 58.0 75.0 59.0 83.0 72.0 96.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:69.50 stddev:3.47 (5.0%) stddev-sans-first:3.64 07:13:49 INFO - PROCESS | 2013 | Values: 69.0 68.0 76.0 71.0 77.0 69.0 68.0 68.0 67.0 70.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#10] stanford-crypto-aes Cycles:10 Average:96.70 Median:77.00 stddev:12.99 (16.9%) stddev-sans-first:13.39 07:13:49 INFO - PROCESS | 2013 | Values: 88.0 89.0 104.0 79.0 99.0 75.0 106.0 109.0 109.0 109.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:152.50 stddev:16.07 (10.5%) stddev-sans-first:16.22 07:13:49 INFO - PROCESS | 2013 | Values: 138.0 135.0 153.0 152.0 154.0 145.0 141.0 151.0 192.0 160.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.00 stddev:4.16 (2.4%) stddev-sans-first:4.40 07:13:49 INFO - PROCESS | 2013 | Values: 171.0 168.0 169.0 164.0 169.0 167.0 170.0 180.0 172.0 170.0 07:13:49 INFO - PROCESS | 2013 | 07:13:49 INFO - PROCESS | 2013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:86.50 stddev:11.54 (13.3%) stddev-sans-first:10.83 07:13:49 INFO - PROCESS | 2013 | Values: 63.0 85.0 92.0 88.0 88.0 91.0 74.0 68.0 68.0 66.0 07:13:49 INFO - PROCESS | 2013 | -------- Summary: end -------- 07:13:49 INFO - PROCESS | 2013 | 07:13:50 INFO - TEST-INFO | 2013: exit 0 07:13:50 INFO - TEST-OK | kraken | took 60196ms 07:13:50 INFO - SUITE-END | took 1171s 07:13:50 INFO - Completed test suite (00:19:32) 07:13:50 INFO - javascript benchmark 07:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.6253812080668, 3425.880094196703, 3459.3427248822723, 3478.930421391573, 3490.982545087274, 5105.285260063594, 5269.7879487717755, 5663.207150998864, 5675.772969081237, 5772.307323121221, 5579.218909352694, 5673.773049078032, 5704.743286552105, 5750.7412166452505, 5790.913136302959, 5100.081985242673, 5175.24958880962, 5277.498637629419, 5303.416624171338, 5316.9202461963105, 484.52762426662946, 5164.173732202848, 5188.558972487324, 5192.610554208431, 5274.05067087924, 5149.613778966593, 5190.896182076356, 5193.0, 5196.168613021917, 5251.369835619712, 5144.176931690949, 5186.870328241786, 5208.374995000586, 5213.869653258661, 5234.685918844882, 4005.959940400588, 5108.489151084899, 5166.405863325728, 5194.92207616886, 5206.817761378372, 4655.790489427984, 5541.141123125922, 5610.298712660918, 5653.123765816305, 5700.686462244575, 6084.756609735606, 6138.1431767337435, 6231.9688401557705, 6234.407731265523, 6257.655828929407, 6180.6291622502795, 6229.813105606839, 6238.313785483593, 6242.656653884034, 6245.437910588069, 5171.586273098105, 5902.468777809975, 5958.433948774859, 5959.940400595982, 5990.281166260033, 6178.752849885954, 6179.0, 6179.567430279927, 6293.024581189831, 6312.621242725451, 6062.818115456544, 6103.962326404522, 6117.265928088569, 6126.969365153146, 6133.570650054453, 6164.48278790489, 6180.907286390708, 6184.8763024739255, 6219.284782250009, 6226.066090086523, 6104.572679912452, 6122.581127188433, 6124.319907527303, 6139.109829074849, 6175.104609831639, 6095.801078121664, 6120.60216085953, 6218.906716399258, 6220.533459990428, 6256.749730010749, 3868.651821336037, 4978.77595508203, 4980.157341783563, 5007.39911210657, 5037.596992240612, 4325.286327755948, 4396.340548917688, 4399.626031787334, 4447.73313601185, 4511.390962220058, 4716.976415117971, 5672.517835983987, 5714.571407144397, 5749.7700091996685, 5779.8555036124435, 6224.688765561795, 6249.531285153632, 6253.874922501524, 6266.436020758154, 6284.183056202664, 5598.992181407304, 5686.715664216773, 5695.060315047971, 5702.45826646468, 5771.163181338682, 5349.973250133725, 5352.116900711417, 5364.463553644682, 5381.461853814665, 5386.13821788512, 6175.3515880831865, 6301.6534090625455, 6304.117423560705, 6315.242170939425, 6324.968375158187, 6205.131281620667, 6222.222222222223, 6237.781677641261, 6254.530910181664, 6263.09185168139, 6348.650824204713, 6353.428191462605, 6355.713992870239, 6362.0, 6369.108324834619, 5938.61399009063, 6123.038605230386, 6230.657313847601, 6246.187995560548, 6247.781327653511, 6167.84580385494, 6231.657258850807, 6235.75056997715, 6259.1550140730415, 6260.968695156495, 5405.648632838853, 6152.507799376129, 6167.167432396569, 6196.318404975539, 6201.658908760061, 6024.427679370453, 6071.878562428815, 6073.757049717962, 6156.722947467285, 6175.0, 4576.8626941191815, 4828.637852161031, 5103.87240318995, 5911.704414779329, 5979.684469416721, 5288.65623734456, 6104.084387341757, 6122.785702500391, 6132.724027418688, 6146.0, 5874.236349274738, 5991.520678345635, 6070.2108725865355, 6080.726367313393, 6084.6349219047], "value": 5609.126064726685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.0750976898777, 495.5960891873123, 495.8051096856575, 540.3758658749144, 569.9344575373829, 37371.252574948485, 40559.39160912585, 42834.99999999996, 42877.92805179872, 42991.57008429915, 35114.47328290078, 42951.926201844966, 43184.0, 43718.0, 43740.0, 9602.519874006306, 9694.22446204302, 9754.804903901917, 9765.658201962933, 9781.266405019653, 9646.180074693659, 9694.757631059209, 9703.417794932291, 9705.708828735149, 9760.219182465422, 9757.170640495566, 9760.804783904317, 9795.971423000588, 9797.412155270671, 9806.068423499755, 8309.709160179365, 9725.0761177688, 9765.951170244174, 9770.413775173476, 9796.706098817047, 9507.619695212252, 9533.570989305497, 9558.044195580456, 9571.712848614552, 9643.90356096437, 40124.598754012375, 40170.59829401727, 40578.39132413016, 40597.0, 40843.795781020905, 2668.3729323608936, 2850.757685596727, 2927.956080658792, 3371.0, 3404.880829170992, 27197.86401068002, 27962.3009424764, 28079.71920280812, 28333.716662833314, 28937.421251575062, 2641.1284276189003, 2659.574468085116, 2668.2262143978223, 2712.864356782153, 2786.9966811947684, 403259.0, 440226.9999999968, 441790.0, 444754.0, 446587.0, 36007.81996090003, 36040.27919441649, 36163.27673446569, 36168.91493255206, 36233.09417264589, 37799.62200378016, 38046.858594242214, 38583.42124868129, 39392.409113863316, 39549.406758898636, 17132.229049692793, 17243.827561724473, 17258.309667613405, 17294.308227671005, 17315.04767237814, 11059.447027648584, 12724.872751272369, 13177.275249861157, 13189.736205276033, 13196.274204918629, 20324.390268291976, 20447.693284600744, 20755.066022029045, 20761.961901904844, 20846.478838028866, 8359.498430094214, 8377.115149091527, 8437.704680336159, 8473.618687159093, 8541.871871921927, 903.5346796399859, 926.8692195521453, 981.3277904635347, 1073.7705327400083, 1100.983485247722, 23681.358649663904, 28778.136655900358, 30041.699583004327, 30811.691883080883, 30974.380512389627, 988.2983082011708, 1003.9347442416366, 1056.345066059033, 1124.224285243196, 1248.8126780982743, 15014.399424022917, 15022.774658380133, 15329.616759580877, 15390.076595404087, 15760.842391576167, 593488.0, 631022.0, 632380.0, 637522.0, 640513.0, 61198.0, 62827.6858615704, 63319.0, 63449.68275158687, 63635.363646362945, 1416.3343228682502, 1437.583100900748, 1453.5929939616924, 1457.453454954392, 1457.8615031571983, 22564.887175564018, 29294.7070529292, 29342.853285733436, 29431.411371772872, 29698.960536381124, 45539.86150346268, 53959.73020134874, 54474.727626361615, 54518.72740636271, 54600.72699636636, 545689.0, 562087.1895640496, 562204.3779562152, 563101.0, 566591.0, 27734.722652773213, 27834.721652784025, 27868.024619138232, 28089.876404943574, 28159.71840281571, 39865.0, 45339.0, 47371.76314118407, 47869.28196076992, 48395.5160448391, 29716.70283297226, 39556.80221598989, 39736.0, 40059.799701001306, 40459.39310910398, 38278.42582361322, 38834.6116538831, 39222.01944951399, 39397.01507462336, 39756.801215993735, 38308.616913830505, 38489.80755096207, 38876.6112338873, 39236.41145382878, 39334.80332598319, 33685.83157084199, 34167.65832341645, 34399.0, 34932.47601285932, 35005.824970876005, 21268.0, 21925.245980321855, 25684.871575642002, 25709.0, 25770.613440798028], "value": 19382.501327592498, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.76029741708845, 390.6620773031329, 392.2468859789206, 392.3780807420239, 416.5480453707727, 20168.69746953797, 21002.89498552509, 21314.254001109963, 21395.0, 22022.0, 20859.478513037142, 20934.790652093474, 21498.89250553745, 21527.0, 21562.676559851614, 5844.941550584493, 5953.107033944922, 5959.433853783905, 6072.0, 6110.144579758838, 5677.744501497443, 5900.970495147519, 5997.40025997399, 5999.220101386835, 6057.636541807506, 5747.856303592423, 5841.503472204868, 5846.9707651461895, 5869.2369991901205, 5876.265466816648, 5608.270924779773, 5737.856553586152, 5812.534997200235, 5813.47678708914, 5866.090755932816, 4667.809708524304, 5112.616553758446, 5146.253793199965, 5149.3305870237, 5154.639175257734, 21275.46811329714, 25994.87002564994, 26032.0, 26216.820243088918, 26228.475430491282, 2187.475005998549, 2210.469487323047, 2373.6320870265135, 2414.37226321156, 2416.782489575929, 13109.689031096814, 14575.271236438135, 15246.085234885832, 15369.538913832603, 15392.230388480531, 1696.9830301697073, 1708.709519381708, 1720.5698575356162, 1735.9913200433916, 1738.226489212301, 91633.54183229108, 122529.0, 124451.3777431116, 124931.0, 125626.0, 8961.865572016424, 10808.297460665031, 11284.71788205285, 11573.363465009505, 11757.470913808898, 14184.361703723358, 14233.003689741825, 14245.857541424453, 14255.429782808571, 14258.572242832732, 7279.59962202084, 8646.178613031752, 8748.387612867038, 8911.631058673433, 9027.684031059012, 7343.63281835906, 8827.337949653802, 8971.910280897238, 8998.280137588978, 9113.270938324918, 6667.6666166691475, 6834.624095674686, 6863.416609588241, 6867.244603093655, 6869.141357330333, 1612.4034107380344, 1614.2574415768643, 1843.1060935446299, 1909.8376637985648, 1911.7228001939918, 962.8748262725801, 965.9565319560637, 981.7202097402206, 999.1008092716613, 1102.32207192576, 16249.025058496292, 19391.739536930054, 20200.393988180378, 21559.24542641, 22138.0, 904.6434039327588, 974.2985050763439, 989.1493315748451, 991.5438898106952, 1008.7679833638158, 9552.42685438876, 11437.542498300141, 11551.422428878523, 11552.711182220512, 11595.18833681651, 597564.0608984723, 608188.0, 621376.0, 624740.0, 625582.0, 116428.0, 120782.0, 121969.39015304866, 122164.38917805353, 123233.38383308025, 1043.0820877627639, 1058.539535302146, 1095.7315457712912, 1105.9668209953713, 1116.1963386361806, 18030.90984545069, 18842.6231475367, 19073.046347682837, 19079.713804293224, 19081.71377429312, 51153.488465114875, 51262.74368628133, 51830.48169518256, 52172.73913630407, 52563.0, 67742.6451470958, 71879.0, 72183.63908180426, 74425.0, 79993.0, 5839.591228613956, 6718.8320291993095, 6878.38094571491, 6911.723531058701, 7402.444816638881, 8821.250193733604, 8835.293176545732, 8884.244839188483, 9273.165415112673, 9333.393329433566, 7849.5682737447705, 8054.275115239657, 8083.7170699025255, 8218.712345067894, 8243.83512329738, 7983.962084929154, 8161.061477930114, 8218.178182181973, 8259.710910118118, 8325.0, 8314.168583141638, 8332.708355207538, 8373.455725377831, 8452.36607254446, 8664.00363958153, 12180.695482613006, 12547.372631368213, 12628.87371126277, 12711.936440317739, 12839.550615728405, 11900.345480998629, 12010.699732506757, 12124.27254364741, 12142.332171730639, 12170.817437738264], "value": 9517.230812582307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1594.3303812398794, 1615.5557221764016, 1653.1734132933534, 1866.4214093630976, 1952.5313924658087, 8115.431919765619, 8125.471844330114, 8638.611262493187, 9157.130072643089, 9179.816403671932, 8135.22715342043, 8753.124687531244, 8930.91069089309, 8964.686235981742, 8974.865377019334, 2471.048646271185, 2487.6019836826113, 2487.7387874273213, 2499.7250302466805, 2506.2982364937848, 2459.053264493165, 2508.122157244968, 2509.2346834215555, 2513.42191296002, 2520.6849143857016, 2072.585482903418, 2451.2156110044793, 2458.21337172105, 2498.225550079472, 2504.373906523369, 2444.095684596693, 2451.350392146074, 2459.827812053157, 2463.9137630183036, 2470.7776300132896, 2439.5730747119183, 2448.6939132608422, 2455.791257743094, 2457.041753716052, 2478.6529885816, 8865.246454051414, 8936.374453788238, 8939.821203575957, 8954.238889694383, 8975.596098175598, 5430.5927055471, 5576.776928922838, 5579.330480342344, 5586.91619625706, 5590.664560126405, 3580.982095089534, 3581.4090675038588, 3619.149499867529, 3646.562412510489, 3665.0287673766475, 988.9208863290919, 1036.8496567997674, 1037.2013549566866, 1038.6105210546045, 1068.417712346773, 11686.006689431408, 11829.290242585472, 11864.169508134433, 11869.228500147463, 11903.94048029763, 4861.854144375674, 4895.216765317532, 5007.424146223231, 5037.5214354636255, 5069.695818250917, 10088.949555252177, 10090.646827361006, 10147.695569132939, 10160.0, 10161.593536258615, 5442.346918369821, 5488.862778430571, 5500.257465242221, 5542.861428464321, 5550.056490396642, 4536.206163921301, 4852.490488498657, 4990.700557966534, 5008.373953255843, 5048.697078175248, 4060.837566497366, 4063.9796801015805, 4072.5927407259037, 4102.715757306927, 4136.482939632546, 1371.9862801372058, 1380.9309534523234, 1385.2935003148266, 1390.8539603341706, 1396.5461225101678, 863.7970077031893, 883.4875772052194, 916.6654171227455, 946.3328353510758, 956.6508224498148, 5970.880582388328, 6000.579959402888, 6069.817905462844, 6108.045425463898, 6158.507319414436, 381.186167532315, 403.4372050988913, 450.5381983466907, 454.10767841192217, 459.0909998203576, 4021.939670904939, 4065.3901914712437, 4110.05468742191, 4125.546189919107, 4126.154138401621, 10204.744881377876, 10906.400147991937, 10969.341839489496, 10994.175436842268, 11049.28179668335, 10609.098226650667, 10692.465376731132, 10830.296030757976, 10915.508802103925, 11039.668809935714, 8294.502329860228, 8324.791880203165, 8371.49771013729, 8414.873776893352, 8470.195331443503, 5837.708114594168, 5867.503786534407, 5878.911816322844, 5984.611000284967, 6102.4812890902995, 7746.651400687096, 10131.341462804894, 10295.742606434898, 10317.896821031694, 10355.378677279386, 10232.897671023493, 10459.477026148814, 10497.26519143683, 10558.894411056099, 10620.0, 6720.764773232913, 7090.645467726697, 7641.847163056596, 7678.61606919663, 7846.843063138819, 8433.156684331518, 8448.746537603882, 8448.957755211184, 8518.82962340762, 8531.0, 6343.841403964938, 7379.926200737924, 7447.180810110775, 7587.861820726936, 7658.0, 7295.804091384286, 7382.4094072473, 7400.814979625552, 7410.147832999274, 7463.440241981764, 7042.647867606497, 7087.82280442993, 7093.32613401726, 7146.464015198777, 7150.7497237596435, 4636.513166117509, 4716.1510928033285, 4728.834490792806, 4761.571458568606, 4887.095887260868, 5004.074246264453, 5050.520200580939, 5080.339555857715, 5144.742762861767, 5260.815871444481], "value": 4591.128729232509, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.79370694005206, 318.9585353903992, 323.2145885498238, 323.5502651314673, 326.4874147588287, 5057.620678449117, 5104.489551044893, 5307.920381194281, 5528.723563821813, 5613.800133923665, 4693.719565488825, 4912.7297998610065, 5553.500184983351, 5560.944390556093, 5578.86052848679, 3885.397763346679, 4086.816093275795, 4243.469566304212, 4270.97864510677, 4282.207791558571, 3311.122552523583, 3900.941485877714, 3905.9804700976456, 3919.863239660495, 4078.164825828389, 3525.7708248963863, 3892.773776260469, 4212.441396683216, 4229.604230603909, 4268.317069268917, 3641.761800987677, 3885.805709714503, 4098.0, 4138.193052354792, 4277.165952639252, 3581.606023337431, 3598.676119149289, 3602.225521512861, 3615.5119058927235, 3627.9818600907092, 4785.880352991203, 4932.309476673268, 5343.332083489564, 5369.731513424314, 5378.542823859977, 3879.903002424962, 4579.267317229227, 4611.907761844778, 4837.588804951583, 4857.73282469464, 5802.5938184327115, 5805.5065319447895, 5825.417458254183, 5828.300603927513, 5833.941660583382, 3382.4249877520633, 3675.981620091909, 3987.1626958338784, 3988.182422603388, 4006.8797936061965, 5704.176432665857, 5800.100984347433, 6158.0, 6209.565330426872, 6229.31477537466, 3359.8656053758064, 3439.9312013759586, 4014.2774300625583, 4041.595840415935, 4059.7970101494807, 3805.6765174959883, 4099.97950010248, 4126.154138401621, 4127.690423218271, 4129.834806607702, 4304.923769057736, 4780.378550788375, 4798.712077275374, 4801.735904525215, 4802.471728109905, 5182.6372153949615, 5518.365387980433, 5889.705514724246, 5903.881922361528, 5932.436418540232, 1200.6038007457519, 1228.5134986666055, 1312.6587087357357, 1330.8554643007005, 1331.3875617215995, 746.1866565443693, 867.7136544940155, 873.9606717697719, 885.6493846883426, 912.9726108216764, 5153.4073581538605, 5162.535371816554, 5175.508326708957, 5208.947910520847, 5263.763015691309, 4995.575376093, 5017.949820501822, 5234.502722241457, 5514.751836167382, 5699.772009119672, 4358.978205108954, 4746.264329029006, 4898.982834076095, 4986.252062190628, 5096.827729622208, 2647.5896236083436, 2779.069011881002, 2785.3454438207004, 2985.268609190762, 3001.2496875781053, 5193.480651934852, 5708.143778433268, 5871.093808564702, 6038.516918646497, 6050.304215015241, 5502.394736578973, 5552.7223638817895, 5713.428657134336, 5933.350989141733, 5940.910886336708, 5966.746983133504, 6067.848303792529, 6073.908891366633, 6078.957493267105, 6081.817545473643, 5568.498835104698, 5811.244538210006, 5812.0, 5830.970845145747, 5925.792597259076, 5022.924656130088, 5525.834224973257, 5620.662760234399, 5696.892149904396, 5704.971475142598, 5047.87380315495, 5389.056915039931, 5733.76724004341, 5739.540836733135, 5900.498457630978, 3259.674032596721, 3316.1212278746634, 3332.0507503110953, 3400.7449441291506, 3842.4457376925675, 5238.4237733850005, 5480.835574932758, 6019.4883434908525, 6031.306399763907, 6086.452219300284, 5193.870153246199, 5234.916764923366, 5877.4122587740885, 5880.882382352414, 5884.882302353843, 4948.177535333499, 5280.310300703738, 5292.988664307539, 5547.389787123332, 5800.896520361586, 4634.443866736014, 5217.399999000012, 5464.016477034013, 5678.126218348018, 5779.913301300399, 4933.851984440473, 5134.5635620972635, 5793.565482588739, 5967.492763115184, 5975.25309336333, 5380.838574842604, 5812.866491034208, 5825.737841797214, 5826.475617194473, 5843.357230704534], "value": 4134.5585704128225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.504856309205, 707.1337611426001, 717.9246179151189, 721.754603434832, 757.5454727163699, 14775.335109920052, 15130.546083617495, 15276.083434993894, 15339.616509587266, 16147.566373892096, 15806.209689515506, 16186.919065404656, 16277.51167464975, 16280.94173878697, 16402.83597164028, 912.41149458599, 913.4108500017485, 921.5760750054983, 921.940073895198, 922.8431166701677, 710.3358359933479, 720.394868310619, 901.1844280925773, 902.0438335364502, 909.1090731083542, 958.1328897347911, 962.4946902875976, 964.4888209249109, 965.4303960663208, 967.032967032967, 934.2806039349697, 953.914147726701, 958.988267377916, 959.0697023886819, 959.1271942532331, 624.1511544299749, 689.9241083480813, 714.9821254468628, 717.7918403662932, 719.6257945868119, 14670.046446980912, 14692.632684182981, 15052.473163439226, 15065.774013389808, 15078.924605377013, 12254.938725306405, 12360.690982725413, 12364.134510584263, 12366.567170149001, 12592.118551701384, 9945.75135621608, 9953.40537325273, 10000.699979000641, 10073.194144468425, 10148.492575371276, 3371.7808342457906, 3417.3165366926714, 3427.8628854846024, 3430.622631510532, 3566.233259849145, 77090.0, 77449.22550774533, 77546.61226693887, 77791.61104194443, 77795.0, 9276.675316363895, 9283.704718038092, 9312.115349041831, 9559.426434413957, 9583.041695830361, 20627.8968605156, 20910.686339704916, 21107.577848443252, 21142.894285528782, 21169.68245476319, 7170.96414517924, 7330.7434239802415, 7343.1555371133, 7368.484206105629, 7394.260573942563, 3967.2263908537557, 4088.7342322748927, 4093.85671501496, 4094.488188976378, 4094.6314831665295, 3351.379994700988, 3451.361498122855, 3452.706519945833, 3472.045187573387, 3472.409690352646, 514.8146667199806, 527.6517498451004, 558.4499268220799, 615.4276522833718, 617.561531312773, 510.8492994566612, 514.1131548079533, 520.4613225311784, 539.4443722965352, 565.5221337969409, 6565.573237739532, 7552.471327007057, 8095.5142691438705, 8172.959135204286, 8365.1216622255, 484.9490803465656, 516.9276301317818, 533.2907233379595, 594.8037147741235, 601.1716409410808, 3820.6152794901755, 3849.749766265184, 3970.82131304092, 4005.2790497710694, 4018.417329487208, 81798.59100704458, 85949.0, 89200.0, 89611.55194224117, 90806.09193908109, 75720.02059701312, 77903.22096779072, 77970.61014694891, 78448.0, 78861.60569197117, 52753.99999999923, 66994.0, 68152.0, 68686.313136869, 68835.65582172057, 8324.583770811314, 8331.458455200393, 8371.455855369382, 8429.831403372022, 8466.91533084686, 43960.0, 44161.33757993569, 44310.778446107564, 44576.55423445854, 45061.77469112633, 58853.0, 61074.38925610687, 61485.0, 61738.38261617506, 61920.380796191464, 11090.001899829054, 11139.33164010162, 11146.777064458503, 11187.384693841917, 11553.916276838165, 11901.642950711492, 11961.820572691242, 11990.40047997614, 12263.202891812003, 12307.69230769238, 11361.54553817838, 11562.653120406065, 11623.418829058344, 11627.186096973131, 11827.036070667273, 10888.510017049093, 11333.546658133911, 11611.197219017287, 11677.824832627348, 11789.115816313639, 11200.607978720705, 11493.540258389905, 11616.825747613624, 11617.361045142261, 11669.649910502698, 9452.527373631154, 9671.371360861522, 9734.75663108428, 9942.850857237292, 10209.591616335263, 9639.662611808553, 9672.613095476103, 9688.612455501701, 9698.75753106178, 9710.70867873965], "value": 6783.791927597335, "unit": "score"}], "name": "dromaeo_css", "value": 7146.831521026869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 107.0, 115.0, 116.0, 116.0, 106.0, 114.0, 116.0, 117.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 145.0, 162.0, 120.0, 148.0, 141.0, 153.0, 207.0, 140.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 200.0, 207.0, 269.0, 280.0, 196.0, 196.0, 194.0, 195.0], "value": 213.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 82.0, 136.0, 49.0, 49.0, 54.0, 77.0, 122.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 96.0, 133.0, 78.0, 79.0, 91.0, 138.0, 102.0, 119.0, 125.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 110.0, 93.0, 89.0, 90.0, 87.0, 92.0, 89.0, 95.0, 99.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 95.0, 96.0, 95.0, 97.0, 95.0, 103.0, 96.0, 96.0, 152.0], "value": 107.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 95.0, 89.0, 90.0, 93.0, 89.0, 92.0, 98.0, 93.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 70.0, 61.0, 58.0, 58.0, 75.0, 59.0, 83.0, 72.0, 96.0], "value": 69.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 76.0, 71.0, 77.0, 69.0, 68.0, 68.0, 67.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 104.0, 79.0, 99.0, 75.0, 106.0, 109.0, 109.0, 109.0], "value": 96.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 153.0, 152.0, 154.0, 145.0, 141.0, 151.0, 192.0, 160.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 169.0, 164.0, 169.0, 167.0, 170.0, 180.0, 172.0, 170.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 85.0, 92.0, 88.0, 88.0, 91.0, 74.0, 68.0, 68.0, 66.0], "value": 78.3, "unit": "score"}], "name": "kraken", "value": 1594.7, "alertThreshold": 2.0}]} 07:13:50 INFO - Return code: 0 07:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:13:50 ERROR - # TBPL SUCCESS # 07:13:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:13:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:13:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:13:50 INFO - 2016-05-07 07:13:50.599 screenresolution[2018:15252] starting screenresolution argv=screenresolution get 07:13:50 INFO - 2016-05-07 07:13:50.602 screenresolution[2018:15252] Display 0: 1600x1200x32@60 07:13:50 INFO - 2016-05-07 07:13:50.607 screenresolution[2019:15255] starting screenresolution argv=screenresolution list 07:13:50 INFO - Available Modes on Display 0 07:13:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:13:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:13:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:13:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:13:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:13:50 INFO - Intel Iris: 07:13:50 INFO - Chipset Model: Intel Iris 07:13:50 INFO - Type: GPU 07:13:50 INFO - Bus: Built-In 07:13:50 INFO - VRAM (Dynamic, Max): 1536 MB 07:13:50 INFO - Vendor: Intel (0x8086) 07:13:50 INFO - Device ID: 0x0a2e 07:13:50 INFO - Revision ID: 0x0009 07:13:50 INFO - Displays: 07:13:50 INFO - Display: 07:13:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:13:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:13:50 INFO - Display Serial Number: 1600x1200 60 07:13:50 INFO - Main Display: Yes 07:13:50 INFO - Mirror: Off 07:13:50 INFO - Online: Yes 07:13:50 INFO - Rotation: Supported 07:13:50 INFO - Return code: 0 07:13:50 INFO - Running post-action listener: _resource_record_post_action 07:13:50 INFO - ##### 07:13:50 INFO - ##### Finished run-tests step (success) 07:13:50 INFO - ##### 07:13:50 INFO - Running post-run listener: _resource_record_post_run 07:13:51 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 315392; Write bytes: 698488832; Read time: 6; Write time: 1861 07:13:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397267456; Write bytes: 393836032; Read time: 29985; Write time: 788 07:13:51 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 270336; Write bytes: 297759232; Read time: 3; Write time: 1046 07:13:51 INFO - Running post-run listener: _upload_blobber_files 07:13:51 INFO - Blob upload gear active. 07:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:13:51 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 07:13:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:13:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:53 INFO - (blobuploader) - INFO - Done attempting. 07:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:53 INFO - (blobuploader) - INFO - Done attempting. 07:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:13:53 INFO - Return code: 0 07:13:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:13:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6748f9854fc0309d7b4c04c997d143dd59a61db82eba6df3444666631c59e9438e10722905ec76c69369c6b8c4dc91c990d62a7700060ef802cb4d964720d01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd1443748a28ca6f8d65978fd0c2ca6c830c0e53c15b2ae35c2a9594c0efe12f9fad342bc7ce5d6a733a835e700d61e3e63155476278e963ef0698b93f09226e"} 07:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:13:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:13:53 INFO - Contents: 07:13:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6748f9854fc0309d7b4c04c997d143dd59a61db82eba6df3444666631c59e9438e10722905ec76c69369c6b8c4dc91c990d62a7700060ef802cb4d964720d01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd1443748a28ca6f8d65978fd0c2ca6c830c0e53c15b2ae35c2a9594c0efe12f9fad342bc7ce5d6a733a835e700d61e3e63155476278e963ef0698b93f09226e"} 07:13:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:13:53 INFO - Copying logs to upload dir... 07:13:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:13:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.909270 ========= master_lag: 6.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-05-07 07:14:00.696788) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 07:14:00.703443) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6748f9854fc0309d7b4c04c997d143dd59a61db82eba6df3444666631c59e9438e10722905ec76c69369c6b8c4dc91c990d62a7700060ef802cb4d964720d01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd1443748a28ca6f8d65978fd0c2ca6c830c0e53c15b2ae35c2a9594c0efe12f9fad342bc7ce5d6a733a835e700d61e3e63155476278e963ef0698b93f09226e"} build_url:https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/JCpsCB0dTKy1D2UH0JOoqw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6748f9854fc0309d7b4c04c997d143dd59a61db82eba6df3444666631c59e9438e10722905ec76c69369c6b8c4dc91c990d62a7700060ef802cb4d964720d01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd1443748a28ca6f8d65978fd0c2ca6c830c0e53c15b2ae35c2a9594c0efe12f9fad342bc7ce5d6a733a835e700d61e3e63155476278e963ef0698b93f09226e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 07:14:00.731725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 07:14:00.732005) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FiBQfF9pIX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RPQnJaPIui/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 07:14:00.781170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 07:14:00.781469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 07:14:00.781833) ========= ========= Total master_lag: 6.87 =========