builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0012 starttime: 1462479016.9 results: success (0) buildid: 20160505111245 builduid: 31ab4dd2d787434cab92eb6288883602 revision: eac275b1daa5b926efe9525d9ad08ebd23e6cf2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:16.899777) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:16.900207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:16.900482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:16.920390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:16.920985) ========= 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.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-05 13:10:16-- 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% 9.48M=0.001s 2016-05-05 13:10:17 (9.48 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:17.036381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:17.036706) ========= 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.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.027548 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:17.194864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 13:10:17.195234) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev eac275b1daa5b926efe9525d9ad08ebd23e6cf2b --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 eac275b1daa5b926efe9525d9ad08ebd23e6cf2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-05 13:10:17,270 truncating revision to first 12 chars 2016-05-05 13:10:17,270 Setting DEBUG logging. 2016-05-05 13:10:17,270 attempt 1/10 2016-05-05 13:10:17,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/eac275b1daa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 13:10:18,293 unpacking tar archive at: mozilla-beta-eac275b1daa5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 13:10:18.486264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:18.486584) ========= script_repo_revision: eac275b1daa5b926efe9525d9ad08ebd23e6cf2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:18.486977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:18.487240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:10:18.500892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-05 13:10:18.501183) ========= /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.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:18 INFO - MultiFileLogger online at 20160505 13:10:18 in /builds/slave/test 13:10:18 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 13:10:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:10:18 INFO - {'append_to_log': False, 13:10:18 INFO - 'base_work_dir': '/builds/slave/test', 13:10:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:10:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:10:18 INFO - 'branch': 'Mozilla-Beta', 13:10:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:18 INFO - 'config_files': ('talos/mac_config.py',), 13:10:18 INFO - 'default_actions': ('clobber', 13:10:18 INFO - 'read-buildbot-config', 13:10:18 INFO - 'download-and-extract', 13:10:18 INFO - 'populate-webroot', 13:10:18 INFO - 'create-virtualenv', 13:10:18 INFO - 'install', 13:10:18 INFO - 'run-tests'), 13:10:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:18 INFO - 'download_minidump_stackwalk': True, 13:10:18 INFO - 'download_symbols': 'ondemand', 13:10:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:18 INFO - 'installer_path': 'installer.exe', 13:10:18 INFO - 'log_level': 'info', 13:10:18 INFO - 'log_name': 'talos', 13:10:18 INFO - 'log_to_console': True, 13:10:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:10:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:10:18 INFO - 'opt_config_files': (), 13:10:18 INFO - 'pip_index': False, 13:10:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:10:18 INFO - 'cmd': ('bash', 13:10:18 INFO - '-c', 13:10:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:10:18 INFO - 'enabled': True, 13:10:18 INFO - 'halt_on_failure': False, 13:10:18 INFO - 'name': 'check_screen_resolution'},), 13:10:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:10:18 INFO - 'cmd': ('bash', 13:10:18 INFO - '-c', 13:10:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:10:18 INFO - 'enabled': True, 13:10:18 INFO - 'halt_on_failure': False, 13:10:18 INFO - 'name': 'check_screen_resolution'},), 13:10:18 INFO - 'run_cmd_checks_enabled': True, 13:10:18 INFO - 'sps_profile': False, 13:10:18 INFO - 'sps_profile_interval': 0, 13:10:18 INFO - 'suite': 'dromaeojs-e10s', 13:10:18 INFO - 'system_bits': '32', 13:10:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:18 INFO - 'title': 't-yosemite-r7-0012', 13:10:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:18 INFO - 'use_talos_json': True, 13:10:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:10:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:18 INFO - 'work_dir': 'build'} 13:10:18 INFO - ##### 13:10:18 INFO - ##### Running clobber step. 13:10:18 INFO - ##### 13:10:18 INFO - Running pre-action listener: _resource_record_pre_action 13:10:18 INFO - Running main action method: clobber 13:10:18 INFO - rmtree: /builds/slave/test/build 13:10:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:20 INFO - Running post-action listener: _resource_record_post_action 13:10:20 INFO - ##### 13:10:20 INFO - ##### Running read-buildbot-config step. 13:10:20 INFO - ##### 13:10:20 INFO - Running pre-action listener: _resource_record_pre_action 13:10:20 INFO - Running main action method: read_buildbot_config 13:10:20 INFO - Using buildbot properties: 13:10:20 INFO - { 13:10:20 INFO - "project": "", 13:10:20 INFO - "product": "firefox", 13:10:20 INFO - "script_repo_revision": "production", 13:10:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:10:20 INFO - "repository": "", 13:10:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:10:20 INFO - "buildid": "20160505111245", 13:10:20 INFO - "pgo_build": "False", 13:10:20 INFO - "basedir": "/builds/slave/test", 13:10:20 INFO - "buildnumber": 1, 13:10:20 INFO - "slavename": "t-yosemite-r7-0012", 13:10:20 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:10:20 INFO - "platform": "yosemite_r7", 13:10:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:10:20 INFO - "branch": "mozilla-beta", 13:10:20 INFO - "repo_path": "releases/mozilla-beta", 13:10:20 INFO - "revision": "eac275b1daa5b926efe9525d9ad08ebd23e6cf2b", 13:10:20 INFO - "stage_platform": "macosx64", 13:10:20 INFO - "builduid": "31ab4dd2d787434cab92eb6288883602", 13:10:20 INFO - "slavebuilddir": "test" 13:10:20 INFO - } 13:10:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 13:10:20 INFO - Running post-action listener: _resource_record_post_action 13:10:20 INFO - ##### 13:10:20 INFO - ##### Running download-and-extract step. 13:10:20 INFO - ##### 13:10:20 INFO - Running pre-action listener: _resource_record_pre_action 13:10:20 INFO - Running main action method: download_and_extract 13:10:20 INFO - mkdir: /builds/slave/test/build/tests 13:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:20 INFO - https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:10:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:10:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:10:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 13:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 13:10:22 INFO - Downloaded 1241 bytes. 13:10:22 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 13:10:22 INFO - Using the following test package requirements: 13:10:22 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:10:22 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 13:10:22 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 13:10:22 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:10:22 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 13:10:22 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:10:22 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 13:10:22 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 13:10:22 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 13:10:22 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:10:22 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:10:22 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 13:10:22 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 13:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:22 INFO - https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 13:10:23 INFO - Downloaded 17747495 bytes. 13:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:10:26 INFO - Return code: 0 13:10:26 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:26 INFO - https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:10:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 13:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 13:10:28 INFO - Downloaded 17747495 bytes. 13:10:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:10:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:10:31 INFO - Return code: 0 13:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:31 INFO - https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 13:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 13:10:32 INFO - Downloaded 10845194 bytes. 13:10:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:10:32 INFO - Return code: 0 13:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:32 INFO - https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 13:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 13:10:36 INFO - Downloaded 88341765 bytes. 13:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:10:36 INFO - mkdir: /builds/slave/test/properties 13:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:10:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:10:36 INFO - Contents: 13:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:10:37 INFO - Running post-action listener: _resource_record_post_action 13:10:37 INFO - Running post-action listener: set_extra_try_arguments 13:10:37 INFO - ##### 13:10:37 INFO - ##### Running populate-webroot step. 13:10:37 INFO - ##### 13:10:37 INFO - Running pre-action listener: _resource_record_pre_action 13:10:37 INFO - Running main action method: populate_webroot 13:10:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:10:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:10:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:10:37 INFO - '--tppagecycles', 13:10:37 INFO - '7'], 13:10:37 INFO - 'tests': ['tsvgm']}}, 13:10:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:10:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:10:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:10:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:10:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'tests': ['damp', 'tps']}, 13:10:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['damp', 'tps']}, 13:10:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:10:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:10:37 INFO - 'other': {'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'other_l64': {'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'other_nol64': {'tests': ['a11yr', 13:10:37 INFO - 'ts_paint', 13:10:37 INFO - 'tpaint', 13:10:37 INFO - 'sessionrestore', 13:10:37 INFO - 'sessionrestore_no_auto_restore', 13:10:37 INFO - 'tabpaint']}, 13:10:37 INFO - 'svgr': {'tests': ['tsvgx', 13:10:37 INFO - 'tsvgr_opacity', 13:10:37 INFO - 'tart', 13:10:37 INFO - 'tscrollx', 13:10:37 INFO - 'cart']}, 13:10:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['tsvgx', 13:10:37 INFO - 'tsvgr_opacity', 13:10:37 INFO - 'tart', 13:10:37 INFO - 'tscrollx', 13:10:37 INFO - 'cart']}, 13:10:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'tests': ['tp5o']}, 13:10:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'talos_options': ['--e10s'], 13:10:37 INFO - 'tests': ['tp5o']}, 13:10:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'talos_options': ['--xperf_path', 13:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:37 INFO - 'tests': ['tp5n']}, 13:10:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:37 INFO - 'talos_options': ['--e10s', 13:10:37 INFO - '--xperf_path', 13:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:37 INFO - 'tests': ['tp5n']}}, 13:10:37 INFO - 'talos.zip': {'path': '', 13:10:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:10:37 INFO - Running post-action listener: _resource_record_post_action 13:10:37 INFO - ##### 13:10:37 INFO - ##### Running create-virtualenv step. 13:10:37 INFO - ##### 13:10:37 INFO - Running pre-action listener: _resource_record_pre_action 13:10:37 INFO - Running main action method: create_virtualenv 13:10:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:10:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:10:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:10:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:10:37 INFO - Using real prefix '/tools/python27' 13:10:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:10:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:10:41 INFO - Installing pip.................done. 13:10:41 INFO - Return code: 0 13:10:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:10: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')]} 13:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10: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')]} 13:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:41 INFO - 'HOME': '/Users/cltbld', 13:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:41 INFO - 'LOGNAME': 'cltbld', 13:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:41 INFO - 'MOZ_NO_REMOTE': '1', 13:10:41 INFO - 'NO_EM_RESTART': '1', 13:10:41 INFO - 'PAGER': '/bin/cat', 13:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:41 INFO - 'PWD': '/builds/slave/test', 13:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:41 INFO - 'SHELL': '/bin/bash', 13:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:41 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:41 INFO - 'USER': 'cltbld', 13:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:41 INFO - 'XPC_FLAGS': '0x0', 13:10:41 INFO - 'XPC_SERVICE_NAME': '0', 13:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:10:41 INFO - Cleaning up... 13:10:41 INFO - Return code: 0 13:10:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:10: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')]} 13:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10: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')]} 13:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:41 INFO - 'HOME': '/Users/cltbld', 13:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:41 INFO - 'LOGNAME': 'cltbld', 13:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:41 INFO - 'MOZ_NO_REMOTE': '1', 13:10:41 INFO - 'NO_EM_RESTART': '1', 13:10:41 INFO - 'PAGER': '/bin/cat', 13:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:41 INFO - 'PWD': '/builds/slave/test', 13:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:41 INFO - 'SHELL': '/bin/bash', 13:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:41 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:41 INFO - 'USER': 'cltbld', 13:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:41 INFO - 'XPC_FLAGS': '0x0', 13:10:41 INFO - 'XPC_SERVICE_NAME': '0', 13:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:42 INFO - Downloading/unpacking psutil>=0.7.1 13:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:44 INFO - Installing collected packages: psutil 13:10:44 INFO - Running setup.py install for psutil 13:10:44 INFO - building 'psutil._psutil_osx' extension 13:10:44 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 13:10:45 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 13:10:45 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 13:10:45 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 13:10:45 INFO - building 'psutil._psutil_posix' extension 13:10:45 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 13:10:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:10:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:10:45 INFO - ^ 13:10:45 INFO - 1 warning generated. 13:10:45 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 13:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:45 INFO - Successfully installed psutil 13:10:45 INFO - Cleaning up... 13:10:45 INFO - Return code: 0 13:10:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:45 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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:45 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 13:10:45 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 13:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:45 INFO - 'HOME': '/Users/cltbld', 13:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:45 INFO - 'LOGNAME': 'cltbld', 13:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:45 INFO - 'MOZ_NO_REMOTE': '1', 13:10:45 INFO - 'NO_EM_RESTART': '1', 13:10:45 INFO - 'PAGER': '/bin/cat', 13:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:45 INFO - 'PWD': '/builds/slave/test', 13:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:45 INFO - 'SHELL': '/bin/bash', 13:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:45 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:45 INFO - 'USER': 'cltbld', 13:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:45 INFO - 'XPC_FLAGS': '0x0', 13:10:45 INFO - 'XPC_SERVICE_NAME': '0', 13:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:10:48 INFO - Installing collected packages: mozsystemmonitor 13:10:48 INFO - Running setup.py install for mozsystemmonitor 13:10:48 INFO - Successfully installed mozsystemmonitor 13:10:48 INFO - Cleaning up... 13:10:48 INFO - Return code: 0 13:10:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:48 INFO - 'HOME': '/Users/cltbld', 13:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:48 INFO - 'LOGNAME': 'cltbld', 13:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:48 INFO - 'MOZ_NO_REMOTE': '1', 13:10:48 INFO - 'NO_EM_RESTART': '1', 13:10:48 INFO - 'PAGER': '/bin/cat', 13:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:48 INFO - 'PWD': '/builds/slave/test', 13:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:48 INFO - 'SHELL': '/bin/bash', 13:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:48 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:48 INFO - 'USER': 'cltbld', 13:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:48 INFO - 'XPC_FLAGS': '0x0', 13:10:48 INFO - 'XPC_SERVICE_NAME': '0', 13:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:10:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:10:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:52 INFO - Downloading docopt-0.6.1.tar.gz 13:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:10:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:10:52 INFO - Running setup.py install for blobuploader 13:10:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:10:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:10:52 INFO - Running setup.py install for requests 13:10:53 INFO - Running setup.py install for docopt 13:10:53 INFO - Successfully installed blobuploader requests docopt 13:10:53 INFO - Cleaning up... 13:10:53 INFO - Return code: 0 13:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:53 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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:53 INFO - 'HOME': '/Users/cltbld', 13:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:53 INFO - 'LOGNAME': 'cltbld', 13:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:53 INFO - 'MOZ_NO_REMOTE': '1', 13:10:53 INFO - 'NO_EM_RESTART': '1', 13:10:53 INFO - 'PAGER': '/bin/cat', 13:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:53 INFO - 'PWD': '/builds/slave/test', 13:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:53 INFO - 'SHELL': '/bin/bash', 13:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:53 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:53 INFO - 'USER': 'cltbld', 13:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:53 INFO - 'XPC_FLAGS': '0x0', 13:10:53 INFO - 'XPC_SERVICE_NAME': '0', 13:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:53 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-d5wbqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HAdeWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5rxJpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ikZB0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-OIYAjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-cvxbkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-NdEALr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HwxvEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-c1rAEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-GFn2kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-bD16LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5ThVCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HUse9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-0MfiQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-4zmJ6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-89vvLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-rW7ze3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:55 INFO - Running setup.py install for manifestparser 13:10:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:10:55 INFO - Running setup.py install for mozcrash 13:10:56 INFO - Running setup.py install for mozdebug 13:10:56 INFO - Running setup.py install for mozdevice 13:10:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Running setup.py install for mozfile 13:10:56 INFO - Running setup.py install for mozhttpd 13:10:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Running setup.py install for mozinfo 13:10:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Running setup.py install for mozInstall 13:10:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:10:56 INFO - Running setup.py install for mozleak 13:10:57 INFO - Running setup.py install for mozlog 13:10:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Running setup.py install for moznetwork 13:10:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Running setup.py install for mozprocess 13:10:57 INFO - Running setup.py install for mozprofile 13:10:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Running setup.py install for mozrunner 13:10:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:10:57 INFO - Running setup.py install for mozscreenshot 13:10:58 INFO - Running setup.py install for moztest 13:10:58 INFO - Running setup.py install for mozversion 13:10:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:10:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:58 INFO - Cleaning up... 13:10:58 INFO - Return code: 0 13:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:58 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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:58 INFO - 'HOME': '/Users/cltbld', 13:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:58 INFO - 'LOGNAME': 'cltbld', 13:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:58 INFO - 'MOZ_NO_REMOTE': '1', 13:10:58 INFO - 'NO_EM_RESTART': '1', 13:10:58 INFO - 'PAGER': '/bin/cat', 13:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:58 INFO - 'PWD': '/builds/slave/test', 13:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:58 INFO - 'SHELL': '/bin/bash', 13:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:10:58 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:58 INFO - 'USER': 'cltbld', 13:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:58 INFO - 'XPC_FLAGS': '0x0', 13:10:58 INFO - 'XPC_SERVICE_NAME': '0', 13:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-afJUmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ZOuD3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-JG4fG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ZepfiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-KaWzzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-2e79Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-xTZPJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-mYrgNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-meKVdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-QkGBSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:59 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)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-rRQFsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-pgPw0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5pkZRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-odIqdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-2uJIUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-psHAKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-L2mY10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:11:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:02 INFO - Downloading blessings-1.6.tar.gz 13:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:02 INFO - Installing collected packages: blessings 13:11:02 INFO - Running setup.py install for blessings 13:11:03 INFO - Successfully installed blessings 13:11:03 INFO - Cleaning up... 13:11:03 INFO - Return code: 0 13:11:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:03 INFO - Reading from file tmpfile_stdout 13:11:03 INFO - Current package versions: 13:11:03 INFO - blessings == 1.6 13:11:03 INFO - blobuploader == 1.2.4 13:11:03 INFO - docopt == 0.6.1 13:11:03 INFO - manifestparser == 1.1 13:11:03 INFO - mozInstall == 1.12 13:11:03 INFO - mozcrash == 0.17 13:11:03 INFO - mozdebug == 0.1 13:11:03 INFO - mozdevice == 0.48 13:11:03 INFO - mozfile == 1.2 13:11:03 INFO - mozhttpd == 0.7 13:11:03 INFO - mozinfo == 0.9 13:11:03 INFO - mozleak == 0.1 13:11:03 INFO - mozlog == 3.1 13:11:03 INFO - moznetwork == 0.27 13:11:03 INFO - mozprocess == 0.22 13:11:03 INFO - mozprofile == 0.28 13:11:03 INFO - mozrunner == 6.11 13:11:03 INFO - mozscreenshot == 0.1 13:11:03 INFO - mozsystemmonitor == 0.0 13:11:03 INFO - moztest == 0.7 13:11:03 INFO - mozversion == 1.4 13:11:03 INFO - psutil == 3.1.1 13:11:03 INFO - requests == 1.2.3 13:11:03 INFO - wsgiref == 0.1.2 13:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:03 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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:11:03 INFO - 'HOME': '/Users/cltbld', 13:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:11:03 INFO - 'LOGNAME': 'cltbld', 13:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:03 INFO - 'MOZ_NO_REMOTE': '1', 13:11:03 INFO - 'NO_EM_RESTART': '1', 13:11:03 INFO - 'PAGER': '/bin/cat', 13:11:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:03 INFO - 'PWD': '/builds/slave/test', 13:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:11:03 INFO - 'SHELL': '/bin/bash', 13:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:11:03 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:11:03 INFO - 'USER': 'cltbld', 13:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:03 INFO - 'XPC_FLAGS': '0x0', 13:11:03 INFO - 'XPC_SERVICE_NAME': '0', 13:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:11:03 INFO - Cleaning up... 13:11:03 INFO - Return code: 0 13:11:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:03 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 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:11:03 INFO - 'HOME': '/Users/cltbld', 13:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:11:03 INFO - 'LOGNAME': 'cltbld', 13:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:03 INFO - 'MOZ_NO_REMOTE': '1', 13:11:03 INFO - 'NO_EM_RESTART': '1', 13:11:03 INFO - 'PAGER': '/bin/cat', 13:11:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:03 INFO - 'PWD': '/builds/slave/test', 13:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:11:03 INFO - 'SHELL': '/bin/bash', 13:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:11:03 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:11:03 INFO - 'USER': 'cltbld', 13:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:03 INFO - 'XPC_FLAGS': '0x0', 13:11:03 INFO - 'XPC_SERVICE_NAME': '0', 13:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:04 INFO - Downloading/unpacking jsonschema 13:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:06 INFO - warning: no files found matching '*.txt' 13:11:06 INFO - no previously-included directories found matching 'build' 13:11:06 INFO - no previously-included directories found matching 'dist' 13:11:06 INFO - no previously-included directories found matching '.git*' 13:11:06 INFO - Installing collected packages: jsonschema, functools32 13:11:06 INFO - Running setup.py install for functools32 13:11:07 INFO - warning: no files found matching '*.txt' 13:11:07 INFO - no previously-included directories found matching 'build' 13:11:07 INFO - no previously-included directories found matching 'dist' 13:11:07 INFO - no previously-included directories found matching '.git*' 13:11:07 INFO - Successfully installed jsonschema functools32 13:11:07 INFO - Cleaning up... 13:11:07 INFO - Return code: 0 13:11:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb1d77f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, '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.dPiAB2d4aq/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.YSnkDHK03B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:11:07 INFO - 'HOME': '/Users/cltbld', 13:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:11:07 INFO - 'LOGNAME': 'cltbld', 13:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:07 INFO - 'MOZ_NO_REMOTE': '1', 13:11:07 INFO - 'NO_EM_RESTART': '1', 13:11:07 INFO - 'PAGER': '/bin/cat', 13:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:07 INFO - 'PWD': '/builds/slave/test', 13:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:11:07 INFO - 'SHELL': '/bin/bash', 13:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:11:07 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:11:07 INFO - 'USER': 'cltbld', 13:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:07 INFO - 'XPC_FLAGS': '0x0', 13:11:07 INFO - 'XPC_SERVICE_NAME': '0', 13:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:07 INFO - Downloading/unpacking flake8 13:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:11:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:11:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:11 INFO - no previously-included directories found matching 'docs/_build' 13:11:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:11:11 INFO - Running setup.py install for pep8 13:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:11 INFO - no previously-included directories found matching 'docs/_build' 13:11:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:11:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:11:11 INFO - Cleaning up... 13:11:11 INFO - Return code: 0 13:11:11 INFO - Running post-action listener: _resource_record_post_action 13:11:11 INFO - Running post-action listener: _start_resource_monitoring 13:11:11 INFO - Starting resource monitoring. 13:11:11 INFO - ##### 13:11:11 INFO - ##### Running install step. 13:11:11 INFO - ##### 13:11:11 INFO - Running pre-action listener: _resource_record_pre_action 13:11:11 INFO - Running main action method: install 13:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:11 INFO - Reading from file tmpfile_stdout 13:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:11:11 INFO - Reading from file tmpfile_stdout 13:11:11 INFO - Output received: 13:11:11 INFO - Usage: mozinstall [options] installer 13:11:11 INFO - Options: 13:11:11 INFO - -h, --help show this help message and exit 13:11:11 INFO - -d DEST, --destination=DEST 13:11:11 INFO - Directory to install application into. [default: 13:11:11 INFO - "/builds/slave/test"] 13:11:11 INFO - --app=APP Application being installed. [default: firefox] 13:11:11 INFO - mkdir: /builds/slave/test/build/application 13:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:11:34 INFO - Reading from file tmpfile_stdout 13:11:34 INFO - Output received: 13:11:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:11:34 INFO - Running post-action listener: _resource_record_post_action 13:11:34 INFO - ##### 13:11:34 INFO - ##### Running run-tests step. 13:11:34 INFO - ##### 13:11:34 INFO - Running pre-action listener: _resource_record_pre_action 13:11:34 INFO - Running main action method: run_tests 13:11:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:34 INFO - 2016-05-05 13:11:34.676 screenresolution[1638:7463] starting screenresolution argv=screenresolution get 13:11:34 INFO - 2016-05-05 13:11:34.679 screenresolution[1638:7463] Display 0: 1600x1200x32@60 13:11:34 INFO - 2016-05-05 13:11:34.685 screenresolution[1639:7466] starting screenresolution argv=screenresolution list 13:11:34 INFO - Available Modes on Display 0 13:11:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:34 INFO - Intel Iris: 13:11:34 INFO - Chipset Model: Intel Iris 13:11:34 INFO - Type: GPU 13:11:34 INFO - Bus: Built-In 13:11:34 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:34 INFO - Vendor: Intel (0x8086) 13:11:34 INFO - Device ID: 0x0a2e 13:11:34 INFO - Revision ID: 0x0009 13:11:34 INFO - Displays: 13:11:34 INFO - Display: 13:11:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:34 INFO - Display Serial Number: 1600x1200 60 13:11:34 INFO - Main Display: Yes 13:11:34 INFO - Mirror: Off 13:11:34 INFO - Online: Yes 13:11:34 INFO - Rotation: Supported 13:11:34 INFO - Return code: 0 13:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:34 INFO - Python 2.7.3 13:11:34 INFO - Return code: 0 13:11:34 INFO - grabbing minidump binary from tooltool 13:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:34 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 0x10a35dd30>, '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 0x10a1c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a354b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:34 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 13:11:34 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 13:11:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:35 INFO - Return code: 0 13:11:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:11:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:11:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:11:36 INFO - Return code: 0 13:11:36 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/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 13:11:36 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/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --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 13:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dPiAB2d4aq/Render', 13:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:11:36 INFO - 'HOME': '/Users/cltbld', 13:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:11:36 INFO - 'LOGNAME': 'cltbld', 13:11:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:36 INFO - 'MOZ_NO_REMOTE': '1', 13:11:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:36 INFO - 'NO_EM_RESTART': '1', 13:11:36 INFO - 'PAGER': '/bin/cat', 13:11:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:36 INFO - 'PWD': '/builds/slave/test', 13:11:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:11:36 INFO - 'SHELL': '/bin/bash', 13:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YSnkDHK03B/Listeners', 13:11:36 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:11:36 INFO - 'USER': 'cltbld', 13:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:36 INFO - 'XPC_FLAGS': '0x0', 13:11:36 INFO - 'XPC_SERVICE_NAME': '0', 13:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:11:36 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/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 13:11:36 INFO - mozversion application_buildid: 20160505111245 13:11:36 INFO - mozversion application_changeset: eac275b1daa5b926efe9525d9ad08ebd23e6cf2b 13:11:36 INFO - mozversion application_display_name: Firefox 13:11:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:36 INFO - mozversion application_name: Firefox 13:11:36 INFO - mozversion application_remotingname: firefox 13:11:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:11:36 INFO - mozversion application_vendor: Mozilla 13:11:36 INFO - mozversion application_version: 47.0 13:11:36 INFO - mozversion platform_buildid: 20160505111245 13:11:36 INFO - mozversion platform_changeset: eac275b1daa5b926efe9525d9ad08ebd23e6cf2b 13:11:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:11:36 INFO - mozversion platform_version: 47.0 13:11:36 INFO - using testdate: 1462479096 13:11:36 INFO - actual date: 1462479096 13:11:36 INFO - starting webserver on 'localhost:49270' 13:11:36 INFO - SUITE-START | Running 2 tests 13:11:36 INFO - TEST-START | dromaeo_css 13:11:36 INFO - operating with platform_type : mac_ 13:11:36 INFO - Initialising browser for dromaeo_css test... 13:11:36 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpFLYUjj/profile http://localhost:49270/getInfo.html) 13:11:39 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 13:11:39 INFO - PROCESS | 1657 | colorDepth:24 13:11:39 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 13:11:39 INFO - PROCESS | 1657 | __metrics 13:11:39 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:11:40 INFO - TEST-INFO | 1657: exit 0 13:11:40 INFO - Browser initialized. 13:11:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:40 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpFLYUjj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:52 INFO - PROCESS | 1664 | RSS: Main: 168169472 13:11:52 INFO - PROCESS | 1664 | 13:12:41 INFO - PROCESS | 1664 | 1462479161786 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:14:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 13:14:53 INFO - PROCESS | 1664 | RSS: Main: 178196480 13:14:53 INFO - PROCESS | 1664 | 13:17:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 13:17:55 INFO - PROCESS | 1664 | RSS: Main: 190603264 13:17:55 INFO - PROCESS | 1664 | 13:20:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 13:20:58 INFO - PROCESS | 1664 | RSS: Main: 191725568 13:20:58 INFO - PROCESS | 1664 | 13:23:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 13:24:00 INFO - PROCESS | 1664 | RSS: Main: 195141632 13:24:00 INFO - PROCESS | 1664 | 13:27:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 13:27:03 INFO - PROCESS | 1664 | RSS: Main: 194383872 13:27:03 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 13:30:05 INFO - PROCESS | 1664 | RSS: Main: 200003584 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | __start_tp_report 13:30:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 13:30:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 13:30:05 INFO - PROCESS | 1664 | |i|pagename|runs| 13:30:05 INFO - PROCESS | 1664 | |0;dojo.html;3668.926621467571;3702.740808143428;3717.7769333839956;3754.586995430502;3762.6049264827193;6035.60768550045;6093.238345206849;6120.274092665631;6124.693765311739;6126.33124129357;6100.054491553805;6131.632102073879;6149.631022138675;6164;6166.81499555014;4831.743746625885;5405.783768649249;5462.399136095027;5511.751971161308;5540.307461567304;4701.553352431513;5494.395616482184;5502.064649009658;5522.254495643077;5526.834194974157;5494.972525137368;5531.225628412026;5569.192467092269;5601.691906945116;5632.577556683244;5525.226468294442;5535.086710692731;5549.805756798533;5555.638883472561;5564.972175139139;5259.447757985433;5408.891822163574;5462.808801691962;5489.890202195934;5508.394076651565;5944.286685597713;6005.129256257862;6020.849478763066;6024.5481588880575;6082.057281121389;6296.929521981274;6317;6341.556091073627;6342.953412686948;6354.3963323484195;6256.499480041586;6362.745490180388;6398.232212134573;6413.935860641381;6427.8393040173905;6114.784027539392;6144.96927515364;6179.16581261524;6186.257649082139;6194.132821405007;6504.252011018699;6581.506387020992;6597.208334999735;6600.702968366435;6608.933910660832;6184.288806787187;6248.375162483806;6267.4986001119805;6290.748370065146;6294;6447.967760161169;6463.741450341934;6483.513736469784;6494.318096599884;6500.382463665944;6305.085762564494;6326.620402775849;6329.68351582419;6335.239771227482;6335.619862808247;6244.219472565929;6257.530685198628;6318.178636777189;6367.713452894631;6393.808185754435;5134.5378915897745;5150.716710580879;5162.967406518711;5182.093133701587;5258;3959.742616729903;4634.907301853944;4660.5106463821485;4663.137319595886;4673.392458980311;6097.3292937776805;6122.794608433986;6125.052321061979;6178.135061091451;6207.875842483125;5024.447310795809;6445.4891515013605;6474.838129046717;6492.610443373413;6516.837079073061;6063.423974722395;6164.445199932027;6190.0405437157315;6210.441060304594;6223.37766223374;5555.777768889199;5666.2350582670815;5679.574031947621;5744.971275143597;5774;6678.3989440950545;6736.02327662496;6776.220734615484;6788.083608712859;6814.727410903508;6340.651264180515;6444.581102228341;6528.347165283623;6545.639989800607;6549.901751473827;6605.1083103780375;6649.800505984828;6699.062131301719;6714.496412768965;6732.562383445061;6396.968015159894;6410.1987251593555;6413.807585772434;6418.550701450854;6439.967800161156;6296.968515157395;6374.298827129105;6438.323975982642;6476.870462590816;6498.220213574401;5098.719570423662;5419.6206265562605;6341.619502829845;6348.77779277723;6361.968190159019;6262.906056409249;6295.842603934755;6298.4883627929885;6301.40136687014;6319.747210111544;6057.18228039209;6137.60105593135;6139.079138129317;6224.37756224374;6251.218597675291;6263.68681565929;6321.494280457644;6353.110564520878;6355.968220158869;6356.110144579855;5847.532197424111;6191.19514463117;6211.13044173807;6225.937740622717;6232.8130156095385 13:30:05 INFO - PROCESS | 1664 | |1;ext.html;497.5820310938811;580.8673087479416;586.9941300586995;654.0450941625227;654.8002859127965;38543;39186.21627567447;39196.21607567847;39217.01957451062;39392.60607393925;40376.990575235635;40693.59306406935;40819.59180408195;41063;41526;9716.174125199366;9954.352967057119;9963.651272205474;9978.351407158547;10016.449095299755;9807.215422766198;9872.802543949118;9900.851487227697;9973.401595904268;9982.500874956224;9917.950410247975;9936.35413698111;9938.105570498654;9939.353941993748;9946.154576860976;9881.715377001015;9885.505724713736;9913.900860991405;9956.402615843073;10024.498775061254;9823.852642210373;9912.801743965152;9954.751131221705;9964.402135871871;9968.750781230454;40366.39450408246;40743.98140046493;40749.57376491838;41023.7948810254;41258.1748365034;3420.162060295219;3451.4650229214512;3508.824558772051;3586.264815712773;3617.240379520304;21961.23135690243;28138.155855324374;28200.294992625142;28562.143135705963;28563.57154642682;2724.3573733478493;2805.1724741201397;2814.9014784482447;2831.362943337753;2890.6242188515357;416180;417974.91012544744;418033;421426;425173;47472.52527474681;48062.759686202044;66203.66898165575;66455;66908.99636505457;46705.13179472851;46766;46927.06145877064;46927.59217223489;46971.5302846974;16299.429519966981;16557;16754.916225418794;16922;17103.914480427517;13241;13427;13458.663533411744;13573.864261357458;13595.252261125734;14663.48677796272;15147.394104235927;15161.862860285522;15503.84496155024;15639.68720625581;6479.8056058318325;6517.3808488193545;6582.3746744059235;6612.404883560503;6623;1018.9439580822977;1078.320657985464;1104.2325583719398;1121.747606788466;1123.3709122891044;30329.393412132074;30465.69534304673;30812.845935770627;31023.379532409224;31073.533896991565;1030.9690709278734;1147.5352482244705;1215.2829830400105;1240.2496489623827;1255.152771878978;15501.689966200613;15723.292451839694;15771.266785632222;15775.921120394554;15973.840261597468;526820;528655;560776.1961190169;562255;566699;60044.79910401855;60053.399466005656;60527.394726053055;61053.38946610566;61121;1497.5133081748259;1498.932548035341;1528.892977491587;1531.326216464752;1545.6522282486576;24696.753032469445;29307.85346073256;29854;30686.693133069275;30948.69051309548;51909.740451297504;57588.71205643945;57624.423755763586;59261;59377;523219;527235;528436;528836;534489;43105;44753.77623111864;46164.307535386324;46262.53737462717;46783.76608116938;48481;48513.757431212616;49077.01845962989;50199;50317;36313.63686363103;37166.070848229014;37432.06419839526;37546.62453375541;39254.80372598119;38122.809385952896;38566.42150367691;38730.80634596809;38817.61182388253;39346.803265983486;30888.53667194949;35297.235138242475;38417.03957401087;41470.79264603658;41520.82316496199;33471.83264083664;34109.97670069902;34368.312633747686;34390.65609343975;34444.48333274953;26383.67834989957;26411;26518.60222096709;26538.60192097159;26844 13:30:05 INFO - PROCESS | 1664 | |2;jquery.html;333.7080054951917;373.64130434782606;379.70003697079306;388.9436031775393;389.9317619416601;20292.89853550732;20495.38513844585;20628.69056964147;20955;21161.153553857846;20807;21000.789992100075;21036.57926841462;21277.68083478749;21278.787212127874;5998.610090344125;6210.441060304572;6264;6282.214723159594;6283.277423096357;4236.110416812473;5829.213056237418;6036.185115009462;6285.214348206474;6287.308396076428;6126.938730612704;6143.7235324410285;6153.476954458876;6156.2920264169525;6232.439080482755;6169.753209871622;6699.39705426509;6714.3957043866285;6801.897971530431;6833.282505336918;5770.16332631766;5904.1734157218025;5907.940920590782;6002.819915402545;6045.576809623328;25334.493310133694;25354.366140846443;25418.36454088644;25463;26217.868910655514;2120.946976325589;2227.532218234173;2248.404172894168;2280.1221529711015;2329.974811083118;10239.590416383337;10363.170946324275;10710.839337409945;14587.051841630366;15476.535703928901;1810.6831304521788;1823.1431227323137;1840.2730921286152;1859.9349022784272;1871.2047379863504;100831;105722.47138764334;107311.92688073097;107563.46218268937;107687.46156269168;11098.278611890362;11502.654920352403;11794.938455539042;12001.219920705125;12087.516499339928;14592.051516651383;14783.852161478462;14805.481808136663;14824.62938426548;14844.554663360117;8902.24330931865;9034.32242581809;9083.863742043875;9196.678116265899;9204.539773011322;9076.41003334781;9151.993280739114;9212.953935230282;9216;9283.953580232055;3884.4950156479476;4497.347884556721;4535.274356103007;4586.243269860503;4673.065386922629;1818.0818686563466;1884.9717254241198;1919.7312376267334;1958.4222654317011;2012.7987201279755;898.3127907151035;955.3312681123102;1021.5147804792664;1052.7473406382412;1116.9218154729092;17268.827311726975;18551.53621159455;18920.33778817735;20001.499962501053;20878;982.8820541535061;987.521052289639;1022.4887556221889;1049.4333060147587;1094;10781.730456738644;10961.616343427942;10967.83548246777;10977.28647637901;10990.450477476094;637894;645963;652410;658415;659682;100560.99439005516;101036.49481752544;101480;102279;108862;852.3564708645057;1010.8534262531891;1021.4280003198232;1027.3887037212846;1055.308772753832;17980.820191797913;18019.279228831223;18215.45353639393;18317.90841045786;18691.25234990585;44057.339139913565;45491.54508455005;45575.31637025381;45972.540274596824;50663.49336506588;63122;65697;66413.66793166003;67667;69421;7559.28186822251;7609.516144351798;8019.478733882279;8076.878846817185;8481.83036339282;12287;13431.798523021967;13586;13611.79582306286;13696.452141914211;9742.123208911233;11091.33451992883;11521.423928803693;11610.5355785771;11815;11373.488193031499;11425.828612570984;11541.307521548733;11632.53469861196;11764.235324703866;10268.58925642966;11912.463939122586;11913.583024594098;12115.273083615011;12148.574799881962;8189.099199088215;8420.62107205165;8453.91546084556;8455.577221139041;8556.10160933093;10909;11932.22440541362;12065;12071.336076515876;12114 13:30:05 INFO - PROCESS | 1664 | |3;mootools.html;1541.7995660564122;1676.740105283681;1908.5610309628785;2118.480972161821;2126.046312092824;8410.453320534161;9108.089191080897;9115.453072815619;9116.17954384106;9248.953755231223;9069.365144439875;9160.587773550189;9171.403858749176;9183.357164998453;9306.813863722738;2562.8206025578265;2573.652556904822;2579.200447861169;2581.354661334666;2582.586786114222;2202.2402271216406;2498.537770512452;2565.102214225016;2574.2663340947834;2601.427685909097;2558.4627228282084;2576.896924123033;2581.5353236417436;2589.507993481242;2596.247088344378;2568.0113156434722;2576.124117799957;2576.9226923192145;2583.509133264683;2603.713591504933;2551.2983929419374;2554.476332351863;2607.674040744907;2613.007057318226;2614.072004438416;7093.503454758169;9413.717588472357;9466.952665236699;9474.431534107976;9495.66765163216;4993.275974983643;5752.338481074688;5796.88406231873;5827.388124246935;5956;3716.981415092934;3825.5409350877794;3826.6747326477284;3848.4804551385487;3867.4005529142746;948.0470231323495;1067.1516144664931;1091.3397394576325;1118.8769235384102;1122.9388228124426;12359.01127909774;12750.489980400773;12772.872271277261;12774.936125319407;12802.551910683082;5081.161608334657;5104.3619547556555;5217.478252174752;5227.3465816772905;5248.9737551312;10582.100521455608;10602;10668.359898406121;10779.083777878968;10960.835587466194;5680.6591604503865;5734.340550836707;5762.538996880239;5787.88424231513;5847.619904706181;4038.919221615551;4777;5186.118359878829;5263.526282634582;5270.947290527046;3984.382420724792;4173.436586060843;4178.770167640748;4215.241256573846;4219.628620698285;1235.9629211123502;1288.3944546063335;1291.541502766523;1298.8766067223598;1313.6124843171287;1397.105852254558;1403.1712662257066;1415.971680566383;1471.0952764050032;1473.042522360453;8382.371322150862;8515.701950431705;8552.401331906707;8661.220490155916;8661.566921653892;526.4288247251775;530.1358785180132;531.8324727710759;534.4201541327625;538.0933127679793;5448.291722076184;5619.466150715757;6431.871362572816;6497.740090396331;6532.706028228741;9300.72097837066;10875.83686244707;11002.229843910849;11115.166362522843;11158.776824463464;10711.303765255388;10795.136389088853;10879.564817407374;10963.83554246687;11003;8919.286457083548;8990.595423205972;9088.81822363549;9110.316726245557;9154.81690366189;8576.748977307403;8611.05278419361;8615.91384086151;8731.738047858575;8734.650613975624;9562.378445401027;9852.408855468695;9906.405615663083;10264;10302.742431438974;8316.459430137022;10076.09315161639;10107.848382274418;10382.480875956324;10425.63510277167;7712.460127791001;7870.72452464161;7894.960525197567;7898.131205567268;7940.682372705027;8512.191341822518;8559.015713193063;8612.698555550525;8671.21959023691;8768.035516093352;7708.997830282027;7800.882986755089;7848.293653571206;7871.921280787119;7896.486728362638;6626.204855417381;7775.183605721318;7839.725609603636;7846.803829904298;7917.247861453153;8258.463199891989;8297.29472994778;8302.169783021649;8315.085340612648;8385.496870187808;7484.925150748641;7524.699012039458;7548.4716069874585;7595.810104747205;7617.885731714139;7507.436942229464;7604.695812167452;7681.846363072819;7695.307422332017;7727.652255648622 13:30:05 INFO - PROCESS | 1664 | |4;prototype.html;341.67370161495774;341.74539967724036;345.65952536751297;348.7732973567181;352.25322316688624;6876.587404755712;6902.171739391274;6923.965380173098;6936.895946560806;6953.33943275388;6864.347886950744;6881.862362752742;6886.2080860701035;6888.3111688831095;6893.482988775837;4893.266010098487;4958.206686930092;5042.218456139304;5047.47001564836;5078.1874900016;5008.974955125219;5038.093143234217;5049.77276022578;5050.267711181877;5055.747212639371;5069.721165335905;5079.009593129341;5089.974550127245;5097.49025097491;5103.744812759366;5086.21163719624;5104;5109.872253193663;5123.644013171379;5142;4390.604845563883;4398.362237475548;4399.428074350314;4399.912001759947;4400.163968845941;6286.559940804145;6572.211334639826;6609.834754131185;6621.933780662228;6655.633940133291;5912.586118971631;5939.940600593982;5956.315023772278;5956.821295361146;5973.611715238496;7395.630218489054;7400.074990626172;7409.962950185269;7433.145188303361;7436.367908727764;4764.857054288377;4769.403824521934;4774.952250477486;4793.808247670089;4803.7357945313;5687.800926967537;6656.5340426169705;7665.386769058462;7786.493877897975;7806.375489960847;4351.934720979188;4770.260609605517;4778.904421911542;4842.903141937141;4872.585830204473;4941.604671626261;4943.604511639061;4948;4967.82612608557;4969.527894849984;5901.262342207224;5934.614250073818;5959.672218027963;5961.344252132262;5961.970190149022;7366.77899663011;7438.888416673754;7442.404607631376;7453.838386867856;7466.328030477283;1405.2411697683342;1642.482617975334;1680.899146051241;1690.653416049707;1707.9316827326768;1072.9409882456384;1077.1867240233573;1089.9073578745738;1093.4040947683532;1096.9140550854597;5709.9714501427225;7071.611061391673;7091.503594748318;7105.715771369088;7125.786226413215;6585.1439312889015;7609.885851712229;7621.275978782007;7626.961865190749;7648.273414025659;6582.80251592453;7061.435085193172;7074.080369552028;7086.503944723923;7154.2050938739785;3750.39993601028;4033.979830100831;4056.3104272273786;4070.898227544335;4072.7963601819793;7867.763967080882;7971.800704982422;7991.880121798177;8066.919330806617;8081.555514446762;6464.935350646433;7959.482633628795;7969.163237860057;7991.72028978983;8055.5972201389695;8135.511869287861;8136.633851476698;8155.877661835078;8166.060902996112;8193.631286592117;7513.812154696177;7781;7810.57041862703;7818.726344577913;7834.334081603128;7519.097708275042;7557.773266802004;7570.848583028419;7580.317771400601;7583.469157158946;8100.4329696923005;8139.18608139205;8141.552214628252;8150.021997360354;8161.020677518736;4821.059893320768;4835.95164048369;4840.249761287007;4844.079624871263;4851.80592776285;7352.264773522819;7616.857471379116;7626.275503827128;7659.425543084402;7742.38060955111;7364.926350736639;7373.262673732584;7434.851302973802;7533.359664428585;7540.886886696594;6110.205673262448;7397.889031664422;7461.552306861606;7503.399728021855;7527.962360188164;7079.504434689728;7234.493585449179;7286.672099755418;7313.378362839006;7322.1579518356075;5024.723640199824;7435;7512.511686740344;7527.360174385239;7605.961970190114;7321.158066822383;7334.652911068407;7350.08123984502;7365.7790266292095;7377.77866664001 13:30:05 INFO - PROCESS | 1664 | |5;yui.html;632.9303776584575;774.8372841703242;779.3414564692832;802.5801465451901;807.3057170833082;15424.305906234218;15461.845381546182;15554.84445155548;15583.065016099043;15696.607584810385;14340.426382944695;14492.347844347003;14841.628959275997;14939.402423903059;14992;806.3226889412892;952.0051546134289;959.2709540749046;973.1582181413062;975.9365641233297;975.4342481360829;978.2027647467327;980.9117179453848;983.6753871222515;989.1394486796461;996.0736515041009;1003.1924300937742;1012.4633944009687;1017.8473229015633;1020.1787561013381;982.29274922056;1000.9349392289514;1007.5012868630001;1012.336919317848;1016.5577973581479;749.9812504687372;750.8047907544023;756.6557216466495;757.8787394016931;765.8391737735027;15573.065616062959;15615.765763513557;15644.374225030984;15727.05637661744;15957.680846383124;13444.529441469502;13480.39338229782;13510.32448377587;13605.523806666819;13608.591742247749;9949.701508954742;10051.447170405625;10318;10323.638672646497;10363.015513526203;3023.969760302391;3586.659267369596;3629.546306711661;3650.0144960860684;3711.2020915503026;82290.58854705749;83293.58353208256;84617.73073403904;84655;85041;9729;10036.949815250877;10093.293469457214;10231.306081754736;10272.12686921605;23374;23601.527969440514;23698.170564030523;23762.405939851295;23823.404414889766;7884;7930.801729956797;7931.484453510619;8029.237222463857;8197;4265.957340426618;4271.487421509439;4306.267934451151;4330.956690433119;4347.847820327615;3740.382836831947;3758.755680880734;3774.905627359338;3792.1278106035215;3795.2409518095938;597.9402059793986;609.6494515653428;658.8846951783419;669.5045666206972;691.3190507350256;543.8205392220558;561.7556362982116;579.6377264209868;583.1486030395586;598.5959477352769;8613.69852055175;8681.088485709037;8754.91245087541;8842.646294148291;8962.372633915564;509.5795968326146;527.9076161671692;591.5740666719955;592.8517870532366;619.3960888134034;3704.2221133561716;3915.882523524242;4040.373742069984;4081.755094694328;4102.876913692594;90831.54584227169;92000.53999729958;93221.0677893226;96395;97317;72654.27345726581;73262.6336868323;84902.15097849067;85199;86586;65054.674726626065;67609;70478.79780983998;72091.27908720846;72968.63515682388;8067.233612806774;8875.801766761404;8906.777330566529;8962;8981.263295288767;49092.50907490879;50523.74738126286;51888;51905.740471298916;52289;54769.72615136899;56877.71561142168;69836.65081674559;74035.62982185054;75561.62219188869;11001.449927503752;11466.025387842126;11499.482523286304;11599.956003959684;11672.124590655565;12207.75584488323;12701.42843572023;12720.6819829505;12726.809097863354;12996.285204313854;11831.230969986924;11972.58095966637;12013.579524716943;12298.446569904198;12300.569480068512;10292;11780.941095294469;12039.337836419081;12076.698082548006;12177.269363838199;11671.824922626338;11731.35477548743;11774.94112529432;11928.70178245516;12118.515259389525;9858.457784821903;9870.259730520096;9919.504024798876;9992.65025724096;10047.648332308334;8942.882139732534;9597.568109434953;9883.159931405911;10048.598056077968;10064.798704026025 13:30:05 INFO - PROCESS | 1664 | __end_tp_report 13:30:05 INFO - PROCESS | 1664 | __start_cc_report 13:30:05 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,356 13:30:05 INFO - PROCESS | 1664 | __end_cc_report 13:30:05 INFO - PROCESS | 1664 | __startTimestamp1462480205755__endTimestamp 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | ------- Summary: start ------- 13:30:05 INFO - PROCESS | 1664 | Number of tests: 6 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5985.58 Median:6210.44 stddev:648.53 (10.4%) stddev-sans-first:624.53 13:30:05 INFO - PROCESS | 1664 | Values: 3668.9 3702.7 3717.8 3754.6 3762.6 6035.6 6093.2 6120.3 6124.7 6126.3 6100.1 6131.6 6149.6 6164.0 6166.8 4831.7 5405.8 5462.4 5511.8 5540.3 4701.6 5494.4 5502.1 5522.3 5526.8 5495.0 5531.2 5569.2 5601.7 5632.6 5525.2 5535.1 5549.8 5555.6 5565.0 5259.4 5408.9 5462.8 5489.9 5508.4 5944.3 6005.1 6020.8 6024.5 6082.1 6296.9 6317.0 6341.6 6343.0 6354.4 6256.5 6362.7 6398.2 6413.9 6427.8 6114.8 6145.0 6179.2 6186.3 6194.1 6504.3 6581.5 6597.2 6600.7 6608.9 6184.3 6248.4 6267.5 6290.7 6294.0 6448.0 6463.7 6483.5 6494.3 6500.4 6305.1 6326.6 6329.7 6335.2 6335.6 6244.2 6257.5 6318.2 6367.7 6393.8 5134.5 5150.7 5163.0 5182.1 5258.0 3959.7 4634.9 4660.5 4663.1 4673.4 6097.3 6122.8 6125.1 6178.1 6207.9 5024.4 6445.5 6474.8 6492.6 6516.8 6063.4 6164.4 6190.0 6210.4 6223.4 5555.8 5666.2 5679.6 5745.0 5774.0 6678.4 6736.0 6776.2 6788.1 6814.7 6340.7 6444.6 6528.3 6545.6 6549.9 6605.1 6649.8 6699.1 6714.5 6732.6 6397.0 6410.2 6413.8 6418.6 6440.0 6297.0 6374.3 6438.3 6476.9 6498.2 5098.7 5419.6 6341.6 6348.8 6362.0 6262.9 6295.8 6298.5 6301.4 6319.7 6057.2 6137.6 6139.1 6224.4 6251.2 6263.7 6321.5 6353.1 6356.0 6356.1 5847.5 6191.2 6211.1 6225.9 6232.8 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:64607.12 Median:40371.69 stddev:133629.29 (331.0%) stddev-sans-first:133917.46 13:30:05 INFO - PROCESS | 1664 | Values: 497.6 580.9 587.0 654.0 654.8 38543.0 39186.2 39196.2 39217.0 39392.6 40377.0 40693.6 40819.6 41063.0 41526.0 9716.2 9954.4 9963.7 9978.4 10016.4 9807.2 9872.8 9900.9 9973.4 9982.5 9918.0 9936.4 9938.1 9939.4 9946.2 9881.7 9885.5 9913.9 9956.4 10024.5 9823.9 9912.8 9954.8 9964.4 9968.8 40366.4 40744.0 40749.6 41023.8 41258.2 3420.2 3451.5 3508.8 3586.3 3617.2 21961.2 28138.2 28200.3 28562.1 28563.6 2724.4 2805.2 2814.9 2831.4 2890.6 416180.0 417974.9 418033.0 421426.0 425173.0 47472.5 48062.8 66203.7 66455.0 66909.0 46705.1 46766.0 46927.1 46927.6 46971.5 16299.4 16557.0 16754.9 16922.0 17103.9 13241.0 13427.0 13458.7 13573.9 13595.3 14663.5 15147.4 15161.9 15503.8 15639.7 6479.8 6517.4 6582.4 6612.4 6623.0 1018.9 1078.3 1104.2 1121.7 1123.4 30329.4 30465.7 30812.8 31023.4 31073.5 1031.0 1147.5 1215.3 1240.2 1255.2 15501.7 15723.3 15771.3 15775.9 15973.8 526820.0 528655.0 560776.2 562255.0 566699.0 60044.8 60053.4 60527.4 61053.4 61121.0 1497.5 1498.9 1528.9 1531.3 1545.7 24696.8 29307.9 29854.0 30686.7 30948.7 51909.7 57588.7 57624.4 59261.0 59377.0 523219.0 527235.0 528436.0 528836.0 534489.0 43105.0 44753.8 46164.3 46262.5 46783.8 48481.0 48513.8 49077.0 50199.0 50317.0 36313.6 37166.1 37432.1 37546.6 39254.8 38122.8 38566.4 38730.8 38817.6 39346.8 30888.5 35297.2 38417.0 41470.8 41520.8 33471.8 34110.0 34368.3 34390.7 34444.5 26383.7 26411.0 26518.6 26538.6 26844.0 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35150.42 Median:21098.87 stddev:107235.96 (508.3%) stddev-sans-first:107504.92 13:30:05 INFO - PROCESS | 1664 | Values: 333.7 373.6 379.7 388.9 389.9 20292.9 20495.4 20628.7 20955.0 21161.2 20807.0 21000.8 21036.6 21277.7 21278.8 5998.6 6210.4 6264.0 6282.2 6283.3 4236.1 5829.2 6036.2 6285.2 6287.3 6126.9 6143.7 6153.5 6156.3 6232.4 6169.8 6699.4 6714.4 6801.9 6833.3 5770.2 5904.2 5907.9 6002.8 6045.6 25334.5 25354.4 25418.4 25463.0 26217.9 2120.9 2227.5 2248.4 2280.1 2330.0 10239.6 10363.2 10710.8 14587.1 15476.5 1810.7 1823.1 1840.3 1859.9 1871.2 100831.0 105722.5 107311.9 107563.5 107687.5 11098.3 11502.7 11794.9 12001.2 12087.5 14592.1 14783.9 14805.5 14824.6 14844.6 8902.2 9034.3 9083.9 9196.7 9204.5 9076.4 9152.0 9213.0 9216.0 9284.0 3884.5 4497.3 4535.3 4586.2 4673.1 1818.1 1885.0 1919.7 1958.4 2012.8 898.3 955.3 1021.5 1052.7 1116.9 17268.8 18551.5 18920.3 20001.5 20878.0 982.9 987.5 1022.5 1049.4 1094.0 10781.7 10961.6 10967.8 10977.3 10990.5 637894.0 645963.0 652410.0 658415.0 659682.0 100561.0 101036.5 101480.0 102279.0 108862.0 852.4 1010.9 1021.4 1027.4 1055.3 17980.8 18019.3 18215.5 18317.9 18691.3 44057.3 45491.5 45575.3 45972.5 50663.5 63122.0 65697.0 66413.7 67667.0 69421.0 7559.3 7609.5 8019.5 8076.9 8481.8 12287.0 13431.8 13586.0 13611.8 13696.5 9742.1 11091.3 11521.4 11610.5 11815.0 11373.5 11425.8 11541.3 11632.5 11764.2 10268.6 11912.5 11913.6 12115.3 12148.6 8189.1 8420.6 8453.9 8455.6 8556.1 10909.0 11932.2 12065.0 12071.3 12114.0 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6340.55 Median:2900.54 stddev:3358.38 (115.8%) stddev-sans-first:3348.43 13:30:05 INFO - PROCESS | 1664 | Values: 1541.8 1676.7 1908.6 2118.5 2126.0 8410.5 9108.1 9115.5 9116.2 9249.0 9069.4 9160.6 9171.4 9183.4 9306.8 2562.8 2573.7 2579.2 2581.4 2582.6 2202.2 2498.5 2565.1 2574.3 2601.4 2558.5 2576.9 2581.5 2589.5 2596.2 2568.0 2576.1 2576.9 2583.5 2603.7 2551.3 2554.5 2607.7 2613.0 2614.1 7093.5 9413.7 9467.0 9474.4 9495.7 4993.3 5752.3 5796.9 5827.4 5956.0 3717.0 3825.5 3826.7 3848.5 3867.4 948.0 1067.2 1091.3 1118.9 1122.9 12359.0 12750.5 12772.9 12774.9 12802.6 5081.2 5104.4 5217.5 5227.3 5249.0 10582.1 10602.0 10668.4 10779.1 10960.8 5680.7 5734.3 5762.5 5787.9 5847.6 4038.9 4777.0 5186.1 5263.5 5270.9 3984.4 4173.4 4178.8 4215.2 4219.6 1236.0 1288.4 1291.5 1298.9 1313.6 1397.1 1403.2 1416.0 1471.1 1473.0 8382.4 8515.7 8552.4 8661.2 8661.6 526.4 530.1 531.8 534.4 538.1 5448.3 5619.5 6431.9 6497.7 6532.7 9300.7 10875.8 11002.2 11115.2 11158.8 10711.3 10795.1 10879.6 10963.8 11003.0 8919.3 8990.6 9088.8 9110.3 9154.8 8576.7 8611.1 8615.9 8731.7 8734.7 9562.4 9852.4 9906.4 10264.0 10302.7 8316.5 10076.1 10107.8 10382.5 10425.6 7712.5 7870.7 7895.0 7898.1 7940.7 8512.2 8559.0 8612.7 8671.2 8768.0 7709.0 7800.9 7848.3 7871.9 7896.5 6626.2 7775.2 7839.7 7846.8 7917.2 8258.5 8297.3 8302.2 8315.1 8385.5 7484.9 7524.7 7548.5 7595.8 7617.9 7507.4 7604.7 7681.8 7695.3 7727.7 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:6044.42 Median:6884.04 stddev:1955.45 (28.4%) stddev-sans-first:1913.52 13:30:05 INFO - PROCESS | 1664 | Values: 341.7 341.7 345.7 348.8 352.3 6876.6 6902.2 6924.0 6936.9 6953.3 6864.3 6881.9 6886.2 6888.3 6893.5 4893.3 4958.2 5042.2 5047.5 5078.2 5009.0 5038.1 5049.8 5050.3 5055.7 5069.7 5079.0 5090.0 5097.5 5103.7 5086.2 5104.0 5109.9 5123.6 5142.0 4390.6 4398.4 4399.4 4399.9 4400.2 6286.6 6572.2 6609.8 6621.9 6655.6 5912.6 5939.9 5956.3 5956.8 5973.6 7395.6 7400.1 7410.0 7433.1 7436.4 4764.9 4769.4 4775.0 4793.8 4803.7 5687.8 6656.5 7665.4 7786.5 7806.4 4351.9 4770.3 4778.9 4842.9 4872.6 4941.6 4943.6 4948.0 4967.8 4969.5 5901.3 5934.6 5959.7 5961.3 5962.0 7366.8 7438.9 7442.4 7453.8 7466.3 1405.2 1642.5 1680.9 1690.7 1707.9 1072.9 1077.2 1089.9 1093.4 1096.9 5710.0 7071.6 7091.5 7105.7 7125.8 6585.1 7609.9 7621.3 7627.0 7648.3 6582.8 7061.4 7074.1 7086.5 7154.2 3750.4 4034.0 4056.3 4070.9 4072.8 7867.8 7971.8 7991.9 8066.9 8081.6 6464.9 7959.5 7969.2 7991.7 8055.6 8135.5 8136.6 8155.9 8166.1 8193.6 7513.8 7781.0 7810.6 7818.7 7834.3 7519.1 7557.8 7570.8 7580.3 7583.5 8100.4 8139.2 8141.6 8150.0 8161.0 4821.1 4836.0 4840.2 4844.1 4851.8 7352.3 7616.9 7626.3 7659.4 7742.4 7364.9 7373.3 7434.9 7533.4 7540.9 6110.2 7397.9 7461.6 7503.4 7528.0 7079.5 7234.5 7286.7 7313.4 7322.2 5024.7 7435.0 7512.5 7527.4 7606.0 7321.2 7334.7 7350.1 7365.8 7377.8 13:30:05 INFO - PROCESS | 1664 | 13:30:05 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18793.36 Median:25516.66 stddev:26147.34 (102.5%) stddev-sans-first:26185.13 13:30:05 INFO - PROCESS | 1664 | Values: 632.9 774.8 779.3 802.6 807.3 15424.3 15461.8 15554.8 15583.1 15696.6 14340.4 14492.3 14841.6 14939.4 14992.0 806.3 952.0 959.3 973.2 975.9 975.4 978.2 980.9 983.7 989.1 996.1 1003.2 1012.5 1017.8 1020.2 982.3 1000.9 1007.5 1012.3 1016.6 750.0 750.8 756.7 757.9 765.8 15573.1 15615.8 15644.4 15727.1 15957.7 13444.5 13480.4 13510.3 13605.5 13608.6 9949.7 10051.4 10318.0 10323.6 10363.0 3024.0 3586.7 3629.5 3650.0 3711.2 82290.6 83293.6 84617.7 84655.0 85041.0 9729.0 10036.9 10093.3 10231.3 10272.1 23374.0 23601.5 23698.2 23762.4 23823.4 7884.0 7930.8 7931.5 8029.2 8197.0 4266.0 4271.5 4306.3 4331.0 4347.8 3740.4 3758.8 3774.9 3792.1 3795.2 597.9 609.6 658.9 669.5 691.3 543.8 561.8 579.6 583.1 598.6 8613.7 8681.1 8754.9 8842.6 8962.4 509.6 527.9 591.6 592.9 619.4 3704.2 3915.9 4040.4 4081.8 4102.9 90831.5 92000.5 93221.1 96395.0 97317.0 72654.3 73262.6 84902.2 85199.0 86586.0 65054.7 67609.0 70478.8 72091.3 72968.6 8067.2 8875.8 8906.8 8962.0 8981.3 49092.5 50523.7 51888.0 51905.7 52289.0 54769.7 56877.7 69836.7 74035.6 75561.6 11001.4 11466.0 11499.5 11600.0 11672.1 12207.8 12701.4 12720.7 12726.8 12996.3 11831.2 11972.6 12013.6 12298.4 12300.6 10292.0 11780.9 12039.3 12076.7 12177.3 11671.8 11731.4 11774.9 11928.7 12118.5 9858.5 9870.3 9919.5 9992.7 10047.6 8942.9 9597.6 9883.2 10048.6 10064.8 13:30:05 INFO - PROCESS | 1664 | -------- Summary: end -------- 13:30:05 INFO - PROCESS | 1664 | 13:30:06 INFO - TEST-INFO | 1664: exit 0 13:30:06 INFO - TEST-OK | dromaeo_css | took 1109695ms 13:30:06 INFO - TEST-START | kraken 13:30:06 INFO - operating with platform_type : mac_ 13:30:06 INFO - Initialising browser for kraken test... 13:30:06 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpdBqqKN/profile http://localhost:49270/getInfo.html) 13:30:08 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 13:30:08 INFO - PROCESS | 1673 | colorDepth:24 13:30:08 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 13:30:08 INFO - PROCESS | 1673 | __metrics 13:30:09 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:30:09 INFO - TEST-INFO | 1673: exit 0 13:30:09 INFO - Browser initialized. 13:30:09 INFO - Running cycle 1/1 for kraken test... 13:30:09 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpdBqqKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:21 INFO - PROCESS | 1677 | RSS: Main: 167948288 13:30:21 INFO - PROCESS | 1677 | 13:30:24 INFO - PROCESS | 1677 | 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) 13:30:24 INFO - PROCESS | 1677 | RSS: Main: 179720192 13:30:24 INFO - PROCESS | 1677 | 13:30:27 INFO - PROCESS | 1677 | 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) 13:30:28 INFO - PROCESS | 1677 | RSS: Main: 188690432 13:30:28 INFO - PROCESS | 1677 | 13:30:31 INFO - PROCESS | 1677 | 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) 13:30:31 INFO - PROCESS | 1677 | RSS: Main: 192757760 13:30:31 INFO - PROCESS | 1677 | 13:30:33 INFO - PROCESS | 1677 | 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) 13:30:34 INFO - PROCESS | 1677 | RSS: Main: 193986560 13:30:34 INFO - PROCESS | 1677 | 13:30:36 INFO - PROCESS | 1677 | 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) 13:30:37 INFO - PROCESS | 1677 | RSS: Main: 194625536 13:30:37 INFO - PROCESS | 1677 | 13:30:40 INFO - PROCESS | 1677 | 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) 13:30:40 INFO - PROCESS | 1677 | RSS: Main: 194985984 13:30:40 INFO - PROCESS | 1677 | 13:30:43 INFO - PROCESS | 1677 | 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) 13:30:44 INFO - PROCESS | 1677 | RSS: Main: 194437120 13:30:44 INFO - PROCESS | 1677 | 13:30:47 INFO - PROCESS | 1677 | 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) 13:30:47 INFO - PROCESS | 1677 | RSS: Main: 194445312 13:30:47 INFO - PROCESS | 1677 | 13:30:49 INFO - PROCESS | 1677 | 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) 13:30:49 INFO - PROCESS | 1677 | RSS: Main: 194551808 13:30:49 INFO - PROCESS | 1677 | 13:30:51 INFO - PROCESS | 1677 | 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) 13:30:52 INFO - PROCESS | 1677 | RSS: Main: 194158592 13:30:52 INFO - PROCESS | 1677 | 13:30:54 INFO - PROCESS | 1677 | 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) 13:30:55 INFO - PROCESS | 1677 | RSS: Main: 195096576 13:30:55 INFO - PROCESS | 1677 | 13:30:57 INFO - PROCESS | 1677 | 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) 13:30:58 INFO - PROCESS | 1677 | RSS: Main: 195309568 13:30:58 INFO - PROCESS | 1677 | 13:31:00 INFO - PROCESS | 1677 | 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) 13:31:01 INFO - PROCESS | 1677 | RSS: Main: 194715648 13:31:01 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | 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) 13:31:03 INFO - PROCESS | 1677 | RSS: Main: 196526080 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | __start_tp_report 13:31:03 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 13:31:03 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 13:31:03 INFO - PROCESS | 1677 | |i|pagename|runs| 13:31:03 INFO - PROCESS | 1677 | |0;ai-astar;115;111;113;116;116;129;114;115;115;117 13:31:03 INFO - PROCESS | 1677 | |1;audio-beat-detection;150;126;185;178;122;156;147;159;142;120 13:31:03 INFO - PROCESS | 1677 | |2;audio-dft;194;198;195;200;196;195;197;193;197;199 13:31:03 INFO - PROCESS | 1677 | |3;audio-fft;69;72;70;112;69;55;84;87;154;56 13:31:03 INFO - PROCESS | 1677 | |4;audio-oscillator;84;107;160;118;112;112;117;80;78;121 13:31:03 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;92;89;92;89;78;131;134;90;96;125 13:31:03 INFO - PROCESS | 1677 | |6;imaging-darkroom;115;149;97;97;114;148;118;96;95;115 13:31:03 INFO - PROCESS | 1677 | |7;imaging-desaturate;115;145;92;91;92;91;94;95;94;89 13:31:03 INFO - PROCESS | 1677 | |8;json-parse-financial;55;58;59;60;58;60;59;59;59;57 13:31:03 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;68;74;64;69;77;73;67;64;63;70 13:31:03 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;98;105;109;108;82;83;84;80;91;92 13:31:03 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;122;133;135;103;135;130;106;130;130;137 13:31:03 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;132;136;134;139;172;176;132;138;137;176 13:31:03 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;62;84;93;85;67;72;89;67;54;92 13:31:03 INFO - PROCESS | 1677 | __end_tp_report 13:31:03 INFO - PROCESS | 1677 | __start_cc_report 13:31:03 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,905 13:31:03 INFO - PROCESS | 1677 | __end_cc_report 13:31:03 INFO - PROCESS | 1677 | __startTimestamp1462480263412__endTimestamp 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | ------- Summary: start ------- 13:31:03 INFO - PROCESS | 1677 | Number of tests: 14 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:116.10 Median:115.50 stddev:4.84 (4.2%) stddev-sans-first:5.12 13:31:03 INFO - PROCESS | 1677 | Values: 115.0 111.0 113.0 116.0 116.0 129.0 114.0 115.0 115.0 117.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.00 stddev:22.20 (14.5%) stddev-sans-first:23.54 13:31:03 INFO - PROCESS | 1677 | Values: 150.0 126.0 185.0 178.0 122.0 156.0 147.0 159.0 142.0 120.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:196.40 Median:197.00 stddev:2.22 (1.1%) stddev-sans-first:2.18 13:31:03 INFO - PROCESS | 1677 | Values: 194.0 198.0 195.0 200.0 196.0 195.0 197.0 193.0 197.0 199.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:82.80 Median:69.50 stddev:29.99 (43.1%) stddev-sans-first:31.39 13:31:03 INFO - PROCESS | 1677 | Values: 69.0 72.0 70.0 112.0 69.0 55.0 84.0 87.0 154.0 56.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:140.50 stddev:24.36 (17.3%) stddev-sans-first:24.11 13:31:03 INFO - PROCESS | 1677 | Values: 84.0 107.0 160.0 118.0 112.0 112.0 117.0 80.0 78.0 121.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:101.60 Median:89.50 stddev:20.24 (22.6%) stddev-sans-first:21.17 13:31:03 INFO - PROCESS | 1677 | Values: 92.0 89.0 92.0 89.0 78.0 131.0 134.0 90.0 96.0 125.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:114.40 Median:122.00 stddev:20.17 (16.5%) stddev-sans-first:21.39 13:31:03 INFO - PROCESS | 1677 | Values: 115.0 149.0 97.0 97.0 114.0 148.0 118.0 96.0 95.0 115.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:92.00 stddev:17.50 (19.0%) stddev-sans-first:17.68 13:31:03 INFO - PROCESS | 1677 | Values: 115.0 145.0 92.0 91.0 92.0 91.0 94.0 95.0 94.0 89.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:1.51 (2.6%) stddev-sans-first:0.97 13:31:03 INFO - PROCESS | 1677 | Values: 55.0 58.0 59.0 60.0 58.0 60.0 59.0 59.0 59.0 57.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.50 stddev:4.68 (6.7%) stddev-sans-first:4.95 13:31:03 INFO - PROCESS | 1677 | Values: 68.0 74.0 64.0 69.0 77.0 73.0 67.0 64.0 63.0 70.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:83.50 stddev:11.18 (13.4%) stddev-sans-first:11.73 13:31:03 INFO - PROCESS | 1677 | Values: 98.0 105.0 109.0 108.0 82.0 83.0 84.0 80.0 91.0 92.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:131.50 stddev:12.13 (9.2%) stddev-sans-first:12.78 13:31:03 INFO - PROCESS | 1677 | Values: 122.0 133.0 135.0 103.0 135.0 130.0 106.0 130.0 130.0 137.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:138.50 stddev:19.12 (13.8%) stddev-sans-first:19.48 13:31:03 INFO - PROCESS | 1677 | Values: 132.0 136.0 134.0 139.0 172.0 176.0 132.0 138.0 137.0 176.0 13:31:03 INFO - PROCESS | 1677 | 13:31:03 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:84.50 stddev:13.80 (16.3%) stddev-sans-first:13.61 13:31:03 INFO - PROCESS | 1677 | Values: 62.0 84.0 93.0 85.0 67.0 72.0 89.0 67.0 54.0 92.0 13:31:03 INFO - PROCESS | 1677 | -------- Summary: end -------- 13:31:03 INFO - PROCESS | 1677 | 13:31:04 INFO - TEST-INFO | 1677: exit 0 13:31:04 INFO - TEST-OK | kraken | took 58028ms 13:31:04 INFO - SUITE-END | took 1167s 13:31:04 INFO - Completed test suite (00:19:27) 13:31:04 INFO - javascript benchmark 13:31:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3668.926621467571, 3702.740808143428, 3717.7769333839956, 3754.586995430502, 3762.6049264827193, 6035.60768550045, 6093.238345206849, 6120.274092665631, 6124.693765311739, 6126.33124129357, 6100.054491553805, 6131.632102073879, 6149.631022138675, 6164.0, 6166.81499555014, 4831.743746625885, 5405.783768649249, 5462.399136095027, 5511.751971161308, 5540.307461567304, 4701.553352431513, 5494.395616482184, 5502.064649009658, 5522.254495643077, 5526.834194974157, 5494.972525137368, 5531.225628412026, 5569.192467092269, 5601.691906945116, 5632.577556683244, 5525.226468294442, 5535.086710692731, 5549.805756798533, 5555.638883472561, 5564.972175139139, 5259.447757985433, 5408.891822163574, 5462.808801691962, 5489.890202195934, 5508.394076651565, 5944.286685597713, 6005.129256257862, 6020.849478763066, 6024.5481588880575, 6082.057281121389, 6296.929521981274, 6317.0, 6341.556091073627, 6342.953412686948, 6354.3963323484195, 6256.499480041586, 6362.745490180388, 6398.232212134573, 6413.935860641381, 6427.8393040173905, 6114.784027539392, 6144.96927515364, 6179.16581261524, 6186.257649082139, 6194.132821405007, 6504.252011018699, 6581.506387020992, 6597.208334999735, 6600.702968366435, 6608.933910660832, 6184.288806787187, 6248.375162483806, 6267.4986001119805, 6290.748370065146, 6294.0, 6447.967760161169, 6463.741450341934, 6483.513736469784, 6494.318096599884, 6500.382463665944, 6305.085762564494, 6326.620402775849, 6329.68351582419, 6335.239771227482, 6335.619862808247, 6244.219472565929, 6257.530685198628, 6318.178636777189, 6367.713452894631, 6393.808185754435, 5134.5378915897745, 5150.716710580879, 5162.967406518711, 5182.093133701587, 5258.0, 3959.742616729903, 4634.907301853944, 4660.5106463821485, 4663.137319595886, 4673.392458980311, 6097.3292937776805, 6122.794608433986, 6125.052321061979, 6178.135061091451, 6207.875842483125, 5024.447310795809, 6445.4891515013605, 6474.838129046717, 6492.610443373413, 6516.837079073061, 6063.423974722395, 6164.445199932027, 6190.0405437157315, 6210.441060304594, 6223.37766223374, 5555.777768889199, 5666.2350582670815, 5679.574031947621, 5744.971275143597, 5774.0, 6678.3989440950545, 6736.02327662496, 6776.220734615484, 6788.083608712859, 6814.727410903508, 6340.651264180515, 6444.581102228341, 6528.347165283623, 6545.639989800607, 6549.901751473827, 6605.1083103780375, 6649.800505984828, 6699.062131301719, 6714.496412768965, 6732.562383445061, 6396.968015159894, 6410.1987251593555, 6413.807585772434, 6418.550701450854, 6439.967800161156, 6296.968515157395, 6374.298827129105, 6438.323975982642, 6476.870462590816, 6498.220213574401, 5098.719570423662, 5419.6206265562605, 6341.619502829845, 6348.77779277723, 6361.968190159019, 6262.906056409249, 6295.842603934755, 6298.4883627929885, 6301.40136687014, 6319.747210111544, 6057.18228039209, 6137.60105593135, 6139.079138129317, 6224.37756224374, 6251.218597675291, 6263.68681565929, 6321.494280457644, 6353.110564520878, 6355.968220158869, 6356.110144579855, 5847.532197424111, 6191.19514463117, 6211.13044173807, 6225.937740622717, 6232.8130156095385], "unit": "score", "name": "dojo.html", "value": 5947.561717433227}, {"lowerIsBetter": false, "replicates": [497.5820310938811, 580.8673087479416, 586.9941300586995, 654.0450941625227, 654.8002859127965, 38543.0, 39186.21627567447, 39196.21607567847, 39217.01957451062, 39392.60607393925, 40376.990575235635, 40693.59306406935, 40819.59180408195, 41063.0, 41526.0, 9716.174125199366, 9954.352967057119, 9963.651272205474, 9978.351407158547, 10016.449095299755, 9807.215422766198, 9872.802543949118, 9900.851487227697, 9973.401595904268, 9982.500874956224, 9917.950410247975, 9936.35413698111, 9938.105570498654, 9939.353941993748, 9946.154576860976, 9881.715377001015, 9885.505724713736, 9913.900860991405, 9956.402615843073, 10024.498775061254, 9823.852642210373, 9912.801743965152, 9954.751131221705, 9964.402135871871, 9968.750781230454, 40366.39450408246, 40743.98140046493, 40749.57376491838, 41023.7948810254, 41258.1748365034, 3420.162060295219, 3451.4650229214512, 3508.824558772051, 3586.264815712773, 3617.240379520304, 21961.23135690243, 28138.155855324374, 28200.294992625142, 28562.143135705963, 28563.57154642682, 2724.3573733478493, 2805.1724741201397, 2814.9014784482447, 2831.362943337753, 2890.6242188515357, 416180.0, 417974.91012544744, 418033.0, 421426.0, 425173.0, 47472.52527474681, 48062.759686202044, 66203.66898165575, 66455.0, 66908.99636505457, 46705.13179472851, 46766.0, 46927.06145877064, 46927.59217223489, 46971.5302846974, 16299.429519966981, 16557.0, 16754.916225418794, 16922.0, 17103.914480427517, 13241.0, 13427.0, 13458.663533411744, 13573.864261357458, 13595.252261125734, 14663.48677796272, 15147.394104235927, 15161.862860285522, 15503.84496155024, 15639.68720625581, 6479.8056058318325, 6517.3808488193545, 6582.3746744059235, 6612.404883560503, 6623.0, 1018.9439580822977, 1078.320657985464, 1104.2325583719398, 1121.747606788466, 1123.3709122891044, 30329.393412132074, 30465.69534304673, 30812.845935770627, 31023.379532409224, 31073.533896991565, 1030.9690709278734, 1147.5352482244705, 1215.2829830400105, 1240.2496489623827, 1255.152771878978, 15501.689966200613, 15723.292451839694, 15771.266785632222, 15775.921120394554, 15973.840261597468, 526820.0, 528655.0, 560776.1961190169, 562255.0, 566699.0, 60044.79910401855, 60053.399466005656, 60527.394726053055, 61053.38946610566, 61121.0, 1497.5133081748259, 1498.932548035341, 1528.892977491587, 1531.326216464752, 1545.6522282486576, 24696.753032469445, 29307.85346073256, 29854.0, 30686.693133069275, 30948.69051309548, 51909.740451297504, 57588.71205643945, 57624.423755763586, 59261.0, 59377.0, 523219.0, 527235.0, 528436.0, 528836.0, 534489.0, 43105.0, 44753.77623111864, 46164.307535386324, 46262.53737462717, 46783.76608116938, 48481.0, 48513.757431212616, 49077.01845962989, 50199.0, 50317.0, 36313.63686363103, 37166.070848229014, 37432.06419839526, 37546.62453375541, 39254.80372598119, 38122.809385952896, 38566.42150367691, 38730.80634596809, 38817.61182388253, 39346.803265983486, 30888.53667194949, 35297.235138242475, 38417.03957401087, 41470.79264603658, 41520.82316496199, 33471.83264083664, 34109.97670069902, 34368.312633747686, 34390.65609343975, 34444.48333274953, 26383.67834989957, 26411.0, 26518.60222096709, 26538.60192097159, 26844.0], "unit": "score", "name": "ext.html", "value": 20087.01089990529}, {"lowerIsBetter": false, "replicates": [333.7080054951917, 373.64130434782606, 379.70003697079306, 388.9436031775393, 389.9317619416601, 20292.89853550732, 20495.38513844585, 20628.69056964147, 20955.0, 21161.153553857846, 20807.0, 21000.789992100075, 21036.57926841462, 21277.68083478749, 21278.787212127874, 5998.610090344125, 6210.441060304572, 6264.0, 6282.214723159594, 6283.277423096357, 4236.110416812473, 5829.213056237418, 6036.185115009462, 6285.214348206474, 6287.308396076428, 6126.938730612704, 6143.7235324410285, 6153.476954458876, 6156.2920264169525, 6232.439080482755, 6169.753209871622, 6699.39705426509, 6714.3957043866285, 6801.897971530431, 6833.282505336918, 5770.16332631766, 5904.1734157218025, 5907.940920590782, 6002.819915402545, 6045.576809623328, 25334.493310133694, 25354.366140846443, 25418.36454088644, 25463.0, 26217.868910655514, 2120.946976325589, 2227.532218234173, 2248.404172894168, 2280.1221529711015, 2329.974811083118, 10239.590416383337, 10363.170946324275, 10710.839337409945, 14587.051841630366, 15476.535703928901, 1810.6831304521788, 1823.1431227323137, 1840.2730921286152, 1859.9349022784272, 1871.2047379863504, 100831.0, 105722.47138764334, 107311.92688073097, 107563.46218268937, 107687.46156269168, 11098.278611890362, 11502.654920352403, 11794.938455539042, 12001.219920705125, 12087.516499339928, 14592.051516651383, 14783.852161478462, 14805.481808136663, 14824.62938426548, 14844.554663360117, 8902.24330931865, 9034.32242581809, 9083.863742043875, 9196.678116265899, 9204.539773011322, 9076.41003334781, 9151.993280739114, 9212.953935230282, 9216.0, 9283.953580232055, 3884.4950156479476, 4497.347884556721, 4535.274356103007, 4586.243269860503, 4673.065386922629, 1818.0818686563466, 1884.9717254241198, 1919.7312376267334, 1958.4222654317011, 2012.7987201279755, 898.3127907151035, 955.3312681123102, 1021.5147804792664, 1052.7473406382412, 1116.9218154729092, 17268.827311726975, 18551.53621159455, 18920.33778817735, 20001.499962501053, 20878.0, 982.8820541535061, 987.521052289639, 1022.4887556221889, 1049.4333060147587, 1094.0, 10781.730456738644, 10961.616343427942, 10967.83548246777, 10977.28647637901, 10990.450477476094, 637894.0, 645963.0, 652410.0, 658415.0, 659682.0, 100560.99439005516, 101036.49481752544, 101480.0, 102279.0, 108862.0, 852.3564708645057, 1010.8534262531891, 1021.4280003198232, 1027.3887037212846, 1055.308772753832, 17980.820191797913, 18019.279228831223, 18215.45353639393, 18317.90841045786, 18691.25234990585, 44057.339139913565, 45491.54508455005, 45575.31637025381, 45972.540274596824, 50663.49336506588, 63122.0, 65697.0, 66413.66793166003, 67667.0, 69421.0, 7559.28186822251, 7609.516144351798, 8019.478733882279, 8076.878846817185, 8481.83036339282, 12287.0, 13431.798523021967, 13586.0, 13611.79582306286, 13696.452141914211, 9742.123208911233, 11091.33451992883, 11521.423928803693, 11610.5355785771, 11815.0, 11373.488193031499, 11425.828612570984, 11541.307521548733, 11632.53469861196, 11764.235324703866, 10268.58925642966, 11912.463939122586, 11913.583024594098, 12115.273083615011, 12148.574799881962, 8189.099199088215, 8420.62107205165, 8453.91546084556, 8455.577221139041, 8556.10160933093, 10909.0, 11932.22440541362, 12065.0, 12071.336076515876, 12114.0], "unit": "score", "name": "jquery.html", "value": 9675.871936101641}, {"lowerIsBetter": false, "replicates": [1541.7995660564122, 1676.740105283681, 1908.5610309628785, 2118.480972161821, 2126.046312092824, 8410.453320534161, 9108.089191080897, 9115.453072815619, 9116.17954384106, 9248.953755231223, 9069.365144439875, 9160.587773550189, 9171.403858749176, 9183.357164998453, 9306.813863722738, 2562.8206025578265, 2573.652556904822, 2579.200447861169, 2581.354661334666, 2582.586786114222, 2202.2402271216406, 2498.537770512452, 2565.102214225016, 2574.2663340947834, 2601.427685909097, 2558.4627228282084, 2576.896924123033, 2581.5353236417436, 2589.507993481242, 2596.247088344378, 2568.0113156434722, 2576.124117799957, 2576.9226923192145, 2583.509133264683, 2603.713591504933, 2551.2983929419374, 2554.476332351863, 2607.674040744907, 2613.007057318226, 2614.072004438416, 7093.503454758169, 9413.717588472357, 9466.952665236699, 9474.431534107976, 9495.66765163216, 4993.275974983643, 5752.338481074688, 5796.88406231873, 5827.388124246935, 5956.0, 3716.981415092934, 3825.5409350877794, 3826.6747326477284, 3848.4804551385487, 3867.4005529142746, 948.0470231323495, 1067.1516144664931, 1091.3397394576325, 1118.8769235384102, 1122.9388228124426, 12359.01127909774, 12750.489980400773, 12772.872271277261, 12774.936125319407, 12802.551910683082, 5081.161608334657, 5104.3619547556555, 5217.478252174752, 5227.3465816772905, 5248.9737551312, 10582.100521455608, 10602.0, 10668.359898406121, 10779.083777878968, 10960.835587466194, 5680.6591604503865, 5734.340550836707, 5762.538996880239, 5787.88424231513, 5847.619904706181, 4038.919221615551, 4777.0, 5186.118359878829, 5263.526282634582, 5270.947290527046, 3984.382420724792, 4173.436586060843, 4178.770167640748, 4215.241256573846, 4219.628620698285, 1235.9629211123502, 1288.3944546063335, 1291.541502766523, 1298.8766067223598, 1313.6124843171287, 1397.105852254558, 1403.1712662257066, 1415.971680566383, 1471.0952764050032, 1473.042522360453, 8382.371322150862, 8515.701950431705, 8552.401331906707, 8661.220490155916, 8661.566921653892, 526.4288247251775, 530.1358785180132, 531.8324727710759, 534.4201541327625, 538.0933127679793, 5448.291722076184, 5619.466150715757, 6431.871362572816, 6497.740090396331, 6532.706028228741, 9300.72097837066, 10875.83686244707, 11002.229843910849, 11115.166362522843, 11158.776824463464, 10711.303765255388, 10795.136389088853, 10879.564817407374, 10963.83554246687, 11003.0, 8919.286457083548, 8990.595423205972, 9088.81822363549, 9110.316726245557, 9154.81690366189, 8576.748977307403, 8611.05278419361, 8615.91384086151, 8731.738047858575, 8734.650613975624, 9562.378445401027, 9852.408855468695, 9906.405615663083, 10264.0, 10302.742431438974, 8316.459430137022, 10076.09315161639, 10107.848382274418, 10382.480875956324, 10425.63510277167, 7712.460127791001, 7870.72452464161, 7894.960525197567, 7898.131205567268, 7940.682372705027, 8512.191341822518, 8559.015713193063, 8612.698555550525, 8671.21959023691, 8768.035516093352, 7708.997830282027, 7800.882986755089, 7848.293653571206, 7871.921280787119, 7896.486728362638, 6626.204855417381, 7775.183605721318, 7839.725609603636, 7846.803829904298, 7917.247861453153, 8258.463199891989, 8297.29472994778, 8302.169783021649, 8315.085340612648, 8385.496870187808, 7484.925150748641, 7524.699012039458, 7548.4716069874585, 7595.810104747205, 7617.885731714139, 7507.436942229464, 7604.695812167452, 7681.846363072819, 7695.307422332017, 7727.652255648622], "unit": "score", "name": "mootools.html", "value": 5082.378002166272}, {"lowerIsBetter": false, "replicates": [341.67370161495774, 341.74539967724036, 345.65952536751297, 348.7732973567181, 352.25322316688624, 6876.587404755712, 6902.171739391274, 6923.965380173098, 6936.895946560806, 6953.33943275388, 6864.347886950744, 6881.862362752742, 6886.2080860701035, 6888.3111688831095, 6893.482988775837, 4893.266010098487, 4958.206686930092, 5042.218456139304, 5047.47001564836, 5078.1874900016, 5008.974955125219, 5038.093143234217, 5049.77276022578, 5050.267711181877, 5055.747212639371, 5069.721165335905, 5079.009593129341, 5089.974550127245, 5097.49025097491, 5103.744812759366, 5086.21163719624, 5104.0, 5109.872253193663, 5123.644013171379, 5142.0, 4390.604845563883, 4398.362237475548, 4399.428074350314, 4399.912001759947, 4400.163968845941, 6286.559940804145, 6572.211334639826, 6609.834754131185, 6621.933780662228, 6655.633940133291, 5912.586118971631, 5939.940600593982, 5956.315023772278, 5956.821295361146, 5973.611715238496, 7395.630218489054, 7400.074990626172, 7409.962950185269, 7433.145188303361, 7436.367908727764, 4764.857054288377, 4769.403824521934, 4774.952250477486, 4793.808247670089, 4803.7357945313, 5687.800926967537, 6656.5340426169705, 7665.386769058462, 7786.493877897975, 7806.375489960847, 4351.934720979188, 4770.260609605517, 4778.904421911542, 4842.903141937141, 4872.585830204473, 4941.604671626261, 4943.604511639061, 4948.0, 4967.82612608557, 4969.527894849984, 5901.262342207224, 5934.614250073818, 5959.672218027963, 5961.344252132262, 5961.970190149022, 7366.77899663011, 7438.888416673754, 7442.404607631376, 7453.838386867856, 7466.328030477283, 1405.2411697683342, 1642.482617975334, 1680.899146051241, 1690.653416049707, 1707.9316827326768, 1072.9409882456384, 1077.1867240233573, 1089.9073578745738, 1093.4040947683532, 1096.9140550854597, 5709.9714501427225, 7071.611061391673, 7091.503594748318, 7105.715771369088, 7125.786226413215, 6585.1439312889015, 7609.885851712229, 7621.275978782007, 7626.961865190749, 7648.273414025659, 6582.80251592453, 7061.435085193172, 7074.080369552028, 7086.503944723923, 7154.2050938739785, 3750.39993601028, 4033.979830100831, 4056.3104272273786, 4070.898227544335, 4072.7963601819793, 7867.763967080882, 7971.800704982422, 7991.880121798177, 8066.919330806617, 8081.555514446762, 6464.935350646433, 7959.482633628795, 7969.163237860057, 7991.72028978983, 8055.5972201389695, 8135.511869287861, 8136.633851476698, 8155.877661835078, 8166.060902996112, 8193.631286592117, 7513.812154696177, 7781.0, 7810.57041862703, 7818.726344577913, 7834.334081603128, 7519.097708275042, 7557.773266802004, 7570.848583028419, 7580.317771400601, 7583.469157158946, 8100.4329696923005, 8139.18608139205, 8141.552214628252, 8150.021997360354, 8161.020677518736, 4821.059893320768, 4835.95164048369, 4840.249761287007, 4844.079624871263, 4851.80592776285, 7352.264773522819, 7616.857471379116, 7626.275503827128, 7659.425543084402, 7742.38060955111, 7364.926350736639, 7373.262673732584, 7434.851302973802, 7533.359664428585, 7540.886886696594, 6110.205673262448, 7397.889031664422, 7461.552306861606, 7503.399728021855, 7527.962360188164, 7079.504434689728, 7234.493585449179, 7286.672099755418, 7313.378362839006, 7322.1579518356075, 5024.723640199824, 7435.0, 7512.511686740344, 7527.360174385239, 7605.961970190114, 7321.158066822383, 7334.652911068407, 7350.08123984502, 7365.7790266292095, 7377.77866664001], "unit": "score", "name": "prototype.html", "value": 5387.389031342018}, {"lowerIsBetter": false, "replicates": [632.9303776584575, 774.8372841703242, 779.3414564692832, 802.5801465451901, 807.3057170833082, 15424.305906234218, 15461.845381546182, 15554.84445155548, 15583.065016099043, 15696.607584810385, 14340.426382944695, 14492.347844347003, 14841.628959275997, 14939.402423903059, 14992.0, 806.3226889412892, 952.0051546134289, 959.2709540749046, 973.1582181413062, 975.9365641233297, 975.4342481360829, 978.2027647467327, 980.9117179453848, 983.6753871222515, 989.1394486796461, 996.0736515041009, 1003.1924300937742, 1012.4633944009687, 1017.8473229015633, 1020.1787561013381, 982.29274922056, 1000.9349392289514, 1007.5012868630001, 1012.336919317848, 1016.5577973581479, 749.9812504687372, 750.8047907544023, 756.6557216466495, 757.8787394016931, 765.8391737735027, 15573.065616062959, 15615.765763513557, 15644.374225030984, 15727.05637661744, 15957.680846383124, 13444.529441469502, 13480.39338229782, 13510.32448377587, 13605.523806666819, 13608.591742247749, 9949.701508954742, 10051.447170405625, 10318.0, 10323.638672646497, 10363.015513526203, 3023.969760302391, 3586.659267369596, 3629.546306711661, 3650.0144960860684, 3711.2020915503026, 82290.58854705749, 83293.58353208256, 84617.73073403904, 84655.0, 85041.0, 9729.0, 10036.949815250877, 10093.293469457214, 10231.306081754736, 10272.12686921605, 23374.0, 23601.527969440514, 23698.170564030523, 23762.405939851295, 23823.404414889766, 7884.0, 7930.801729956797, 7931.484453510619, 8029.237222463857, 8197.0, 4265.957340426618, 4271.487421509439, 4306.267934451151, 4330.956690433119, 4347.847820327615, 3740.382836831947, 3758.755680880734, 3774.905627359338, 3792.1278106035215, 3795.2409518095938, 597.9402059793986, 609.6494515653428, 658.8846951783419, 669.5045666206972, 691.3190507350256, 543.8205392220558, 561.7556362982116, 579.6377264209868, 583.1486030395586, 598.5959477352769, 8613.69852055175, 8681.088485709037, 8754.91245087541, 8842.646294148291, 8962.372633915564, 509.5795968326146, 527.9076161671692, 591.5740666719955, 592.8517870532366, 619.3960888134034, 3704.2221133561716, 3915.882523524242, 4040.373742069984, 4081.755094694328, 4102.876913692594, 90831.54584227169, 92000.53999729958, 93221.0677893226, 96395.0, 97317.0, 72654.27345726581, 73262.6336868323, 84902.15097849067, 85199.0, 86586.0, 65054.674726626065, 67609.0, 70478.79780983998, 72091.27908720846, 72968.63515682388, 8067.233612806774, 8875.801766761404, 8906.777330566529, 8962.0, 8981.263295288767, 49092.50907490879, 50523.74738126286, 51888.0, 51905.740471298916, 52289.0, 54769.72615136899, 56877.71561142168, 69836.65081674559, 74035.62982185054, 75561.62219188869, 11001.449927503752, 11466.025387842126, 11499.482523286304, 11599.956003959684, 11672.124590655565, 12207.75584488323, 12701.42843572023, 12720.6819829505, 12726.809097863354, 12996.285204313854, 11831.230969986924, 11972.58095966637, 12013.579524716943, 12298.446569904198, 12300.569480068512, 10292.0, 11780.941095294469, 12039.337836419081, 12076.698082548006, 12177.269363838199, 11671.824922626338, 11731.35477548743, 11774.94112529432, 11928.70178245516, 12118.515259389525, 9858.457784821903, 9870.259730520096, 9919.504024798876, 9992.65025724096, 10047.648332308334, 8942.882139732534, 9597.568109434953, 9883.159931405911, 10048.598056077968, 10064.798704026025], "unit": "score", "name": "yui.html", "value": 7177.43338478113}], "name": "dromaeo_css", "value": 7811.4542538331225}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 113.0, 116.0, 116.0, 129.0, 114.0, 115.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 185.0, 178.0, 122.0, 156.0, 147.0, 159.0, 142.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [194.0, 198.0, 195.0, 200.0, 196.0, 195.0, 197.0, 193.0, 197.0, 199.0], "unit": "score", "name": "audio-dft", "value": 196.4}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 70.0, 112.0, 69.0, 55.0, 84.0, 87.0, 154.0, 56.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [84.0, 107.0, 160.0, 118.0, 112.0, 112.0, 117.0, 80.0, 78.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [92.0, 89.0, 92.0, 89.0, 78.0, 131.0, 134.0, 90.0, 96.0, 125.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.6}, {"lowerIsBetter": true, "replicates": [115.0, 149.0, 97.0, 97.0, 114.0, 148.0, 118.0, 96.0, 95.0, 115.0], "unit": "score", "name": "imaging-darkroom", "value": 114.4}, {"lowerIsBetter": true, "replicates": [115.0, 145.0, 92.0, 91.0, 92.0, 91.0, 94.0, 95.0, 94.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 99.8}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 59.0, 60.0, 58.0, 60.0, 59.0, 59.0, 59.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 64.0, 69.0, 77.0, 73.0, 67.0, 64.0, 63.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [98.0, 105.0, 109.0, 108.0, 82.0, 83.0, 84.0, 80.0, 91.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.2}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 135.0, 103.0, 135.0, 130.0, 106.0, 130.0, 130.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [132.0, 136.0, 134.0, 139.0, 172.0, 176.0, 132.0, 138.0, 137.0, 176.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [62.0, 84.0, 93.0, 85.0, 67.0, 72.0, 89.0, 67.0, 54.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.5}], "name": "kraken", "value": 1538.8}]} 13:31:04 INFO - Return code: 0 13:31:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:31:04 ERROR - # TBPL SUCCESS # 13:31:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:31:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:31:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:31:04 INFO - 2016-05-05 13:31:04.722 screenresolution[1682:10431] starting screenresolution argv=screenresolution get 13:31:04 INFO - 2016-05-05 13:31:04.725 screenresolution[1682:10431] Display 0: 1600x1200x32@60 13:31:04 INFO - 2016-05-05 13:31:04.731 screenresolution[1683:10434] starting screenresolution argv=screenresolution list 13:31:04 INFO - Available Modes on Display 0 13:31:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:31:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:31:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:31:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:31:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:31:04 INFO - Intel Iris: 13:31:04 INFO - Chipset Model: Intel Iris 13:31:04 INFO - Type: GPU 13:31:04 INFO - Bus: Built-In 13:31:04 INFO - VRAM (Dynamic, Max): 1536 MB 13:31:04 INFO - Vendor: Intel (0x8086) 13:31:04 INFO - Device ID: 0x0a2e 13:31:04 INFO - Revision ID: 0x0009 13:31:04 INFO - Displays: 13:31:04 INFO - Display: 13:31:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:31:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:31:04 INFO - Display Serial Number: 1600x1200 60 13:31:04 INFO - Main Display: Yes 13:31:04 INFO - Mirror: Off 13:31:04 INFO - Online: Yes 13:31:04 INFO - Rotation: Supported 13:31:04 INFO - Return code: 0 13:31:04 INFO - Running post-action listener: _resource_record_post_action 13:31:04 INFO - Running post-run listener: _resource_record_post_run 13:31:06 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 38061568; Write bytes: 511814144; Read time: 397; Write time: 1887 13:31:06 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 206111232; Write bytes: 202135040; Read time: 19117; Write time: 409 13:31:06 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 36247040; Write bytes: 303080448; Read time: 374; Write time: 1450 13:31:06 INFO - Running post-run listener: _upload_blobber_files 13:31:06 INFO - Blob upload gear active. 13:31:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:31:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:31:06 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'] 13:31:06 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 13:31:06 INFO - (blobuploader) - INFO - Open directory for files ... 13:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:07 INFO - (blobuploader) - INFO - Done attempting. 13:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:08 INFO - (blobuploader) - INFO - Done attempting. 13:31:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:31:08 INFO - Return code: 0 13:31:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:31:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:31:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/028616ea46861c459b8ff18c9f3c012a39bf4307bae59f360dbf59ac46a76cf2f41f24cc1baee1eafb4537f4c0f524f58d0ae41847f9f695a2c3357752d5b6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0af2cfd4328561cf027a3fd2921843fc3b17291f3d0c8529d087e28f16cd4ec56e63f5808c705b62e0af4cf97859c83fb76a4bc536476cea41e3fcd774aa6d5c"} 13:31:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:31:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:31:08 INFO - Contents: 13:31:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/028616ea46861c459b8ff18c9f3c012a39bf4307bae59f360dbf59ac46a76cf2f41f24cc1baee1eafb4537f4c0f524f58d0ae41847f9f695a2c3357752d5b6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0af2cfd4328561cf027a3fd2921843fc3b17291f3d0c8529d087e28f16cd4ec56e63f5808c705b62e0af4cf97859c83fb76a4bc536476cea41e3fcd774aa6d5c"} 13:31:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:31:08 INFO - Copying logs to upload dir... 13:31:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:31:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.017021 ========= master_lag: 0.91 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-05 13:31:09.425000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:31:09.432956) ========= 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.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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/028616ea46861c459b8ff18c9f3c012a39bf4307bae59f360dbf59ac46a76cf2f41f24cc1baee1eafb4537f4c0f524f58d0ae41847f9f695a2c3357752d5b6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0af2cfd4328561cf027a3fd2921843fc3b17291f3d0c8529d087e28f16cd4ec56e63f5808c705b62e0af4cf97859c83fb76a4bc536476cea41e3fcd774aa6d5c"} build_url:https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010749 build_url: 'https://queue.taskcluster.net/v1/task/BpIh0NbzSJyS-cMCfRqQEA/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/028616ea46861c459b8ff18c9f3c012a39bf4307bae59f360dbf59ac46a76cf2f41f24cc1baee1eafb4537f4c0f524f58d0ae41847f9f695a2c3357752d5b6e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0af2cfd4328561cf027a3fd2921843fc3b17291f3d0c8529d087e28f16cd4ec56e63f5808c705b62e0af4cf97859c83fb76a4bc536476cea41e3fcd774aa6d5c"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:31:09.585963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:31:09.586280) ========= 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.dPiAB2d4aq/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.YSnkDHK03B/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.004980 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:31:09.606194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:31:09.606459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:31:09.606756) ========= ========= Total master_lag: 1.23 =========