builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0329 starttime: 1468023397.6 results: success (0) buildid: 20160708151127 builduid: f79d4f8ccb4d45c0863bd48756e9225d revision: cbacbb7c2c3523d036f737c9dc6c4406d14ade2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.599288) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.599759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.600038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.623900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.624319) ========= 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.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-07-08 17:16:37-- 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% 17.2M=0.001s 2016-07-08 17:16:37 (17.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123774 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.809772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.810104) ========= 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.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.044385 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:37.974572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:16:37.975208) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cbacbb7c2c3523d036f737c9dc6c4406d14ade2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cbacbb7c2c3523d036f737c9dc6c4406d14ade2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-07-08 17:16:38,059 truncating revision to first 12 chars 2016-07-08 17:16:38,059 Setting DEBUG logging. 2016-07-08 17:16:38,059 attempt 1/10 2016-07-08 17:16:38,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cbacbb7c2c35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 17:16:39,703 unpacking tar archive at: mozilla-beta-cbacbb7c2c35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.898021 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:16:39.941179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:39.941533) ========= script_repo_revision: cbacbb7c2c3523d036f737c9dc6c4406d14ade2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:39.941977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:39.942276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:16:39.960543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-08 17:16:39.960941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:16:40 INFO - MultiFileLogger online at 20160708 17:16:40 in /builds/slave/test 17:16:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:40 INFO - {'append_to_log': False, 17:16:40 INFO - 'base_work_dir': '/builds/slave/test', 17:16:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:40 INFO - 'branch': 'Mozilla-Beta', 17:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:40 INFO - 'config_files': ('talos/mac_config.py',), 17:16:40 INFO - 'default_actions': ('clobber', 17:16:40 INFO - 'read-buildbot-config', 17:16:40 INFO - 'download-and-extract', 17:16:40 INFO - 'populate-webroot', 17:16:40 INFO - 'create-virtualenv', 17:16:40 INFO - 'install', 17:16:40 INFO - 'run-tests'), 17:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:40 INFO - 'download_minidump_stackwalk': True, 17:16:40 INFO - 'download_symbols': 'ondemand', 17:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:40 INFO - 'installer_path': 'installer.exe', 17:16:40 INFO - 'log_level': 'info', 17:16:40 INFO - 'log_name': 'talos', 17:16:40 INFO - 'log_to_console': True, 17:16:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:16:40 INFO - 'opt_config_files': (), 17:16:40 INFO - 'pip_index': False, 17:16:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:40 INFO - 'cmd': ('bash', 17:16:40 INFO - '-c', 17:16:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:40 INFO - 'enabled': True, 17:16:40 INFO - 'halt_on_failure': False, 17:16:40 INFO - 'name': 'check_screen_resolution'},), 17:16:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:40 INFO - 'cmd': ('bash', 17:16:40 INFO - '-c', 17:16:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:40 INFO - 'enabled': True, 17:16:40 INFO - 'halt_on_failure': False, 17:16:40 INFO - 'name': 'check_screen_resolution'},), 17:16:40 INFO - 'run_cmd_checks_enabled': True, 17:16:40 INFO - 'sps_profile': False, 17:16:40 INFO - 'sps_profile_interval': 0, 17:16:40 INFO - 'suite': 'dromaeojs-e10s', 17:16:40 INFO - 'system_bits': '32', 17:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:40 INFO - 'title': 't-yosemite-r7-0329', 17:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:40 INFO - 'use_talos_json': True, 17:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:40 INFO - 'work_dir': 'build'} 17:16:40 INFO - ##### 17:16:40 INFO - ##### Running clobber step. 17:16:40 INFO - ##### 17:16:40 INFO - Running pre-action listener: _resource_record_pre_action 17:16:40 INFO - Running main action method: clobber 17:16:40 INFO - rmtree: /builds/slave/test/build 17:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:41 INFO - Running post-action listener: _resource_record_post_action 17:16:41 INFO - ##### 17:16:41 INFO - ##### Running read-buildbot-config step. 17:16:41 INFO - ##### 17:16:41 INFO - Running pre-action listener: _resource_record_pre_action 17:16:41 INFO - Running main action method: read_buildbot_config 17:16:41 INFO - Using buildbot properties: 17:16:41 INFO - { 17:16:41 INFO - "project": "", 17:16:41 INFO - "product": "firefox", 17:16:41 INFO - "script_repo_revision": "production", 17:16:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 17:16:41 INFO - "repository": "", 17:16:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 17:16:41 INFO - "buildid": "20160708151127", 17:16:41 INFO - "pgo_build": "False", 17:16:41 INFO - "basedir": "/builds/slave/test", 17:16:41 INFO - "buildnumber": 21, 17:16:41 INFO - "slavename": "t-yosemite-r7-0329", 17:16:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:16:41 INFO - "platform": "yosemite_r7", 17:16:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:16:41 INFO - "branch": "mozilla-beta", 17:16:41 INFO - "repo_path": "releases/mozilla-beta", 17:16:41 INFO - "revision": "cbacbb7c2c3523d036f737c9dc6c4406d14ade2b", 17:16:41 INFO - "stage_platform": "macosx64", 17:16:41 INFO - "builduid": "f79d4f8ccb4d45c0863bd48756e9225d", 17:16:41 INFO - "slavebuilddir": "test" 17:16:41 INFO - } 17:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 17:16:41 INFO - Running post-action listener: _resource_record_post_action 17:16:41 INFO - ##### 17:16:41 INFO - ##### Running download-and-extract step. 17:16:41 INFO - ##### 17:16:41 INFO - Running pre-action listener: _resource_record_pre_action 17:16:41 INFO - Running main action method: download_and_extract 17:16:41 INFO - mkdir: /builds/slave/test/build/tests 17:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:41 INFO - https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 17:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 17:16:43 INFO - Downloaded 1165 bytes. 17:16:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 17:16:43 INFO - Using the following test package requirements: 17:16:43 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:16:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 17:16:43 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 17:16:43 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:16:43 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 17:16:43 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:16:43 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 17:16:43 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 17:16:43 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 17:16:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:16:43 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 17:16:43 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 17:16:43 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')]} 17:16:43 INFO - https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 17:16:44 INFO - Downloaded 18351540 bytes. 17:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:16:48 INFO - Return code: 0 17:16:48 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:48 INFO - https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 17:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 17:16:49 INFO - Downloaded 18351540 bytes. 17:16:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:16:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:16:53 INFO - Return code: 0 17:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:53 INFO - https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 17:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 17:16:53 INFO - Downloaded 10840145 bytes. 17:16:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:16:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:16:54 INFO - Return code: 0 17:16:54 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')]} 17:16:54 INFO - https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 17:16:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:16:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:16:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 17:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 17:16:56 INFO - Downloaded 86191171 bytes. 17:16:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:16:56 INFO - mkdir: /builds/slave/test/properties 17:16:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:56 INFO - Contents: 17:16:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:16:57 INFO - Running post-action listener: _resource_record_post_action 17:16:57 INFO - Running post-action listener: set_extra_try_arguments 17:16:57 INFO - ##### 17:16:57 INFO - ##### Running populate-webroot step. 17:16:57 INFO - ##### 17:16:57 INFO - Running pre-action listener: _resource_record_pre_action 17:16:57 INFO - Running main action method: populate_webroot 17:16:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:16:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:16:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:16:57 INFO - '--tppagecycles', 17:16:57 INFO - '7'], 17:16:57 INFO - 'tests': ['tsvgm']}}, 17:16:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:16:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['damp', 'tps']}, 17:16:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'tests': ['damp', 'tps']}, 17:16:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['dromaeo_dom']}, 17:16:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['a11yr', 17:16:57 INFO - 'ts_paint', 17:16:57 INFO - 'tpaint', 17:16:57 INFO - 'sessionrestore', 17:16:57 INFO - 'sessionrestore_no_auto_restore', 17:16:57 INFO - 'tabpaint']}, 17:16:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['tsvgx', 17:16:57 INFO - 'tsvgr_opacity', 17:16:57 INFO - 'tart', 17:16:57 INFO - 'tscrollx', 17:16:57 INFO - 'cart']}, 17:16:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:57 INFO - 'tsvgr_opacity', 17:16:57 INFO - 'tart', 17:16:57 INFO - 'tscrollx', 17:16:57 INFO - 'cart']}, 17:16:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'talos_options': ['--disable-e10s'], 17:16:57 INFO - 'tests': ['tp5o']}, 17:16:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'tests': ['tp5o']}, 17:16:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'talos_options': ['--disable-e10s', 17:16:57 INFO - '--xperf_path', 17:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:57 INFO - 'tests': ['tp5n']}, 17:16:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:57 INFO - 'talos_options': ['--xperf_path', 17:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:57 INFO - 'tests': ['tp5n']}}, 17:16:57 INFO - 'talos.zip': {'path': '', 17:16:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:16:57 INFO - Running post-action listener: _resource_record_post_action 17:16:57 INFO - ##### 17:16:57 INFO - ##### Running create-virtualenv step. 17:16:57 INFO - ##### 17:16:57 INFO - Running pre-action listener: _resource_record_pre_action 17:16:57 INFO - Running main action method: create_virtualenv 17:16:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:57 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 17:16:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:57 INFO - Using real prefix '/tools/python27' 17:16:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:01 INFO - Installing pip.................done. 17:17:01 INFO - Return code: 0 17:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:01 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')]} 17:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:01 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')]} 17:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:01 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:01 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 17:17:01 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 17:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:01 INFO - 'HOME': '/Users/cltbld', 17:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:01 INFO - 'LOGNAME': 'cltbld', 17:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:01 INFO - 'MOZ_NO_REMOTE': '1', 17:17:01 INFO - 'NO_EM_RESTART': '1', 17:17:01 INFO - 'PAGER': '/bin/cat', 17:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:01 INFO - 'PWD': '/builds/slave/test', 17:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:01 INFO - 'SHELL': '/bin/bash', 17:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:01 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:01 INFO - 'USER': 'cltbld', 17:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:01 INFO - 'XPC_FLAGS': '0x0', 17:17:01 INFO - 'XPC_SERVICE_NAME': '0', 17:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:01 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 17:17:01 INFO - Cleaning up... 17:17:01 INFO - Return code: 0 17:17:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17:01 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')]} 17:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:01 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')]} 17:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:01 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:01 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 17:17:01 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 17:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:01 INFO - 'HOME': '/Users/cltbld', 17:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:01 INFO - 'LOGNAME': 'cltbld', 17:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:01 INFO - 'MOZ_NO_REMOTE': '1', 17:17:01 INFO - 'NO_EM_RESTART': '1', 17:17:01 INFO - 'PAGER': '/bin/cat', 17:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:01 INFO - 'PWD': '/builds/slave/test', 17:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:01 INFO - 'SHELL': '/bin/bash', 17:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:01 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:01 INFO - 'USER': 'cltbld', 17:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:01 INFO - 'XPC_FLAGS': '0x0', 17:17:01 INFO - 'XPC_SERVICE_NAME': '0', 17:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:02 INFO - Downloading/unpacking psutil>=0.7.1 17:17:02 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 17:17:02 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 17:17:02 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 17:17:02 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 17:17:02 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 17:17:02 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 17:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:04 INFO - Installing collected packages: psutil 17:17:04 INFO - Running setup.py install for psutil 17:17:04 INFO - building 'psutil._psutil_osx' extension 17:17:04 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 17:17:05 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 17:17:05 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 17:17:05 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 17:17:05 INFO - building 'psutil._psutil_posix' extension 17:17:05 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 17:17:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:05 INFO - ^ 17:17:05 INFO - 1 warning generated. 17:17:05 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 17:17:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:05 INFO - Successfully installed psutil 17:17:05 INFO - Cleaning up... 17:17:05 INFO - Return code: 0 17:17:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:05 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:05 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 17:17:05 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 17:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:05 INFO - 'HOME': '/Users/cltbld', 17:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:05 INFO - 'LOGNAME': 'cltbld', 17:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:05 INFO - 'MOZ_NO_REMOTE': '1', 17:17:05 INFO - 'NO_EM_RESTART': '1', 17:17:05 INFO - 'PAGER': '/bin/cat', 17:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:05 INFO - 'PWD': '/builds/slave/test', 17:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:05 INFO - 'SHELL': '/bin/bash', 17:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:05 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:05 INFO - 'USER': 'cltbld', 17:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:05 INFO - 'XPC_FLAGS': '0x0', 17:17:05 INFO - 'XPC_SERVICE_NAME': '0', 17:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:06 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 17:17:06 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 17:17:06 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 17:17:06 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 17:17:06 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 17:17:06 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 17:17:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:08 INFO - Installing collected packages: mozsystemmonitor 17:17:08 INFO - Running setup.py install for mozsystemmonitor 17:17:08 INFO - Successfully installed mozsystemmonitor 17:17:08 INFO - Cleaning up... 17:17:08 INFO - Return code: 0 17:17:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:08 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')]} 17:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:08 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')]} 17:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:08 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:08 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 17:17:08 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 17:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:08 INFO - 'HOME': '/Users/cltbld', 17:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:08 INFO - 'LOGNAME': 'cltbld', 17:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:08 INFO - 'MOZ_NO_REMOTE': '1', 17:17:08 INFO - 'NO_EM_RESTART': '1', 17:17:08 INFO - 'PAGER': '/bin/cat', 17:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:08 INFO - 'PWD': '/builds/slave/test', 17:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:08 INFO - 'SHELL': '/bin/bash', 17:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:08 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:08 INFO - 'USER': 'cltbld', 17:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:08 INFO - 'XPC_FLAGS': '0x0', 17:17:08 INFO - 'XPC_SERVICE_NAME': '0', 17:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:09 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:12 INFO - Downloading docopt-0.6.1.tar.gz 17:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:12 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:12 INFO - Running setup.py install for blobuploader 17:17:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:12 INFO - Running setup.py install for requests 17:17:13 INFO - Running setup.py install for docopt 17:17:13 INFO - Successfully installed blobuploader requests docopt 17:17:13 INFO - Cleaning up... 17:17:13 INFO - Return code: 0 17:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:13 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')]} 17:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:13 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')]} 17:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:13 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:13 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 17:17:13 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 17:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:13 INFO - 'HOME': '/Users/cltbld', 17:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:13 INFO - 'LOGNAME': 'cltbld', 17:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:13 INFO - 'MOZ_NO_REMOTE': '1', 17:17:13 INFO - 'NO_EM_RESTART': '1', 17:17:13 INFO - 'PAGER': '/bin/cat', 17:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:13 INFO - 'PWD': '/builds/slave/test', 17:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:13 INFO - 'SHELL': '/bin/bash', 17:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:13 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:13 INFO - 'USER': 'cltbld', 17:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:13 INFO - 'XPC_FLAGS': '0x0', 17:17:13 INFO - 'XPC_SERVICE_NAME': '0', 17:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:13 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-bz7QVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-mgNIMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ntRLqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-bVYtVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-U7g2rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-5p8bsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Hdlpdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-K2KotH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-3qptns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-EyHDtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:14 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-cdZlAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-FEFAna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-60cATk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-s7mkOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-EHvFnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-NnttDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:15 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-T9peAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:15 INFO - Running setup.py install for manifestparser 17:17:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:15 INFO - Running setup.py install for mozcrash 17:17:15 INFO - Running setup.py install for mozdebug 17:17:16 INFO - Running setup.py install for mozdevice 17:17:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozfile 17:17:16 INFO - Running setup.py install for mozhttpd 17:17:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozinfo 17:17:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozInstall 17:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozleak 17:17:16 INFO - Running setup.py install for mozlog 17:17:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for moznetwork 17:17:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozprocess 17:17:17 INFO - Running setup.py install for mozprofile 17:17:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozrunner 17:17:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozscreenshot 17:17:17 INFO - Running setup.py install for moztest 17:17:18 INFO - Running setup.py install for mozversion 17:17:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:18 INFO - Cleaning up... 17:17:18 INFO - Return code: 0 17:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:18 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:18 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 17:17:18 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 17:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:18 INFO - 'HOME': '/Users/cltbld', 17:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:18 INFO - 'LOGNAME': 'cltbld', 17:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:18 INFO - 'MOZ_NO_REMOTE': '1', 17:17:18 INFO - 'NO_EM_RESTART': '1', 17:17:18 INFO - 'PAGER': '/bin/cat', 17:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:18 INFO - 'PWD': '/builds/slave/test', 17:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:18 INFO - 'SHELL': '/bin/bash', 17:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:18 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:18 INFO - 'USER': 'cltbld', 17:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:18 INFO - 'XPC_FLAGS': '0x0', 17:17:18 INFO - 'XPC_SERVICE_NAME': '0', 17:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-EToXBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-FXgDpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Vq7a2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:18 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-1gLkBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:18 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-C1kMDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-nRStG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-vINqyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-UZsvhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-N3WG9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-7jQqfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-UEFCPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-jPTeXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-P1ZMdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-yuCDFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:19 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Ct2KOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-as7HdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-KVvMDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:22 INFO - Downloading blessings-1.6.tar.gz 17:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:22 INFO - Installing collected packages: blessings 17:17:22 INFO - Running setup.py install for blessings 17:17:22 INFO - Successfully installed blessings 17:17:22 INFO - Cleaning up... 17:17:23 INFO - Return code: 0 17:17:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:23 INFO - Reading from file tmpfile_stdout 17:17:23 INFO - Current package versions: 17:17:23 INFO - blessings == 1.6 17:17:23 INFO - blobuploader == 1.2.4 17:17:23 INFO - docopt == 0.6.1 17:17:23 INFO - manifestparser == 1.1 17:17:23 INFO - mozInstall == 1.12 17:17:23 INFO - mozcrash == 0.17 17:17:23 INFO - mozdebug == 0.1 17:17:23 INFO - mozdevice == 0.48 17:17:23 INFO - mozfile == 1.2 17:17:23 INFO - mozhttpd == 0.7 17:17:23 INFO - mozinfo == 0.9 17:17:23 INFO - mozleak == 0.1 17:17:23 INFO - mozlog == 3.1 17:17:23 INFO - moznetwork == 0.27 17:17:23 INFO - mozprocess == 0.22 17:17:23 INFO - mozprofile == 0.28 17:17:23 INFO - mozrunner == 6.11 17:17:23 INFO - mozscreenshot == 0.1 17:17:23 INFO - mozsystemmonitor == 0.0 17:17:23 INFO - moztest == 0.7 17:17:23 INFO - mozversion == 1.4 17:17:23 INFO - psutil == 3.1.1 17:17:23 INFO - requests == 1.2.3 17:17:23 INFO - wsgiref == 0.1.2 17:17:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:23 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')]} 17:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 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')]} 17:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:23 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 17:17:23 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 17:17:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:23 INFO - 'HOME': '/Users/cltbld', 17:17:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:23 INFO - 'LOGNAME': 'cltbld', 17:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:23 INFO - 'MOZ_NO_REMOTE': '1', 17:17:23 INFO - 'NO_EM_RESTART': '1', 17:17:23 INFO - 'PAGER': '/bin/cat', 17:17:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:23 INFO - 'PWD': '/builds/slave/test', 17:17:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:23 INFO - 'SHELL': '/bin/bash', 17:17:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:23 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:23 INFO - 'USER': 'cltbld', 17:17:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:23 INFO - 'XPC_FLAGS': '0x0', 17:17:23 INFO - 'XPC_SERVICE_NAME': '0', 17:17:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 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)) 17:17:23 INFO - Cleaning up... 17:17:23 INFO - Return code: 0 17:17:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:23 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')]} 17:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 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')]} 17:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:23 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 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:23 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 17:17:23 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 17:17:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:23 INFO - 'HOME': '/Users/cltbld', 17:17:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:23 INFO - 'LOGNAME': 'cltbld', 17:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:23 INFO - 'MOZ_NO_REMOTE': '1', 17:17:23 INFO - 'NO_EM_RESTART': '1', 17:17:23 INFO - 'PAGER': '/bin/cat', 17:17:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:23 INFO - 'PWD': '/builds/slave/test', 17:17:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:23 INFO - 'SHELL': '/bin/bash', 17:17:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:23 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:23 INFO - 'USER': 'cltbld', 17:17:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:23 INFO - 'XPC_FLAGS': '0x0', 17:17:23 INFO - 'XPC_SERVICE_NAME': '0', 17:17:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:23 INFO - Downloading/unpacking jsonschema 17:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:26 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:26 INFO - warning: no files found matching '*.txt' 17:17:26 INFO - no previously-included directories found matching 'build' 17:17:26 INFO - no previously-included directories found matching 'dist' 17:17:26 INFO - no previously-included directories found matching '.git*' 17:17:26 INFO - Installing collected packages: jsonschema, functools32 17:17:26 INFO - Running setup.py install for functools32 17:17:26 INFO - warning: no files found matching '*.txt' 17:17:26 INFO - no previously-included directories found matching 'build' 17:17:26 INFO - no previously-included directories found matching 'dist' 17:17:26 INFO - no previously-included directories found matching '.git*' 17:17:26 INFO - Successfully installed jsonschema functools32 17:17:26 INFO - Cleaning up... 17:17:27 INFO - Return code: 0 17:17:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1045d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7f059f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, '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.ZPL7uFqFOA/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.DyixFBTHli/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 17:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:27 INFO - 'HOME': '/Users/cltbld', 17:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:27 INFO - 'LOGNAME': 'cltbld', 17:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:27 INFO - 'MOZ_NO_REMOTE': '1', 17:17:27 INFO - 'NO_EM_RESTART': '1', 17:17:27 INFO - 'PAGER': '/bin/cat', 17:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:27 INFO - 'PWD': '/builds/slave/test', 17:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:27 INFO - 'SHELL': '/bin/bash', 17:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:27 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:27 INFO - 'USER': 'cltbld', 17:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:27 INFO - 'XPC_FLAGS': '0x0', 17:17:27 INFO - 'XPC_SERVICE_NAME': '0', 17:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:27 INFO - Downloading/unpacking flake8 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:32 INFO - no previously-included directories found matching 'docs/_build' 17:17:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:32 INFO - Running setup.py install for pep8 17:17:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:32 INFO - no previously-included directories found matching 'docs/_build' 17:17:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:32 INFO - Cleaning up... 17:17:32 INFO - Return code: 0 17:17:32 INFO - Running post-action listener: _resource_record_post_action 17:17:32 INFO - Running post-action listener: _start_resource_monitoring 17:17:32 INFO - Starting resource monitoring. 17:17:32 INFO - ##### 17:17:32 INFO - ##### Running install step. 17:17:32 INFO - ##### 17:17:32 INFO - Running pre-action listener: _resource_record_pre_action 17:17:32 INFO - Running main action method: install 17:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:32 INFO - Reading from file tmpfile_stdout 17:17:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:32 INFO - Reading from file tmpfile_stdout 17:17:32 INFO - Output received: 17:17:32 INFO - Usage: mozinstall [options] installer 17:17:32 INFO - Options: 17:17:32 INFO - -h, --help show this help message and exit 17:17:32 INFO - -d DEST, --destination=DEST 17:17:32 INFO - Directory to install application into. [default: 17:17:32 INFO - "/builds/slave/test"] 17:17:32 INFO - --app=APP Application being installed. [default: firefox] 17:17:32 INFO - mkdir: /builds/slave/test/build/application 17:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:17:54 INFO - Reading from file tmpfile_stdout 17:17:54 INFO - Output received: 17:17:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:17:54 INFO - Running post-action listener: _resource_record_post_action 17:17:54 INFO - ##### 17:17:54 INFO - ##### Running run-tests step. 17:17:54 INFO - ##### 17:17:54 INFO - Running pre-action listener: _resource_record_pre_action 17:17:54 INFO - Running main action method: run_tests 17:17:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:17:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:17:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:17:54 INFO - 2016-07-08 17:17:54.468 screenresolution[1647:7701] starting screenresolution argv=screenresolution get 17:17:54 INFO - 2016-07-08 17:17:54.470 screenresolution[1647:7701] Display 0: 1600x1200x32@60 17:17:54 INFO - 2016-07-08 17:17:54.476 screenresolution[1648:7703] starting screenresolution argv=screenresolution list 17:17:54 INFO - Available Modes on Display 0 17:17:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:17:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:17:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:17:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:17:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:17:54 INFO - Intel Iris: 17:17:54 INFO - Chipset Model: Intel Iris 17:17:54 INFO - Type: GPU 17:17:54 INFO - Bus: Built-In 17:17:54 INFO - VRAM (Dynamic, Max): 1536 MB 17:17:54 INFO - Vendor: Intel (0x8086) 17:17:54 INFO - Device ID: 0x0a2e 17:17:54 INFO - Revision ID: 0x0009 17:17:54 INFO - Displays: 17:17:54 INFO - Display: 17:17:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:17:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:17:54 INFO - Display Serial Number: 1600x1200 60 17:17:54 INFO - Main Display: Yes 17:17:54 INFO - Mirror: Off 17:17:54 INFO - Online: Yes 17:17:54 INFO - Rotation: Supported 17:17:54 INFO - Return code: 0 17:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:54 INFO - Python 2.7.3 17:17:54 INFO - Return code: 0 17:17:54 INFO - grabbing minidump binary from tooltool 17:17:54 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')]} 17:17:54 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 0x104472e00>, '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 0x1042dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10446db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:54 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 17:17:54 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 17:17:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:54 INFO - Return code: 0 17:17:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:17:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:17:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:17:55 INFO - Return code: 0 17:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 17:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0329 --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 17:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZPL7uFqFOA/Render', 17:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:55 INFO - 'HOME': '/Users/cltbld', 17:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:55 INFO - 'LOGNAME': 'cltbld', 17:17:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:55 INFO - 'MOZ_NO_REMOTE': '1', 17:17:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:55 INFO - 'NO_EM_RESTART': '1', 17:17:55 INFO - 'PAGER': '/bin/cat', 17:17:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:55 INFO - 'PWD': '/builds/slave/test', 17:17:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:55 INFO - 'SHELL': '/bin/bash', 17:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DyixFBTHli/Listeners', 17:17:55 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 17:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:55 INFO - 'USER': 'cltbld', 17:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:55 INFO - 'XPC_FLAGS': '0x0', 17:17:55 INFO - 'XPC_SERVICE_NAME': '0', 17:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 17:17:56 INFO - mozversion application_buildid: 20160708151127 17:17:56 INFO - mozversion application_changeset: cbacbb7c2c3523d036f737c9dc6c4406d14ade2b 17:17:56 INFO - mozversion application_display_name: Firefox 17:17:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:56 INFO - mozversion application_name: Firefox 17:17:56 INFO - mozversion application_remotingname: firefox 17:17:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:17:56 INFO - mozversion application_vendor: Mozilla 17:17:56 INFO - mozversion application_version: 48.0 17:17:56 INFO - mozversion platform_buildid: 20160708151127 17:17:56 INFO - mozversion platform_changeset: cbacbb7c2c3523d036f737c9dc6c4406d14ade2b 17:17:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:17:56 INFO - mozversion platform_version: 48.0 17:17:56 INFO - using testdate: 1468023476 17:17:56 INFO - actual date: 1468023476 17:17:56 INFO - starting webserver on 'localhost:49270' 17:17:56 INFO - SUITE-START | Running 2 tests 17:17:56 INFO - TEST-START | dromaeo_css 17:17:56 INFO - operating with platform_type : mac_ 17:17:56 INFO - Initialising browser for dromaeo_css test... 17:17:56 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp9V3MXo/profile http://localhost:49270/getInfo.html) 17:17:58 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:17:58 INFO - PROCESS | 1666 | colorDepth:24 17:17:58 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:17:58 INFO - PROCESS | 1666 | __metrics 17:17:59 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:17:59 INFO - TEST-INFO | 1666: exit 0 17:17:59 INFO - Browser initialized. 17:17:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:59 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp9V3MXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:11 INFO - PROCESS | 1670 | RSS: Main: 171298816 17:18:11 INFO - PROCESS | 1670 | 17:19:01 INFO - PROCESS | 1670 | 1468023541267 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] 17:21:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:21:12 INFO - PROCESS | 1670 | RSS: Main: 181903360 17:21:12 INFO - PROCESS | 1670 | 17:24:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:24:15 INFO - PROCESS | 1670 | RSS: Main: 192913408 17:24:15 INFO - PROCESS | 1670 | 17:27:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:27:17 INFO - PROCESS | 1670 | RSS: Main: 194863104 17:27:17 INFO - PROCESS | 1670 | 17:30:19 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:30:20 INFO - PROCESS | 1670 | RSS: Main: 198516736 17:30:20 INFO - PROCESS | 1670 | 17:33:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:33:23 INFO - PROCESS | 1670 | RSS: Main: 197623808 17:33:23 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:36:25 INFO - PROCESS | 1670 | RSS: Main: 202964992 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | __start_tp_report 17:36:25 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 17:36:25 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 17:36:25 INFO - PROCESS | 1670 | |i|pagename|runs| 17:36:25 INFO - PROCESS | 1670 | |0;dojo.html;3481.4603736420854;3670.082479380155;3676.8896933092014;3705.4256590228506;3718.2005868738224;5958.851028724284;5989.88020239595;5995.82012539624;5996.8800623987545;6044.365341639131;5868.823935281937;5922.733476993535;5956.8212953611355;5999.970000149993;6030.9396906030925;5297.788088476456;5331.306930099082;5331.733413329337;5417.674939503623;5426.701531415771;5286.841394758163;5314.415414304423;5350.3312085989255;5389.838304850841;5426.972865135669;5363.54409875161;5423.620346575742;5427.023135835548;5435.0488664483755;5440.782368705247;5386.353637563518;5403.540699040586;5418.078926582491;5423.430539793324;5458.836234912959;5202.219667049935;5212.947870521284;5283.841484755463;5293.422529431265;5341.545968592674;5693.060644993571;5801.854953626151;5839.416058394127;5847.883042339129;5879.1475236090955;6265.122882796412;6297.149884765544;6314.589551679126;6317.463015643676;6331.366863313678;6213.658248796314;6306.936930630681;6312.147860038928;6359.236891573041;6394.296627370985;6040.033594624839;6052.576319657625;6063.969680151659;6071.437485959587;6116.082587611894;6443.96778016107;6484.675766211671;6494.902576461357;6511.902321465182;6514.706838192293;5122.308488354099;5152.742362881841;5615.241942337814;6276.152719382825;6325.209348831396;5140.897182056413;6436.356364363526;6436.7425302988295;6438.034294855809;6440.838979025468;6153.138560601519;6207.844803879849;6248.156498872594;6271.843203919939;6308.905366419507;5415.862668839509;5968.671723055187;6279.183706118175;6310.495160387158;6331.715072821734;4244.511881133647;5038.370203724535;5039.974800125976;5073.720945347967;5080.644354895122;4496.752678602708;4502.16709908668;4551.3173024046655;4582.129395414927;4609.331646911179;5290.703777574442;6035.577509574287;6125.935851519034;6133.693315334215;6138.662373569497;6343.619382836952;6356.555041147168;6377.457916077093;6408.29508754046;6414.615123092536;6059.272887253558;6115.143879856823;6156.138140660311;6161.815145545641;6196.10156527301;5592.524635406036;5615.606907516435;5616.241807356037;5616.354119276254;5628.71856407178;6662.167229096363;6663.800085997428;6664.666766661648;6665.500087493458;6688.063671086052;5175.81884634036;6229.53278504123;6336.334684858023;6372.776952806629;6384.07430922523;6615.17310336208;6624.768133115318;6656.134702488645;6662.666866656745;6669.399754022162;6266.686665666607;6276;6286;6290.811275661737;6295.905561416674;5095.719735414587;6123.4351415035735;6141.731496609813;6289.874202516015;6371.108044873814;5320.787168513216;5980.611260268069;6128.233970753656;6235.220597425322;6236.563440559117;6133.120447061136;6235.657038862724;6238.563300568917;6247.750089996349;6262.342454042442;5991.108812618605;6107.206063211932;6113.567524283718;6167.198264225802;6238.563300568917;6200.844978875564;6214;6224.2842073160355;6238.844028899314;6246.718897649525;6054.606450580698;6126.639818174547;6217.222847144107;6250.906236406367;6252.124702541557 17:36:25 INFO - PROCESS | 1670 | |1;ext.html;539.175062154903;541.4558368839319;547.6741338903354;604.4197570332481;618.458848507556;33368.332633347316;40391.79804100979;40426.39360409596;40555;40679.389809152846;42256.9435764106;42321.788391058;42448.787756061254;42716.718498445094;42842;9474.336796424253;9693.418394896293;9693.982131876157;9699.9815019423;9746.269029822755;9581.760455988586;9705.805883882318;9758.804823903518;9760.511974401286;9771.316007879452;9794.216462682969;9805.264605154642;9827.606895724199;9833.70498885031;9867.753306167331;9794.706158815212;9800.362976406583;9810.215182785396;9842.753931151707;9923.751906202331;9756.512174391251;9856.753581160528;9858.457784821832;9860.408375497493;9875.60497580096;39788;40165.39751903724;40345.798271008454;40573.39139912904;40806.79596601998;2813.8030337876357;2881.985590072057;3264.9020529384156;3527.7001454876367;3784.3566593678866;28242;28521.144365669064;28753.56869646957;29918.55122173169;30226.244343891358;2723.7548620624043;2735.575985722216;2755.476459472714;2799.692033876272;2833.8583070846375;353582;354489;359277.2036139829;359560;360259;55748;56018.479168437516;62083.68958155271;62133.689331553054;62212;72284;73383.2661673387;73807.26192738004;74139;74151.62924185344;17902;17965.371212007518;18212.54468638268;18233.452996410128;18250.269989200282;13621.931890340486;13642.454301827816;13658.590242292747;13661.931690341484;13690.178589284675;20194.89902550478;20440.79559204389;20608.381748547567;20684.689729654066;20755.377338679864;7331.753601887692;7423.9628801856725;8589.914100859036;8762.342824288204;8766.517841518778;900.1718419054486;1025.2208321675432;1109.2567979453786;1128.7178205448638;1143.874173840877;29055.7094429053;30366.93715719939;31062.68937310643;31584;32096.67903320937;1104.304288298383;1141.4178768827958;1145.2269717940358;1225.4852961756085;1229.8155276708565;13963.511277105252;14784.408623655148;14950.551483455514;15065.472708455152;15347.386104555693;556985;666137;667858.6607066933;668811;672013;59903;60540;60633;60706.69646651827;60884.69557652184;1545.7604071368955;1554.4947891935167;1560.524040167737;1564.327339244136;1574.8661363784206;25901.740982590687;28562.42875142444;29104.708952911045;29708.405831883672;29889;52925;53183;53977.73011134919;54173;54175.18737218866;602179;602297;604759;604877;605618;26618.600720989587;26793.33016674599;26804.86597567078;26805;27374.315642109108;45277.320840188084;45671.314930276734;45712.771436142604;45980.31029534493;46903;36935.815320923226;38080.85757427281;38551.42172867353;38577.80711096426;39256.21487570176;37178.6282137186;37425;37529.249415011;38031.429528557645;38254;33243;37661.05847353728;37875.48498060157;37997.620023799405;38598.80700596479;32580.34839303248;34718.47922281218;34971;35066.47400288947;35465.290694186486;22227.555448891257;25084.24747257585;25152.49695006053;25326.366840829127;25592 17:36:25 INFO - PROCESS | 1670 | |2;jquery.html;408.3853800030953;409.39614069247847;410.57505481826314;411.81879972811964;420.5479109956795;18152.36466723665;20637.071331790066;21374.465638359048;21379.67930481044;21404.785952140475;20075.397738067844;20544.589108217864;20883.895580522116;21150;21246;5546.972265138689;5834.737436815353;6118.326984031775;6120.2043734314475;6125.111858780474;5870.148828419877;5874.030784920483;5949.434803693643;6037.2755269367735;6040.848978775522;5723.427657234285;5921.348651648315;5943;5993.670348130851;6022.608530445529;4959.8016079356785;5886.087656413263;5919.615225010382;5966.105084237356;6113.847153821145;4974.651774375795;5721.798422331315;5800.738966746464;5888.175655408247;5907.1434641976675;11868.465919033664;13477.921766258676;13811.240381778998;13895.444182232699;14149.929250353682;2147.0874878176714;2211.1155537784853;2249.167807911067;2317.9171701636783;2380.1074597026113;9561.521923903847;9850.90149098507;10065.849012264822;11554.884451155465;14638.243410790667;1556.3618916244286;1870.1023508715757;1884.7644044494439;1891.3474851176322;1894.3843250943498;118974;121060.18409723861;122322.99999999911;123280;124538.5092298149;9874.456904870158;10125.544350504246;11436.256643318324;11605.665348484863;11976.161668683282;13838.861611383958;14788.482403116055;15045.924770376298;15363.923180384027;15387.153706546023;7476.476646634684;8707.564621769014;8857.29141668665;9108.772280692903;9117.908820911838;8992.010878803327;9014.18872301496;9034.277257819358;9057.411268267542;9059.637614495477;4611.861644150681;4722.24444088951;4748.620110391161;4756.096341695067;4781.211100168433;1721.5610019445212;1732.2984191402502;1743.738439234125;1816.0465755478479;2072.471519762481;881.2949640287744;921.447131720962;1044.4516628769957;1051.9368837869752;1052.6421016854154;19685.901570492057;19704.01479925998;19979.300724474575;20152.395428136886;20325.898370508054;921.8110287391069;929.8512238041881;1032.5147180825;1046.398320965448;1090.6946055104584;7734.944696844715;10522.526486308134;10535.947320263349;10557.577696892038;10767.039064257391;529940;602637;616787;652101;657995;128424;129175.70824291637;131873.34063329623;132127.3393633045;135222;991.8197345159238;1001.9899801001897;1006.9496525173859;1008.4755926918108;1015.8476228565775;17557.956728969428;17739.37912173068;17741;17891.19489622944;18343.724844127082;42305.57694423016;50317.987280509835;50800.72998175075;51855.96288074142;53846.92306153933;73150;73852.89220661802;75107;75390;75649.86525202016;8111.310538604049;8162.510249385056;8220.917790822254;8318.292945099734;8539.615717292862;11964.605289321726;12450.875491244971;12563.371831408576;12705.555305564261;12836.55072072473;5416.783328666809;6825.624590647562;10222.335548189343;10723.94638026836;11039.460923987368;10734.194935380034;10761.784764304826;10843;11124.276922000045;11240.381779001906;10987.285826421257;11284.605038823931;11465.254758440675;11630.476628551905;11687.415629218674;8118.066422361504;8139.023317201973;8153.836923261383;8342.374321925758;8367.665293388196;8238.382121341043;10158.441285729356;10997.835032474679;11315.264507806965;11334.433278336215 17:36:25 INFO - PROCESS | 1670 | |3;mootools.html;1370.4929176204803;1497.08677706599;1830.9084545772716;1852.4998250472365;1859.5722983713745;8248;8939.284857211424;9106.99823019469;9391.62433502659;9398.624055037799;9073.63705451781;9105.726828195147;9156.175944165025;9158.86261706075;9180.954095229514;2556.297018319958;2568.9100881469153;2573.1637217904163;2591.8704064796684;2597.7012643546045;2520.080170737686;2600.414906645999;2602.4795040991785;2606;2618.5548456762394;2564.7948164146824;2583.3799888026833;2620.7379262073737;2626.304029432202;2632.3945492536727;2579.3422677217377;2584.1988983415204;2585.75435333643;2609.973900261011;2617.057859170697;2158.5467051919118;2547.7197508274076;2558.091877383539;2570.717221105677;2608.178423796498;9080.318976076755;9316.580753866092;9392.483413412328;9395.62417503299;9422.811543769154;4854.2233242681;5581.134924086773;5699.74351154199;5726.770929162829;5775.653460792366;3686.299603075407;3764.604716504782;3766.5480142382817;3817.4464702617965;3837.0982819037504;1063.670262218707;1074.623881641427;1089.096050278267;1121.114319687446;1124.8818874018193;12012.63962081139;12343.321117338453;12528.935040521566;12546.121771476;12548.74902501954;4217.662586993033;4904.852854414374;5036.521530454601;5088.262201980766;5127.769250383742;8826.735197944072;10309.53607087683;10538.57845686164;10579.735506612242;10589.311694739818;5556.277683901067;5634.352049514358;5662.065759149694;5707.258056452634;5735.627184233095;4593.586577208067;5009.724465154379;5117.488251174927;5131.204663277198;5173.870653233699;4226.323788193874;4227.8097485613225;4275.273203555403;4301.526832048472;4311.547287534827;1286.9704236610673;1322.8503681517534;1395.427874571421;1416.022944168541;1432.2051261549732;953.9666111686058;969.99030009699;989.5547003848297;1005.8491226316111;1008.863803386548;5922.466977971917;6014.699265036731;6039.335673075958;6109.266887973472;6150.231221097363;486.2536007228887;493.3487796109101;493.77533222383727;494.96287778416763;498.118330554923;3942.940855887164;3947.3289540778137;3976.741511801724;4000.659943904801;4059.5331536873637;10972.341659500296;11380.886191138148;11424.828627570592;11441.942790285995;11482.196246262849;10975.670729878117;11101.945315195044;11186.776264474665;11210.887891120985;11211.60759373418;8221.301189398848;8463.788405289793;8510.234078932926;8696.956515217384;8816.030236673962;5942.940570594239;5958.225430693982;6161.784337548164;6166.136740856374;6200.914839903089;8376.664933402595;9441.858372124287;9738.269629777653;9866.457344846101;9938.453385063602;9505.714828555154;9915;9988.250881183794;10048.648297309559;10056.899431005597;7058.858822823618;7548.320651141424;7725.420593455401;7731.497452665559;7808.063032436144;7157;8527.786805329917;8599.656013759379;8604.752310915008;8621.525816080175;7527.247275272429;7625.23747625233;7637.5035622684345;7648.65581048843;7770.145284018867;7419.332260096618;7469.141048779243;7496.8500629986;7546.735864244725;7559.924400755922;7186.425085993213;7232.276772322725;7237.384822290164;7269.600171990592;7292.489525733148;4975.278584605139;5020.422651395136;5060.240963855451;5138.691678499302;5169.715665638426;5123.6157288202785;5155.845324640267;5200.6879587224885;5330.653507521999;5354.4110147884485 17:36:25 INFO - PROCESS | 1670 | |4;prototype.html;334.72552506944305;336.8147518864624;337.7433150805387;345.1681447711017;346.67239458711526;7067.823304417392;7074.186468556118;7078.2921707829255;7084.539504932176;7140.214576396599;5570.637908535942;6964.8258793530185;6982.546134501254;6982.895256571142;7057.659044781488;4915.483874193212;5005.349304590398;5122.590192784568;5136.126858434075;5147.974260128694;5063.03802277568;5089.618278629099;5132.255822905677;5147.279380886679;5163.1480805667015;5104.2088476286235;5116.769745361467;5119.513646203604;5129.128048231791;5133.3326667533165;4155.9999999999845;5119.436861945183;5124.205748109049;5136.486351364871;5181.4041385240425;4412.977935110336;4430.202563538562;4438;4450.732956022649;4454.086912182995;6504.3820837020885;6782.559133656297;6782.694778734969;6822;6832.624205668686;5975.581709280352;6035.7887473938645;6046.697665116727;6046.848828779272;6054.061620448838;7465.328120469129;7505.812354691122;7561;7578.469507134503;7579;3973.5033120859894;4805.567498925114;4807.879803004917;4815.518448155191;4815.916418805776;7796.844063118706;7938.285554300141;7991.520508769492;8015.078265999368;8068.7175948841505;3986.9003274917777;4474.194644963938;4635.725175576744;4823.662343635982;4856.2958371036;4945.233488809168;4948.331975183376;4958.157113290749;4959.13215187348;4969.925451118236;5384.949934762683;5923.318818335861;5988.730507127189;5995.550333724901;6010;6866.622335771581;7612.505187162817;7640.694372225049;7650.923490765021;7658.846823063619;1398.321813920248;1664.525610201087;1743.2329774899258;1745.4501831922903;1745.5810605454599;1087.124864484098;1097.8902109788958;1099.571167244775;1106.1869525898458;1106.4523061084815;5418.783248670009;6133.417325354173;6457.096006559085;6758.831029224309;7183.461240406886;6945.583265004116;7155.642217889189;7527.661255243527;7743.845123097506;7839.921600784033;7196.640167991684;7214.042242680476;7246.891296630555;7301.123865136112;7307.926920730831;3702.185519185775;3865.9613403866165;4203.70574059819;4217.9033451302885;4223.239816832999;7420.925790742023;7766.87380329849;8413.116622754522;8425.325973922072;8432;7951.284384405316;8237.50574965504;8250.092489826115;8265.380096492787;8283.420160588701;8365.912431384002;8412.537310447862;8412.705555305534;8419.999999999878;8422.24199822019;7914.783860519064;7933.1670174630835;7940.325072368913;7946.801329966797;7954.323882470055;7513.211112833293;7804.492707973964;7825.608719563885;7827.099883513469;7877.054753429625;8413.368997325348;8422.326213902996;8431.578421079044;8433.36749743784;8444.324454043784;4889.3888263967;4932.4327702314695;4944.3572335596145;4953.777080031479;4959.553640172402;7919.841603167789;7931.2068793120225;7944.880826787718;7956.84086318282;7964.929118429366;5767.8558036049435;6128;7388.076490438695;7503.911932769827;7757.418193635613;7628.580428076509;7652.426068044808;7677.769666910001;7698.499597526143;7706.383489320953;7475.887861682188;7476.140243872024;7476.813079673052;7501.6249187539315;7510.248975102664;6221.813345599639;7594.658240379085;7604.809879752829;7660.425468089804;7700.653470593948;7237.131544214728;7492.063492063492;7492.887606686013;7509.47433679659;7528.20953799865 17:36:25 INFO - PROCESS | 1670 | |5;yui.html;718.7915504503693;726.9491135620507;728.5337384074194;749.5764892835551;790.7034861926782;15136.940414171013;15276.694466110672;15426.151561664105;15427.46003889864;15510.069395836244;13100.41048152833;14181.220032898187;14305.499307524238;14339.21134337611;14339.71320573588;953.132649289147;963.5808423335836;968.3657204531044;976.8730065091528;982.778874753182;929.5073610986154;958.7459323279337;966.21253678252;971.1745016735789;971.4220039076738;1018.8828284747275;1019.4953498018491;1023.3910823060268;1024.2932376660117;1024.8513965475001;976.6581696406237;1005.6379703306803;1012.9594816207343;1015.7714514234275;1017.760826205841;731.381982225019;738.2248638929103;757.0423414380813;764.6253335865385;764.9464537482379;13254.86745132546;13327;13460;13461.932690336584;13490.123141995738;12389.194702344319;12414.503419863195;12466.24550972377;12576.622701318975;12579.874201257962;11033.724156896062;11169;11286.774264514746;11485.94257028718;11545.884541154564;3240.675932406764;3322.7175690066374;4120.1553681495225;4149.97925010373;4420.3369494575745;70769.64615176943;78182;80080.59959700222;85424;87592;9675.951620241995;9794.314397992215;9803.313768036169;9945;10429.061384475433;21819.781802182093;21831.672524912137;21859.344219673436;21878.781212187994;21897.343079707633;7684.5773482459;7701.422393320523;7710.997570315823;7737.148913619498;7817.374610031184;4133.9793301033305;4150.664036687215;4181.958180418218;4190.497140343178;4326.978365108154;3664.1022949377575;3690.2435000825303;3698.4082546792383;3770.1517158639085;3770.792606406619;692.764460083574;702.7329614746363;721.3363705391052;727.4871215792854;736.694271877165;555.3141869790805;567.8637127089469;569.7208367899699;579.5305802300066;596.6777939912486;8060.8387832243025;8137.79655508617;8194.262516373556;8339.12439193876;8371;532.5233915645475;571.6570057965188;592.3839207224438;597.172915512019;598.0759726222909;3910.882673519799;3925.823337949799;3931.0565464288366;3997.340438827561;4052.77709725962;66855;69566;90102.54948725214;95447.2276386178;95766.52116739372;51432.74283628558;81265;82367.7644835328;82853.17146828576;83266;47869.5213047872;65066.02400963989;65541.34458655448;66424;66569.99999999903;8419.158084191531;8456.957715211385;8510.957445212734;8688.044315125204;8775.91224087751;47259.52740472689;49228;49849.252261215384;50092.499075010244;51665;55278;61120;68071.65964170148;69480.65259673669;70786;10867.51096200657;10882.727931801768;11155.386453745123;11160.665180044612;11293.830592540955;11570.305781653127;11642.883571164519;11886;12041.397930103285;12248.387580620754;11446.885531144582;11578.247413918405;11599.130065244972;11617.76764464689;11853.947923647622;9206.815863682823;11407.25852819564;11500.194986350874;11670;11826.822597661214;10967.561297548009;11056.060234880126;11068.28056176346;11190.496427660612;11842.28946263227;9430.764230894009;9575.521223938636;9635.22918166559;9850.162736167505;9884.950575247365;9307;9350.579223935076;9509.952450237704;9551.42691438516;9568.282378821477 17:36:25 INFO - PROCESS | 1670 | __end_tp_report 17:36:25 INFO - PROCESS | 1670 | __start_cc_report 17:36:25 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,394 17:36:25 INFO - PROCESS | 1670 | __end_cc_report 17:36:25 INFO - PROCESS | 1670 | __startTimestamp1468024585619__endTimestamp 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | ------- Summary: start ------- 17:36:25 INFO - PROCESS | 1670 | Number of tests: 6 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5865.00 Median:6116.08 stddev:649.72 (10.6%) stddev-sans-first:624.23 17:36:25 INFO - PROCESS | 1670 | Values: 3481.5 3670.1 3676.9 3705.4 3718.2 5958.9 5989.9 5995.8 5996.9 6044.4 5868.8 5922.7 5956.8 6000.0 6030.9 5297.8 5331.3 5331.7 5417.7 5426.7 5286.8 5314.4 5350.3 5389.8 5427.0 5363.5 5423.6 5427.0 5435.0 5440.8 5386.4 5403.5 5418.1 5423.4 5458.8 5202.2 5212.9 5283.8 5293.4 5341.5 5693.1 5801.9 5839.4 5847.9 5879.1 6265.1 6297.1 6314.6 6317.5 6331.4 6213.7 6306.9 6312.1 6359.2 6394.3 6040.0 6052.6 6064.0 6071.4 6116.1 6444.0 6484.7 6494.9 6511.9 6514.7 5122.3 5152.7 5615.2 6276.2 6325.2 5140.9 6436.4 6436.7 6438.0 6440.8 6153.1 6207.8 6248.2 6271.8 6308.9 5415.9 5968.7 6279.2 6310.5 6331.7 4244.5 5038.4 5040.0 5073.7 5080.6 4496.8 4502.2 4551.3 4582.1 4609.3 5290.7 6035.6 6125.9 6133.7 6138.7 6343.6 6356.6 6377.5 6408.3 6414.6 6059.3 6115.1 6156.1 6161.8 6196.1 5592.5 5615.6 5616.2 5616.4 5628.7 6662.2 6663.8 6664.7 6665.5 6688.1 5175.8 6229.5 6336.3 6372.8 6384.1 6615.2 6624.8 6656.1 6662.7 6669.4 6266.7 6276.0 6286.0 6290.8 6295.9 5095.7 6123.4 6141.7 6289.9 6371.1 5320.8 5980.6 6128.2 6235.2 6236.6 6133.1 6235.7 6238.6 6247.8 6262.3 5991.1 6107.2 6113.6 6167.2 6238.6 6200.8 6214.0 6224.3 6238.8 6246.7 6054.6 6126.6 6217.2 6250.9 6252.1 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:67925.53 Median:38402.71 stddev:147601.53 (384.4%) stddev-sans-first:147928.87 17:36:25 INFO - PROCESS | 1670 | Values: 539.2 541.5 547.7 604.4 618.5 33368.3 40391.8 40426.4 40555.0 40679.4 42256.9 42321.8 42448.8 42716.7 42842.0 9474.3 9693.4 9694.0 9700.0 9746.3 9581.8 9705.8 9758.8 9760.5 9771.3 9794.2 9805.3 9827.6 9833.7 9867.8 9794.7 9800.4 9810.2 9842.8 9923.8 9756.5 9856.8 9858.5 9860.4 9875.6 39788.0 40165.4 40345.8 40573.4 40806.8 2813.8 2882.0 3264.9 3527.7 3784.4 28242.0 28521.1 28753.6 29918.6 30226.2 2723.8 2735.6 2755.5 2799.7 2833.9 353582.0 354489.0 359277.2 359560.0 360259.0 55748.0 56018.5 62083.7 62133.7 62212.0 72284.0 73383.3 73807.3 74139.0 74151.6 17902.0 17965.4 18212.5 18233.5 18250.3 13621.9 13642.5 13658.6 13661.9 13690.2 20194.9 20440.8 20608.4 20684.7 20755.4 7331.8 7424.0 8589.9 8762.3 8766.5 900.2 1025.2 1109.3 1128.7 1143.9 29055.7 30366.9 31062.7 31584.0 32096.7 1104.3 1141.4 1145.2 1225.5 1229.8 13963.5 14784.4 14950.6 15065.5 15347.4 556985.0 666137.0 667858.7 668811.0 672013.0 59903.0 60540.0 60633.0 60706.7 60884.7 1545.8 1554.5 1560.5 1564.3 1574.9 25901.7 28562.4 29104.7 29708.4 29889.0 52925.0 53183.0 53977.7 54173.0 54175.2 602179.0 602297.0 604759.0 604877.0 605618.0 26618.6 26793.3 26804.9 26805.0 27374.3 45277.3 45671.3 45712.8 45980.3 46903.0 36935.8 38080.9 38551.4 38577.8 39256.2 37178.6 37425.0 37529.2 38031.4 38254.0 33243.0 37661.1 37875.5 37997.6 38598.8 32580.3 34718.5 34971.0 35066.5 35465.3 22227.6 25084.2 25152.5 25326.4 25592.0 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35027.87 Median:21377.07 stddev:102484.96 (479.4%) stddev-sans-first:102739.49 17:36:25 INFO - PROCESS | 1670 | Values: 408.4 409.4 410.6 411.8 420.5 18152.4 20637.1 21374.5 21379.7 21404.8 20075.4 20544.6 20883.9 21150.0 21246.0 5547.0 5834.7 6118.3 6120.2 6125.1 5870.1 5874.0 5949.4 6037.3 6040.8 5723.4 5921.3 5943.0 5993.7 6022.6 4959.8 5886.1 5919.6 5966.1 6113.8 4974.7 5721.8 5800.7 5888.2 5907.1 11868.5 13477.9 13811.2 13895.4 14149.9 2147.1 2211.1 2249.2 2317.9 2380.1 9561.5 9850.9 10065.8 11554.9 14638.2 1556.4 1870.1 1884.8 1891.3 1894.4 118974.0 121060.2 122323.0 123280.0 124538.5 9874.5 10125.5 11436.3 11605.7 11976.2 13838.9 14788.5 15045.9 15363.9 15387.2 7476.5 8707.6 8857.3 9108.8 9117.9 8992.0 9014.2 9034.3 9057.4 9059.6 4611.9 4722.2 4748.6 4756.1 4781.2 1721.6 1732.3 1743.7 1816.0 2072.5 881.3 921.4 1044.5 1051.9 1052.6 19685.9 19704.0 19979.3 20152.4 20325.9 921.8 929.9 1032.5 1046.4 1090.7 7734.9 10522.5 10535.9 10557.6 10767.0 529940.0 602637.0 616787.0 652101.0 657995.0 128424.0 129175.7 131873.3 132127.3 135222.0 991.8 1002.0 1006.9 1008.5 1015.8 17558.0 17739.4 17741.0 17891.2 18343.7 42305.6 50318.0 50800.7 51856.0 53846.9 73150.0 73852.9 75107.0 75390.0 75649.9 8111.3 8162.5 8220.9 8318.3 8539.6 11964.6 12450.9 12563.4 12705.6 12836.6 5416.8 6825.6 10222.3 10723.9 11039.5 10734.2 10761.8 10843.0 11124.3 11240.4 10987.3 11284.6 11465.3 11630.5 11687.4 8118.1 8139.0 8153.8 8342.4 8367.7 8238.4 10158.4 10997.8 11315.3 11334.4 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5908.63 Median:5048.38 stddev:3289.12 (65.2%) stddev-sans-first:3280.67 17:36:25 INFO - PROCESS | 1670 | Values: 1370.5 1497.1 1830.9 1852.5 1859.6 8248.0 8939.3 9107.0 9391.6 9398.6 9073.6 9105.7 9156.2 9158.9 9181.0 2556.3 2568.9 2573.2 2591.9 2597.7 2520.1 2600.4 2602.5 2606.0 2618.6 2564.8 2583.4 2620.7 2626.3 2632.4 2579.3 2584.2 2585.8 2610.0 2617.1 2158.5 2547.7 2558.1 2570.7 2608.2 9080.3 9316.6 9392.5 9395.6 9422.8 4854.2 5581.1 5699.7 5726.8 5775.7 3686.3 3764.6 3766.5 3817.4 3837.1 1063.7 1074.6 1089.1 1121.1 1124.9 12012.6 12343.3 12528.9 12546.1 12548.7 4217.7 4904.9 5036.5 5088.3 5127.8 8826.7 10309.5 10538.6 10579.7 10589.3 5556.3 5634.4 5662.1 5707.3 5735.6 4593.6 5009.7 5117.5 5131.2 5173.9 4226.3 4227.8 4275.3 4301.5 4311.5 1287.0 1322.9 1395.4 1416.0 1432.2 954.0 970.0 989.6 1005.8 1008.9 5922.5 6014.7 6039.3 6109.3 6150.2 486.3 493.3 493.8 495.0 498.1 3942.9 3947.3 3976.7 4000.7 4059.5 10972.3 11380.9 11424.8 11441.9 11482.2 10975.7 11101.9 11186.8 11210.9 11211.6 8221.3 8463.8 8510.2 8697.0 8816.0 5942.9 5958.2 6161.8 6166.1 6200.9 8376.7 9441.9 9738.3 9866.5 9938.5 9505.7 9915.0 9988.3 10048.6 10056.9 7058.9 7548.3 7725.4 7731.5 7808.1 7157.0 8527.8 8599.7 8604.8 8621.5 7527.2 7625.2 7637.5 7648.7 7770.1 7419.3 7469.1 7496.9 7546.7 7559.9 7186.4 7232.3 7237.4 7269.6 7292.5 4975.3 5020.4 5060.2 5138.7 5169.7 5123.6 5155.8 5200.7 5330.7 5354.4 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:6141.19 Median:6973.69 stddev:2037.29 (29.2%) stddev-sans-first:1995.85 17:36:25 INFO - PROCESS | 1670 | Values: 334.7 336.8 337.7 345.2 346.7 7067.8 7074.2 7078.3 7084.5 7140.2 5570.6 6964.8 6982.5 6982.9 7057.7 4915.5 5005.3 5122.6 5136.1 5148.0 5063.0 5089.6 5132.3 5147.3 5163.1 5104.2 5116.8 5119.5 5129.1 5133.3 4156.0 5119.4 5124.2 5136.5 5181.4 4413.0 4430.2 4438.0 4450.7 4454.1 6504.4 6782.6 6782.7 6822.0 6832.6 5975.6 6035.8 6046.7 6046.8 6054.1 7465.3 7505.8 7561.0 7578.5 7579.0 3973.5 4805.6 4807.9 4815.5 4815.9 7796.8 7938.3 7991.5 8015.1 8068.7 3986.9 4474.2 4635.7 4823.7 4856.3 4945.2 4948.3 4958.2 4959.1 4969.9 5384.9 5923.3 5988.7 5995.6 6010.0 6866.6 7612.5 7640.7 7650.9 7658.8 1398.3 1664.5 1743.2 1745.5 1745.6 1087.1 1097.9 1099.6 1106.2 1106.5 5418.8 6133.4 6457.1 6758.8 7183.5 6945.6 7155.6 7527.7 7743.8 7839.9 7196.6 7214.0 7246.9 7301.1 7307.9 3702.2 3866.0 4203.7 4217.9 4223.2 7420.9 7766.9 8413.1 8425.3 8432.0 7951.3 8237.5 8250.1 8265.4 8283.4 8365.9 8412.5 8412.7 8420.0 8422.2 7914.8 7933.2 7940.3 7946.8 7954.3 7513.2 7804.5 7825.6 7827.1 7877.1 8413.4 8422.3 8431.6 8433.4 8444.3 4889.4 4932.4 4944.4 4953.8 4959.6 7919.8 7931.2 7944.9 7956.8 7964.9 5767.9 6128.0 7388.1 7503.9 7757.4 7628.6 7652.4 7677.8 7698.5 7706.4 7475.9 7476.1 7476.8 7501.6 7510.2 6221.8 7594.7 7604.8 7660.4 7700.7 7237.1 7492.1 7492.9 7509.5 7528.2 17:36:25 INFO - PROCESS | 1670 | 17:36:25 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:17751.59 Median:26098.76 stddev:24500.12 (93.9%) stddev-sans-first:24535.47 17:36:25 INFO - PROCESS | 1670 | Values: 718.8 726.9 728.5 749.6 790.7 15136.9 15276.7 15426.2 15427.5 15510.1 13100.4 14181.2 14305.5 14339.2 14339.7 953.1 963.6 968.4 976.9 982.8 929.5 958.7 966.2 971.2 971.4 1018.9 1019.5 1023.4 1024.3 1024.9 976.7 1005.6 1013.0 1015.8 1017.8 731.4 738.2 757.0 764.6 764.9 13254.9 13327.0 13460.0 13461.9 13490.1 12389.2 12414.5 12466.2 12576.6 12579.9 11033.7 11169.0 11286.8 11485.9 11545.9 3240.7 3322.7 4120.2 4150.0 4420.3 70769.6 78182.0 80080.6 85424.0 87592.0 9676.0 9794.3 9803.3 9945.0 10429.1 21819.8 21831.7 21859.3 21878.8 21897.3 7684.6 7701.4 7711.0 7737.1 7817.4 4134.0 4150.7 4182.0 4190.5 4327.0 3664.1 3690.2 3698.4 3770.2 3770.8 692.8 702.7 721.3 727.5 736.7 555.3 567.9 569.7 579.5 596.7 8060.8 8137.8 8194.3 8339.1 8371.0 532.5 571.7 592.4 597.2 598.1 3910.9 3925.8 3931.1 3997.3 4052.8 66855.0 69566.0 90102.5 95447.2 95766.5 51432.7 81265.0 82367.8 82853.2 83266.0 47869.5 65066.0 65541.3 66424.0 66570.0 8419.2 8457.0 8511.0 8688.0 8775.9 47259.5 49228.0 49849.3 50092.5 51665.0 55278.0 61120.0 68071.7 69480.7 70786.0 10867.5 10882.7 11155.4 11160.7 11293.8 11570.3 11642.9 11886.0 12041.4 12248.4 11446.9 11578.2 11599.1 11617.8 11853.9 9206.8 11407.3 11500.2 11670.0 11826.8 10967.6 11056.1 11068.3 11190.5 11842.3 9430.8 9575.5 9635.2 9850.2 9885.0 9307.0 9350.6 9510.0 9551.4 9568.3 17:36:25 INFO - PROCESS | 1670 | -------- Summary: end -------- 17:36:25 INFO - PROCESS | 1670 | 17:36:26 INFO - TEST-INFO | 1670: exit 0 17:36:26 INFO - TEST-OK | dromaeo_css | took 1110007ms 17:36:26 INFO - TEST-START | kraken 17:36:26 INFO - operating with platform_type : mac_ 17:36:26 INFO - Initialising browser for kraken test... 17:36:26 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp4mTCj1/profile http://localhost:49270/getInfo.html) 17:36:28 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 17:36:28 INFO - PROCESS | 1680 | colorDepth:24 17:36:28 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 17:36:28 INFO - PROCESS | 1680 | __metrics 17:36:28 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:36:29 INFO - TEST-INFO | 1680: exit 0 17:36:29 INFO - Browser initialized. 17:36:29 INFO - Running cycle 1/1 for kraken test... 17:36:29 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp4mTCj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:41 INFO - PROCESS | 1684 | RSS: Main: 170930176 17:36:41 INFO - PROCESS | 1684 | 17:36:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:44 INFO - PROCESS | 1684 | RSS: Main: 183603200 17:36:44 INFO - PROCESS | 1684 | 17:36:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:36:47 INFO - PROCESS | 1684 | RSS: Main: 192720896 17:36:47 INFO - PROCESS | 1684 | 17:36:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:36:51 INFO - PROCESS | 1684 | RSS: Main: 196411392 17:36:51 INFO - PROCESS | 1684 | 17:36:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:36:54 INFO - PROCESS | 1684 | RSS: Main: 196100096 17:36:54 INFO - PROCESS | 1684 | 17:36:56 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:57 INFO - PROCESS | 1684 | RSS: Main: 197746688 17:36:57 INFO - PROCESS | 1684 | 17:37:00 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:00 INFO - PROCESS | 1684 | RSS: Main: 198750208 17:37:00 INFO - PROCESS | 1684 | 17:37:03 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:04 INFO - PROCESS | 1684 | RSS: Main: 198500352 17:37:04 INFO - PROCESS | 1684 | 17:37:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:37:07 INFO - PROCESS | 1684 | RSS: Main: 198615040 17:37:07 INFO - PROCESS | 1684 | 17:37:09 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:09 INFO - PROCESS | 1684 | RSS: Main: 197709824 17:37:09 INFO - PROCESS | 1684 | 17:37:11 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:12 INFO - PROCESS | 1684 | RSS: Main: 197746688 17:37:12 INFO - PROCESS | 1684 | 17:37:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:15 INFO - PROCESS | 1684 | RSS: Main: 197709824 17:37:15 INFO - PROCESS | 1684 | 17:37:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:18 INFO - PROCESS | 1684 | RSS: Main: 197902336 17:37:18 INFO - PROCESS | 1684 | 17:37:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:22 INFO - PROCESS | 1684 | RSS: Main: 197795840 17:37:22 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:37:24 INFO - PROCESS | 1684 | RSS: Main: 199835648 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | __start_tp_report 17:37:24 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 17:37:24 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 17:37:24 INFO - PROCESS | 1684 | |i|pagename|runs| 17:37:24 INFO - PROCESS | 1684 | |0;ai-astar;116;112;118;116;114;132;116;115;117;118 17:37:24 INFO - PROCESS | 1684 | |1;audio-beat-detection;154;123;143;151;118;137;118;150;184;104 17:37:24 INFO - PROCESS | 1684 | |2;audio-dft;197;197;199;270;195;214;192;197;199;198 17:37:24 INFO - PROCESS | 1684 | |3;audio-fft;59;75;77;139;63;64;94;96;160;83 17:37:24 INFO - PROCESS | 1684 | |4;audio-oscillator;80;83;121;77;81;88;123;81;83;121 17:37:24 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;86;88;86;108;129;90;89;91;86 17:37:24 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;149;97;96;94;106;95;94;94;95 17:37:24 INFO - PROCESS | 1684 | |7;imaging-desaturate;88;90;92;87;76;136;145;143;91;88 17:37:24 INFO - PROCESS | 1684 | |8;json-parse-financial;60;62;66;63;66;62;69;103;95;91 17:37:24 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;59;86;96;74;78;72;66;66;65 17:37:24 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;80;79;79;83;79;79;78;84;105;76 17:37:24 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;128;127;123;125;158;149;152;127;149;130 17:37:24 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;177;222;163;207;155;204;164;142;216;212 17:37:24 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;68;72;84;90;94;94;92;81;65;66 17:37:24 INFO - PROCESS | 1684 | __end_tp_report 17:37:24 INFO - PROCESS | 1684 | __start_cc_report 17:37:24 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1065 17:37:24 INFO - PROCESS | 1684 | __end_cc_report 17:37:24 INFO - PROCESS | 1684 | __startTimestamp1468024644451__endTimestamp 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | ------- Summary: start ------- 17:37:24 INFO - PROCESS | 1684 | Number of tests: 14 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:117.40 Median:116.50 stddev:5.44 (4.7%) stddev-sans-first:5.75 17:37:24 INFO - PROCESS | 1684 | Values: 116.0 112.0 118.0 116.0 114.0 132.0 116.0 115.0 117.0 118.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:146.50 stddev:23.31 (15.9%) stddev-sans-first:24.02 17:37:24 INFO - PROCESS | 1684 | Values: 154.0 123.0 143.0 151.0 118.0 137.0 118.0 150.0 184.0 104.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:205.80 Median:198.50 stddev:23.29 (11.7%) stddev-sans-first:24.48 17:37:24 INFO - PROCESS | 1684 | Values: 197.0 197.0 199.0 270.0 195.0 214.0 192.0 197.0 199.0 198.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:91.00 Median:76.00 stddev:33.59 (44.2%) stddev-sans-first:33.57 17:37:24 INFO - PROCESS | 1684 | Values: 59.0 75.0 77.0 139.0 63.0 64.0 94.0 96.0 160.0 83.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:81.00 stddev:19.44 (24.0%) stddev-sans-first:19.96 17:37:24 INFO - PROCESS | 1684 | Values: 80.0 83.0 121.0 77.0 81.0 88.0 123.0 81.0 83.0 121.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:88.50 stddev:13.84 (15.6%) stddev-sans-first:14.55 17:37:24 INFO - PROCESS | 1684 | Values: 89.0 86.0 88.0 86.0 108.0 129.0 90.0 89.0 91.0 86.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:94.50 stddev:17.12 (18.1%) stddev-sans-first:17.94 17:37:24 INFO - PROCESS | 1684 | Values: 94.0 149.0 97.0 96.0 94.0 106.0 95.0 94.0 94.0 95.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:88.00 stddev:26.50 (30.1%) stddev-sans-first:27.50 17:37:24 INFO - PROCESS | 1684 | Values: 88.0 90.0 92.0 87.0 76.0 136.0 145.0 143.0 91.0 88.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:73.70 Median:66.00 stddev:16.08 (24.4%) stddev-sans-first:16.28 17:37:24 INFO - PROCESS | 1684 | Values: 60.0 62.0 66.0 63.0 66.0 62.0 69.0 103.0 95.0 91.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:11.55 (15.8%) stddev-sans-first:11.62 17:37:24 INFO - PROCESS | 1684 | Values: 62.0 59.0 86.0 96.0 74.0 78.0 72.0 66.0 66.0 65.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:79.00 stddev:8.34 (10.6%) stddev-sans-first:8.80 17:37:24 INFO - PROCESS | 1684 | Values: 80.0 79.0 79.0 83.0 79.0 79.0 78.0 84.0 105.0 76.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:139.50 stddev:13.43 (9.6%) stddev-sans-first:13.86 17:37:24 INFO - PROCESS | 1684 | Values: 128.0 127.0 123.0 125.0 158.0 149.0 152.0 127.0 149.0 130.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:205.50 stddev:29.11 (14.2%) stddev-sans-first:30.69 17:37:24 INFO - PROCESS | 1684 | Values: 177.0 222.0 163.0 207.0 155.0 204.0 164.0 142.0 216.0 212.0 17:37:24 INFO - PROCESS | 1684 | 17:37:24 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.60 Median:87.00 stddev:11.92 (13.7%) stddev-sans-first:11.74 17:37:24 INFO - PROCESS | 1684 | Values: 68.0 72.0 84.0 90.0 94.0 94.0 92.0 81.0 65.0 66.0 17:37:24 INFO - PROCESS | 1684 | -------- Summary: end -------- 17:37:24 INFO - PROCESS | 1684 | 17:37:25 INFO - TEST-INFO | 1684: exit 0 17:37:25 INFO - TEST-OK | kraken | took 59237ms 17:37:25 INFO - SUITE-END | took 1169s 17:37:25 INFO - Completed test suite (00:19:29) 17:37:25 INFO - javascript benchmark 17:37:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.4603736420854, 3670.082479380155, 3676.8896933092014, 3705.4256590228506, 3718.2005868738224, 5958.851028724284, 5989.88020239595, 5995.82012539624, 5996.8800623987545, 6044.365341639131, 5868.823935281937, 5922.733476993535, 5956.8212953611355, 5999.970000149993, 6030.9396906030925, 5297.788088476456, 5331.306930099082, 5331.733413329337, 5417.674939503623, 5426.701531415771, 5286.841394758163, 5314.415414304423, 5350.3312085989255, 5389.838304850841, 5426.972865135669, 5363.54409875161, 5423.620346575742, 5427.023135835548, 5435.0488664483755, 5440.782368705247, 5386.353637563518, 5403.540699040586, 5418.078926582491, 5423.430539793324, 5458.836234912959, 5202.219667049935, 5212.947870521284, 5283.841484755463, 5293.422529431265, 5341.545968592674, 5693.060644993571, 5801.854953626151, 5839.416058394127, 5847.883042339129, 5879.1475236090955, 6265.122882796412, 6297.149884765544, 6314.589551679126, 6317.463015643676, 6331.366863313678, 6213.658248796314, 6306.936930630681, 6312.147860038928, 6359.236891573041, 6394.296627370985, 6040.033594624839, 6052.576319657625, 6063.969680151659, 6071.437485959587, 6116.082587611894, 6443.96778016107, 6484.675766211671, 6494.902576461357, 6511.902321465182, 6514.706838192293, 5122.308488354099, 5152.742362881841, 5615.241942337814, 6276.152719382825, 6325.209348831396, 5140.897182056413, 6436.356364363526, 6436.7425302988295, 6438.034294855809, 6440.838979025468, 6153.138560601519, 6207.844803879849, 6248.156498872594, 6271.843203919939, 6308.905366419507, 5415.862668839509, 5968.671723055187, 6279.183706118175, 6310.495160387158, 6331.715072821734, 4244.511881133647, 5038.370203724535, 5039.974800125976, 5073.720945347967, 5080.644354895122, 4496.752678602708, 4502.16709908668, 4551.3173024046655, 4582.129395414927, 4609.331646911179, 5290.703777574442, 6035.577509574287, 6125.935851519034, 6133.693315334215, 6138.662373569497, 6343.619382836952, 6356.555041147168, 6377.457916077093, 6408.29508754046, 6414.615123092536, 6059.272887253558, 6115.143879856823, 6156.138140660311, 6161.815145545641, 6196.10156527301, 5592.524635406036, 5615.606907516435, 5616.241807356037, 5616.354119276254, 5628.71856407178, 6662.167229096363, 6663.800085997428, 6664.666766661648, 6665.500087493458, 6688.063671086052, 5175.81884634036, 6229.53278504123, 6336.334684858023, 6372.776952806629, 6384.07430922523, 6615.17310336208, 6624.768133115318, 6656.134702488645, 6662.666866656745, 6669.399754022162, 6266.686665666607, 6276.0, 6286.0, 6290.811275661737, 6295.905561416674, 5095.719735414587, 6123.4351415035735, 6141.731496609813, 6289.874202516015, 6371.108044873814, 5320.787168513216, 5980.611260268069, 6128.233970753656, 6235.220597425322, 6236.563440559117, 6133.120447061136, 6235.657038862724, 6238.563300568917, 6247.750089996349, 6262.342454042442, 5991.108812618605, 6107.206063211932, 6113.567524283718, 6167.198264225802, 6238.563300568917, 6200.844978875564, 6214.0, 6224.2842073160355, 6238.844028899314, 6246.718897649525, 6054.606450580698, 6126.639818174547, 6217.222847144107, 6250.906236406367, 6252.124702541557], "value": 5827.885441216617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.175062154903, 541.4558368839319, 547.6741338903354, 604.4197570332481, 618.458848507556, 33368.332633347316, 40391.79804100979, 40426.39360409596, 40555.0, 40679.389809152846, 42256.9435764106, 42321.788391058, 42448.787756061254, 42716.718498445094, 42842.0, 9474.336796424253, 9693.418394896293, 9693.982131876157, 9699.9815019423, 9746.269029822755, 9581.760455988586, 9705.805883882318, 9758.804823903518, 9760.511974401286, 9771.316007879452, 9794.216462682969, 9805.264605154642, 9827.606895724199, 9833.70498885031, 9867.753306167331, 9794.706158815212, 9800.362976406583, 9810.215182785396, 9842.753931151707, 9923.751906202331, 9756.512174391251, 9856.753581160528, 9858.457784821832, 9860.408375497493, 9875.60497580096, 39788.0, 40165.39751903724, 40345.798271008454, 40573.39139912904, 40806.79596601998, 2813.8030337876357, 2881.985590072057, 3264.9020529384156, 3527.7001454876367, 3784.3566593678866, 28242.0, 28521.144365669064, 28753.56869646957, 29918.55122173169, 30226.244343891358, 2723.7548620624043, 2735.575985722216, 2755.476459472714, 2799.692033876272, 2833.8583070846375, 353582.0, 354489.0, 359277.2036139829, 359560.0, 360259.0, 55748.0, 56018.479168437516, 62083.68958155271, 62133.689331553054, 62212.0, 72284.0, 73383.2661673387, 73807.26192738004, 74139.0, 74151.62924185344, 17902.0, 17965.371212007518, 18212.54468638268, 18233.452996410128, 18250.269989200282, 13621.931890340486, 13642.454301827816, 13658.590242292747, 13661.931690341484, 13690.178589284675, 20194.89902550478, 20440.79559204389, 20608.381748547567, 20684.689729654066, 20755.377338679864, 7331.753601887692, 7423.9628801856725, 8589.914100859036, 8762.342824288204, 8766.517841518778, 900.1718419054486, 1025.2208321675432, 1109.2567979453786, 1128.7178205448638, 1143.874173840877, 29055.7094429053, 30366.93715719939, 31062.68937310643, 31584.0, 32096.67903320937, 1104.304288298383, 1141.4178768827958, 1145.2269717940358, 1225.4852961756085, 1229.8155276708565, 13963.511277105252, 14784.408623655148, 14950.551483455514, 15065.472708455152, 15347.386104555693, 556985.0, 666137.0, 667858.6607066933, 668811.0, 672013.0, 59903.0, 60540.0, 60633.0, 60706.69646651827, 60884.69557652184, 1545.7604071368955, 1554.4947891935167, 1560.524040167737, 1564.327339244136, 1574.8661363784206, 25901.740982590687, 28562.42875142444, 29104.708952911045, 29708.405831883672, 29889.0, 52925.0, 53183.0, 53977.73011134919, 54173.0, 54175.18737218866, 602179.0, 602297.0, 604759.0, 604877.0, 605618.0, 26618.600720989587, 26793.33016674599, 26804.86597567078, 26805.0, 27374.315642109108, 45277.320840188084, 45671.314930276734, 45712.771436142604, 45980.31029534493, 46903.0, 36935.815320923226, 38080.85757427281, 38551.42172867353, 38577.80711096426, 39256.21487570176, 37178.6282137186, 37425.0, 37529.249415011, 38031.429528557645, 38254.0, 33243.0, 37661.05847353728, 37875.48498060157, 37997.620023799405, 38598.80700596479, 32580.34839303248, 34718.47922281218, 34971.0, 35066.47400288947, 35465.290694186486, 22227.555448891257, 25084.24747257585, 25152.49695006053, 25326.366840829127, 25592.0], "value": 20242.222266521887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.3853800030953, 409.39614069247847, 410.57505481826314, 411.81879972811964, 420.5479109956795, 18152.36466723665, 20637.071331790066, 21374.465638359048, 21379.67930481044, 21404.785952140475, 20075.397738067844, 20544.589108217864, 20883.895580522116, 21150.0, 21246.0, 5546.972265138689, 5834.737436815353, 6118.326984031775, 6120.2043734314475, 6125.111858780474, 5870.148828419877, 5874.030784920483, 5949.434803693643, 6037.2755269367735, 6040.848978775522, 5723.427657234285, 5921.348651648315, 5943.0, 5993.670348130851, 6022.608530445529, 4959.8016079356785, 5886.087656413263, 5919.615225010382, 5966.105084237356, 6113.847153821145, 4974.651774375795, 5721.798422331315, 5800.738966746464, 5888.175655408247, 5907.1434641976675, 11868.465919033664, 13477.921766258676, 13811.240381778998, 13895.444182232699, 14149.929250353682, 2147.0874878176714, 2211.1155537784853, 2249.167807911067, 2317.9171701636783, 2380.1074597026113, 9561.521923903847, 9850.90149098507, 10065.849012264822, 11554.884451155465, 14638.243410790667, 1556.3618916244286, 1870.1023508715757, 1884.7644044494439, 1891.3474851176322, 1894.3843250943498, 118974.0, 121060.18409723861, 122322.99999999911, 123280.0, 124538.5092298149, 9874.456904870158, 10125.544350504246, 11436.256643318324, 11605.665348484863, 11976.161668683282, 13838.861611383958, 14788.482403116055, 15045.924770376298, 15363.923180384027, 15387.153706546023, 7476.476646634684, 8707.564621769014, 8857.29141668665, 9108.772280692903, 9117.908820911838, 8992.010878803327, 9014.18872301496, 9034.277257819358, 9057.411268267542, 9059.637614495477, 4611.861644150681, 4722.24444088951, 4748.620110391161, 4756.096341695067, 4781.211100168433, 1721.5610019445212, 1732.2984191402502, 1743.738439234125, 1816.0465755478479, 2072.471519762481, 881.2949640287744, 921.447131720962, 1044.4516628769957, 1051.9368837869752, 1052.6421016854154, 19685.901570492057, 19704.01479925998, 19979.300724474575, 20152.395428136886, 20325.898370508054, 921.8110287391069, 929.8512238041881, 1032.5147180825, 1046.398320965448, 1090.6946055104584, 7734.944696844715, 10522.526486308134, 10535.947320263349, 10557.577696892038, 10767.039064257391, 529940.0, 602637.0, 616787.0, 652101.0, 657995.0, 128424.0, 129175.70824291637, 131873.34063329623, 132127.3393633045, 135222.0, 991.8197345159238, 1001.9899801001897, 1006.9496525173859, 1008.4755926918108, 1015.8476228565775, 17557.956728969428, 17739.37912173068, 17741.0, 17891.19489622944, 18343.724844127082, 42305.57694423016, 50317.987280509835, 50800.72998175075, 51855.96288074142, 53846.92306153933, 73150.0, 73852.89220661802, 75107.0, 75390.0, 75649.86525202016, 8111.310538604049, 8162.510249385056, 8220.917790822254, 8318.292945099734, 8539.615717292862, 11964.605289321726, 12450.875491244971, 12563.371831408576, 12705.555305564261, 12836.55072072473, 5416.783328666809, 6825.624590647562, 10222.335548189343, 10723.94638026836, 11039.460923987368, 10734.194935380034, 10761.784764304826, 10843.0, 11124.276922000045, 11240.381779001906, 10987.285826421257, 11284.605038823931, 11465.254758440675, 11630.476628551905, 11687.415629218674, 8118.066422361504, 8139.023317201973, 8153.836923261383, 8342.374321925758, 8367.665293388196, 8238.382121341043, 10158.441285729356, 10997.835032474679, 11315.264507806965, 11334.433278336215], "value": 9392.280016433464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.4929176204803, 1497.08677706599, 1830.9084545772716, 1852.4998250472365, 1859.5722983713745, 8248.0, 8939.284857211424, 9106.99823019469, 9391.62433502659, 9398.624055037799, 9073.63705451781, 9105.726828195147, 9156.175944165025, 9158.86261706075, 9180.954095229514, 2556.297018319958, 2568.9100881469153, 2573.1637217904163, 2591.8704064796684, 2597.7012643546045, 2520.080170737686, 2600.414906645999, 2602.4795040991785, 2606.0, 2618.5548456762394, 2564.7948164146824, 2583.3799888026833, 2620.7379262073737, 2626.304029432202, 2632.3945492536727, 2579.3422677217377, 2584.1988983415204, 2585.75435333643, 2609.973900261011, 2617.057859170697, 2158.5467051919118, 2547.7197508274076, 2558.091877383539, 2570.717221105677, 2608.178423796498, 9080.318976076755, 9316.580753866092, 9392.483413412328, 9395.62417503299, 9422.811543769154, 4854.2233242681, 5581.134924086773, 5699.74351154199, 5726.770929162829, 5775.653460792366, 3686.299603075407, 3764.604716504782, 3766.5480142382817, 3817.4464702617965, 3837.0982819037504, 1063.670262218707, 1074.623881641427, 1089.096050278267, 1121.114319687446, 1124.8818874018193, 12012.63962081139, 12343.321117338453, 12528.935040521566, 12546.121771476, 12548.74902501954, 4217.662586993033, 4904.852854414374, 5036.521530454601, 5088.262201980766, 5127.769250383742, 8826.735197944072, 10309.53607087683, 10538.57845686164, 10579.735506612242, 10589.311694739818, 5556.277683901067, 5634.352049514358, 5662.065759149694, 5707.258056452634, 5735.627184233095, 4593.586577208067, 5009.724465154379, 5117.488251174927, 5131.204663277198, 5173.870653233699, 4226.323788193874, 4227.8097485613225, 4275.273203555403, 4301.526832048472, 4311.547287534827, 1286.9704236610673, 1322.8503681517534, 1395.427874571421, 1416.022944168541, 1432.2051261549732, 953.9666111686058, 969.99030009699, 989.5547003848297, 1005.8491226316111, 1008.863803386548, 5922.466977971917, 6014.699265036731, 6039.335673075958, 6109.266887973472, 6150.231221097363, 486.2536007228887, 493.3487796109101, 493.77533222383727, 494.96287778416763, 498.118330554923, 3942.940855887164, 3947.3289540778137, 3976.741511801724, 4000.659943904801, 4059.5331536873637, 10972.341659500296, 11380.886191138148, 11424.828627570592, 11441.942790285995, 11482.196246262849, 10975.670729878117, 11101.945315195044, 11186.776264474665, 11210.887891120985, 11211.60759373418, 8221.301189398848, 8463.788405289793, 8510.234078932926, 8696.956515217384, 8816.030236673962, 5942.940570594239, 5958.225430693982, 6161.784337548164, 6166.136740856374, 6200.914839903089, 8376.664933402595, 9441.858372124287, 9738.269629777653, 9866.457344846101, 9938.453385063602, 9505.714828555154, 9915.0, 9988.250881183794, 10048.648297309559, 10056.899431005597, 7058.858822823618, 7548.320651141424, 7725.420593455401, 7731.497452665559, 7808.063032436144, 7157.0, 8527.786805329917, 8599.656013759379, 8604.752310915008, 8621.525816080175, 7527.247275272429, 7625.23747625233, 7637.5035622684345, 7648.65581048843, 7770.145284018867, 7419.332260096618, 7469.141048779243, 7496.8500629986, 7546.735864244725, 7559.924400755922, 7186.425085993213, 7232.276772322725, 7237.384822290164, 7269.600171990592, 7292.489525733148, 4975.278584605139, 5020.422651395136, 5060.240963855451, 5138.691678499302, 5169.715665638426, 5123.6157288202785, 5155.845324640267, 5200.6879587224885, 5330.653507521999, 5354.4110147884485], "value": 4709.981694924018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.72552506944305, 336.8147518864624, 337.7433150805387, 345.1681447711017, 346.67239458711526, 7067.823304417392, 7074.186468556118, 7078.2921707829255, 7084.539504932176, 7140.214576396599, 5570.637908535942, 6964.8258793530185, 6982.546134501254, 6982.895256571142, 7057.659044781488, 4915.483874193212, 5005.349304590398, 5122.590192784568, 5136.126858434075, 5147.974260128694, 5063.03802277568, 5089.618278629099, 5132.255822905677, 5147.279380886679, 5163.1480805667015, 5104.2088476286235, 5116.769745361467, 5119.513646203604, 5129.128048231791, 5133.3326667533165, 4155.9999999999845, 5119.436861945183, 5124.205748109049, 5136.486351364871, 5181.4041385240425, 4412.977935110336, 4430.202563538562, 4438.0, 4450.732956022649, 4454.086912182995, 6504.3820837020885, 6782.559133656297, 6782.694778734969, 6822.0, 6832.624205668686, 5975.581709280352, 6035.7887473938645, 6046.697665116727, 6046.848828779272, 6054.061620448838, 7465.328120469129, 7505.812354691122, 7561.0, 7578.469507134503, 7579.0, 3973.5033120859894, 4805.567498925114, 4807.879803004917, 4815.518448155191, 4815.916418805776, 7796.844063118706, 7938.285554300141, 7991.520508769492, 8015.078265999368, 8068.7175948841505, 3986.9003274917777, 4474.194644963938, 4635.725175576744, 4823.662343635982, 4856.2958371036, 4945.233488809168, 4948.331975183376, 4958.157113290749, 4959.13215187348, 4969.925451118236, 5384.949934762683, 5923.318818335861, 5988.730507127189, 5995.550333724901, 6010.0, 6866.622335771581, 7612.505187162817, 7640.694372225049, 7650.923490765021, 7658.846823063619, 1398.321813920248, 1664.525610201087, 1743.2329774899258, 1745.4501831922903, 1745.5810605454599, 1087.124864484098, 1097.8902109788958, 1099.571167244775, 1106.1869525898458, 1106.4523061084815, 5418.783248670009, 6133.417325354173, 6457.096006559085, 6758.831029224309, 7183.461240406886, 6945.583265004116, 7155.642217889189, 7527.661255243527, 7743.845123097506, 7839.921600784033, 7196.640167991684, 7214.042242680476, 7246.891296630555, 7301.123865136112, 7307.926920730831, 3702.185519185775, 3865.9613403866165, 4203.70574059819, 4217.9033451302885, 4223.239816832999, 7420.925790742023, 7766.87380329849, 8413.116622754522, 8425.325973922072, 8432.0, 7951.284384405316, 8237.50574965504, 8250.092489826115, 8265.380096492787, 8283.420160588701, 8365.912431384002, 8412.537310447862, 8412.705555305534, 8419.999999999878, 8422.24199822019, 7914.783860519064, 7933.1670174630835, 7940.325072368913, 7946.801329966797, 7954.323882470055, 7513.211112833293, 7804.492707973964, 7825.608719563885, 7827.099883513469, 7877.054753429625, 8413.368997325348, 8422.326213902996, 8431.578421079044, 8433.36749743784, 8444.324454043784, 4889.3888263967, 4932.4327702314695, 4944.3572335596145, 4953.777080031479, 4959.553640172402, 7919.841603167789, 7931.2068793120225, 7944.880826787718, 7956.84086318282, 7964.929118429366, 5767.8558036049435, 6128.0, 7388.076490438695, 7503.911932769827, 7757.418193635613, 7628.580428076509, 7652.426068044808, 7677.769666910001, 7698.499597526143, 7706.383489320953, 7475.887861682188, 7476.140243872024, 7476.813079673052, 7501.6249187539315, 7510.248975102664, 6221.813345599639, 7594.658240379085, 7604.809879752829, 7660.425468089804, 7700.653470593948, 7237.131544214728, 7492.063492063492, 7492.887606686013, 7509.47433679659, 7528.20953799865], "value": 5454.808804861103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.7915504503693, 726.9491135620507, 728.5337384074194, 749.5764892835551, 790.7034861926782, 15136.940414171013, 15276.694466110672, 15426.151561664105, 15427.46003889864, 15510.069395836244, 13100.41048152833, 14181.220032898187, 14305.499307524238, 14339.21134337611, 14339.71320573588, 953.132649289147, 963.5808423335836, 968.3657204531044, 976.8730065091528, 982.778874753182, 929.5073610986154, 958.7459323279337, 966.21253678252, 971.1745016735789, 971.4220039076738, 1018.8828284747275, 1019.4953498018491, 1023.3910823060268, 1024.2932376660117, 1024.8513965475001, 976.6581696406237, 1005.6379703306803, 1012.9594816207343, 1015.7714514234275, 1017.760826205841, 731.381982225019, 738.2248638929103, 757.0423414380813, 764.6253335865385, 764.9464537482379, 13254.86745132546, 13327.0, 13460.0, 13461.932690336584, 13490.123141995738, 12389.194702344319, 12414.503419863195, 12466.24550972377, 12576.622701318975, 12579.874201257962, 11033.724156896062, 11169.0, 11286.774264514746, 11485.94257028718, 11545.884541154564, 3240.675932406764, 3322.7175690066374, 4120.1553681495225, 4149.97925010373, 4420.3369494575745, 70769.64615176943, 78182.0, 80080.59959700222, 85424.0, 87592.0, 9675.951620241995, 9794.314397992215, 9803.313768036169, 9945.0, 10429.061384475433, 21819.781802182093, 21831.672524912137, 21859.344219673436, 21878.781212187994, 21897.343079707633, 7684.5773482459, 7701.422393320523, 7710.997570315823, 7737.148913619498, 7817.374610031184, 4133.9793301033305, 4150.664036687215, 4181.958180418218, 4190.497140343178, 4326.978365108154, 3664.1022949377575, 3690.2435000825303, 3698.4082546792383, 3770.1517158639085, 3770.792606406619, 692.764460083574, 702.7329614746363, 721.3363705391052, 727.4871215792854, 736.694271877165, 555.3141869790805, 567.8637127089469, 569.7208367899699, 579.5305802300066, 596.6777939912486, 8060.8387832243025, 8137.79655508617, 8194.262516373556, 8339.12439193876, 8371.0, 532.5233915645475, 571.6570057965188, 592.3839207224438, 597.172915512019, 598.0759726222909, 3910.882673519799, 3925.823337949799, 3931.0565464288366, 3997.340438827561, 4052.77709725962, 66855.0, 69566.0, 90102.54948725214, 95447.2276386178, 95766.52116739372, 51432.74283628558, 81265.0, 82367.7644835328, 82853.17146828576, 83266.0, 47869.5213047872, 65066.02400963989, 65541.34458655448, 66424.0, 66569.99999999903, 8419.158084191531, 8456.957715211385, 8510.957445212734, 8688.044315125204, 8775.91224087751, 47259.52740472689, 49228.0, 49849.252261215384, 50092.499075010244, 51665.0, 55278.0, 61120.0, 68071.65964170148, 69480.65259673669, 70786.0, 10867.51096200657, 10882.727931801768, 11155.386453745123, 11160.665180044612, 11293.830592540955, 11570.305781653127, 11642.883571164519, 11886.0, 12041.397930103285, 12248.387580620754, 11446.885531144582, 11578.247413918405, 11599.130065244972, 11617.76764464689, 11853.947923647622, 9206.815863682823, 11407.25852819564, 11500.194986350874, 11670.0, 11826.822597661214, 10967.561297548009, 11056.060234880126, 11068.28056176346, 11190.496427660612, 11842.28946263227, 9430.764230894009, 9575.521223938636, 9635.22918166559, 9850.162736167505, 9884.950575247365, 9307.0, 9350.579223935076, 9509.952450237704, 9551.42691438516, 9568.282378821477], "value": 6999.017984978436, "unit": "score"}], "name": "dromaeo_css", "value": 7642.495682098359, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 118.0, 116.0, 114.0, 132.0, 116.0, 115.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 143.0, 151.0, 118.0, 137.0, 118.0, 150.0, 184.0, 104.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 199.0, 270.0, 195.0, 214.0, 192.0, 197.0, 199.0, 198.0], "value": 205.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 75.0, 77.0, 139.0, 63.0, 64.0, 94.0, 96.0, 160.0, 83.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 121.0, 77.0, 81.0, 88.0, 123.0, 81.0, 83.0, 121.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 108.0, 129.0, 90.0, 89.0, 91.0, 86.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 149.0, 97.0, 96.0, 94.0, 106.0, 95.0, 94.0, 94.0, 95.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 92.0, 87.0, 76.0, 136.0, 145.0, 143.0, 91.0, 88.0], "value": 103.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 66.0, 63.0, 66.0, 62.0, 69.0, 103.0, 95.0, 91.0], "value": 73.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 86.0, 96.0, 74.0, 78.0, 72.0, 66.0, 66.0, 65.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 83.0, 79.0, 79.0, 78.0, 84.0, 105.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 123.0, 125.0, 158.0, 149.0, 152.0, 127.0, 149.0, 130.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 222.0, 163.0, 207.0, 155.0, 204.0, 164.0, 142.0, 216.0, 212.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 84.0, 90.0, 94.0, 94.0, 92.0, 81.0, 65.0, 66.0], "value": 80.6, "unit": "score"}], "name": "kraken", "value": 1577.3, "alertThreshold": 2.0}]} 17:37:25 INFO - Return code: 0 17:37:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:25 ERROR - # TBPL SUCCESS # 17:37:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:25 INFO - 2016-07-08 17:37:25.783 screenresolution[1689:10643] starting screenresolution argv=screenresolution get 17:37:25 INFO - 2016-07-08 17:37:25.786 screenresolution[1689:10643] Display 0: 1600x1200x32@60 17:37:25 INFO - 2016-07-08 17:37:25.792 screenresolution[1690:10646] starting screenresolution argv=screenresolution list 17:37:25 INFO - Available Modes on Display 0 17:37:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:26 INFO - Intel Iris: 17:37:26 INFO - Chipset Model: Intel Iris 17:37:26 INFO - Type: GPU 17:37:26 INFO - Bus: Built-In 17:37:26 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:26 INFO - Vendor: Intel (0x8086) 17:37:26 INFO - Device ID: 0x0a2e 17:37:26 INFO - Revision ID: 0x0009 17:37:26 INFO - Displays: 17:37:26 INFO - Display: 17:37:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:26 INFO - Display Serial Number: 1600x1200 60 17:37:26 INFO - Main Display: Yes 17:37:26 INFO - Mirror: Off 17:37:26 INFO - Online: Yes 17:37:26 INFO - Rotation: Supported 17:37:26 INFO - Return code: 0 17:37:26 INFO - Running post-action listener: _resource_record_post_action 17:37:26 INFO - Running post-run listener: _resource_record_post_run 17:37:27 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31501824; Write bytes: 497353216; Read time: 195; Write time: 1659 17:37:27 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194904576; Write bytes: 198391808; Read time: 17593; Write time: 472 17:37:27 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29711872; Write bytes: 298109440; Read time: 180; Write time: 1184 17:37:27 INFO - Running post-run listener: _upload_blobber_files 17:37:27 INFO - Blob upload gear active. 17:37:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:27 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 17:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:27 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:28 INFO - (blobuploader) - INFO - Done attempting. 17:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:29 INFO - (blobuploader) - INFO - Done attempting. 17:37:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:29 INFO - Return code: 0 17:37:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d02208115da3b94076a9d2a678541b8cdae2943b67ac9828953bb5f2149313e7d05dd5e31706b7bdd1d679adb49eab769809dfc1d49e5d3120b0f63657169a3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5ab8fc16be6e56838d49b0d243e6dd494bb790e842a672a8aaf9f22275706d193c10273b30fb6c220106a121aacfbd8271ac5983eba082d7bd11182c6452761"} 17:37:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:29 INFO - Contents: 17:37:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d02208115da3b94076a9d2a678541b8cdae2943b67ac9828953bb5f2149313e7d05dd5e31706b7bdd1d679adb49eab769809dfc1d49e5d3120b0f63657169a3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5ab8fc16be6e56838d49b0d243e6dd494bb790e842a672a8aaf9f22275706d193c10273b30fb6c220106a121aacfbd8271ac5983eba082d7bd11182c6452761"} 17:37:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:29 INFO - Copying logs to upload dir... 17:37:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.607998 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-08 17:37:29.606137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:37:29.610145) ========= 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.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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/Mozilla-Beta/sha512/d02208115da3b94076a9d2a678541b8cdae2943b67ac9828953bb5f2149313e7d05dd5e31706b7bdd1d679adb49eab769809dfc1d49e5d3120b0f63657169a3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5ab8fc16be6e56838d49b0d243e6dd494bb790e842a672a8aaf9f22275706d193c10273b30fb6c220106a121aacfbd8271ac5983eba082d7bd11182c6452761"} build_url:https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/CTeUfv0WTjK9VCdmkVQLpg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d02208115da3b94076a9d2a678541b8cdae2943b67ac9828953bb5f2149313e7d05dd5e31706b7bdd1d679adb49eab769809dfc1d49e5d3120b0f63657169a3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5ab8fc16be6e56838d49b0d243e6dd494bb790e842a672a8aaf9f22275706d193c10273b30fb6c220106a121aacfbd8271ac5983eba082d7bd11182c6452761"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:37:29.642563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:37:29.642942) ========= 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.ZPL7uFqFOA/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.DyixFBTHli/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.005204 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:37:29.691669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:37:29.692030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:37:29.692367) ========= ========= Total master_lag: 0.35 =========