builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1462404679.13 results: success (0) buildid: 20160504140135 builduid: 4fc3223fd45a436997c63bff6750a5f7 revision: 02a85cdafe4c0b956124e6f122e37e272b3c5055 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:19.129174) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:19.129572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:19.129852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:19.166428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-04 16:31:19.166752) ========= 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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-04 16:31:19-- 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% 145M=0s 2016-05-04 16:31:19 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152782 ========= master_lag: 3.73 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-04 16:31:23.049418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:23.049749) ========= 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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.027528 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:23.227506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 16:31:23.227836) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02a85cdafe4c0b956124e6f122e37e272b3c5055 --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 02a85cdafe4c0b956124e6f122e37e272b3c5055 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-04 16:31:23,315 truncating revision to first 12 chars 2016-05-04 16:31:23,315 Setting DEBUG logging. 2016-05-04 16:31:23,315 attempt 1/10 2016-05-04 16:31:23,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/02a85cdafe4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 16:31:24,766 unpacking tar archive at: mozilla-beta-02a85cdafe4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.706373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 16:31:24.952228) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:24.952562) ========= script_repo_revision: 02a85cdafe4c0b956124e6f122e37e272b3c5055 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:24.952953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:24.953230) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 16:31:24.967067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-04 16:31:24.967479) ========= /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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:31:25 INFO - MultiFileLogger online at 20160504 16:31:25 in /builds/slave/test 16:31:25 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 16:31:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:25 INFO - {'append_to_log': False, 16:31:25 INFO - 'base_work_dir': '/builds/slave/test', 16:31:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:31:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:25 INFO - 'branch': 'Mozilla-Beta', 16:31:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:25 INFO - 'config_files': ('talos/mac_config.py',), 16:31:25 INFO - 'default_actions': ('clobber', 16:31:25 INFO - 'read-buildbot-config', 16:31:25 INFO - 'download-and-extract', 16:31:25 INFO - 'populate-webroot', 16:31:25 INFO - 'create-virtualenv', 16:31:25 INFO - 'install', 16:31:25 INFO - 'run-tests'), 16:31:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:25 INFO - 'download_minidump_stackwalk': True, 16:31:25 INFO - 'download_symbols': 'ondemand', 16:31:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:25 INFO - 'installer_path': 'installer.exe', 16:31:25 INFO - 'log_level': 'info', 16:31:25 INFO - 'log_name': 'talos', 16:31:25 INFO - 'log_to_console': True, 16:31:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:31:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:31:25 INFO - 'opt_config_files': (), 16:31:25 INFO - 'pip_index': False, 16:31:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:25 INFO - 'cmd': ('bash', 16:31:25 INFO - '-c', 16:31:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:25 INFO - 'enabled': True, 16:31:25 INFO - 'halt_on_failure': False, 16:31:25 INFO - 'name': 'check_screen_resolution'},), 16:31:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:25 INFO - 'cmd': ('bash', 16:31:25 INFO - '-c', 16:31:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:25 INFO - 'enabled': True, 16:31:25 INFO - 'halt_on_failure': False, 16:31:25 INFO - 'name': 'check_screen_resolution'},), 16:31:25 INFO - 'run_cmd_checks_enabled': True, 16:31:25 INFO - 'sps_profile': False, 16:31:25 INFO - 'sps_profile_interval': 0, 16:31:25 INFO - 'suite': 'dromaeojs-e10s', 16:31:25 INFO - 'system_bits': '32', 16:31:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:25 INFO - 'title': 't-yosemite-r7-0061', 16:31:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:25 INFO - 'use_talos_json': True, 16:31:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:25 INFO - 'work_dir': 'build'} 16:31:25 INFO - ##### 16:31:25 INFO - ##### Running clobber step. 16:31:25 INFO - ##### 16:31:25 INFO - Running pre-action listener: _resource_record_pre_action 16:31:25 INFO - Running main action method: clobber 16:31:25 INFO - rmtree: /builds/slave/test/build 16:31:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:26 INFO - Running post-action listener: _resource_record_post_action 16:31:26 INFO - ##### 16:31:26 INFO - ##### Running read-buildbot-config step. 16:31:26 INFO - ##### 16:31:26 INFO - Running pre-action listener: _resource_record_pre_action 16:31:26 INFO - Running main action method: read_buildbot_config 16:31:26 INFO - Using buildbot properties: 16:31:26 INFO - { 16:31:26 INFO - "project": "", 16:31:26 INFO - "product": "firefox", 16:31:26 INFO - "script_repo_revision": "production", 16:31:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:31:26 INFO - "repository": "", 16:31:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:31:26 INFO - "buildid": "20160504140135", 16:31:26 INFO - "pgo_build": "False", 16:31:26 INFO - "basedir": "/builds/slave/test", 16:31:26 INFO - "buildnumber": 13, 16:31:26 INFO - "slavename": "t-yosemite-r7-0061", 16:31:26 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:31:26 INFO - "platform": "yosemite_r7", 16:31:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:31:26 INFO - "branch": "mozilla-beta", 16:31:26 INFO - "repo_path": "releases/mozilla-beta", 16:31:26 INFO - "revision": "02a85cdafe4c0b956124e6f122e37e272b3c5055", 16:31:26 INFO - "stage_platform": "macosx64", 16:31:26 INFO - "builduid": "4fc3223fd45a436997c63bff6750a5f7", 16:31:26 INFO - "slavebuilddir": "test" 16:31:26 INFO - } 16:31:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 16:31:26 INFO - Running post-action listener: _resource_record_post_action 16:31:26 INFO - ##### 16:31:26 INFO - ##### Running download-and-extract step. 16:31:26 INFO - ##### 16:31:26 INFO - Running pre-action listener: _resource_record_pre_action 16:31:26 INFO - Running main action method: download_and_extract 16:31:26 INFO - mkdir: /builds/slave/test/build/tests 16:31: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')]} 16:31:26 INFO - https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:32 INFO - Downloaded 1241 bytes. 16:31:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 16:31:32 INFO - Using the following test package requirements: 16:31:32 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:31:32 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 16:31:32 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 16:31:32 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:31:32 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 16:31:32 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:31:32 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 16:31:32 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 16:31:32 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 16:31:32 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:31:32 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:31:32 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 16:31:32 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 16:31: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')]} 16:31:32 INFO - https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:34 INFO - Downloaded 17747493 bytes. 16:31:34 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'] 16:31:34 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 16:31:37 INFO - Return code: 0 16:31:37 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 16:31:37 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')]} 16:31:37 INFO - https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:40 INFO - Downloaded 17747493 bytes. 16:31:40 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'] 16:31:40 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 16:31:44 INFO - Return code: 0 16:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:44 INFO - https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:45 INFO - Downloaded 10845194 bytes. 16:31:45 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'] 16:31:45 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 16:31:45 INFO - Return code: 0 16:31: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')]} 16:31:45 INFO - https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 16:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6q98FBsSoStHpFG4C__cQ/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 16:31:48 INFO - Downloaded 88346977 bytes. 16:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:31:48 INFO - mkdir: /builds/slave/test/properties 16:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:48 INFO - Contents: 16:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:31:49 INFO - Running post-action listener: _resource_record_post_action 16:31:49 INFO - Running post-action listener: set_extra_try_arguments 16:31:49 INFO - ##### 16:31:49 INFO - ##### Running populate-webroot step. 16:31:49 INFO - ##### 16:31:49 INFO - Running pre-action listener: _resource_record_pre_action 16:31:49 INFO - Running main action method: populate_webroot 16:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:49 INFO - '--tppagecycles', 16:31:49 INFO - '7'], 16:31:49 INFO - 'tests': ['tsvgm']}}, 16:31:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:31:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:31:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['damp', 'tps']}, 16:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['damp', 'tps']}, 16:31:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:49 INFO - 'other': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other_l64': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other_nol64': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'svgr': {'tests': ['tsvgx', 16:31:49 INFO - 'tsvgr_opacity', 16:31:49 INFO - 'tart', 16:31:49 INFO - 'tscrollx', 16:31:49 INFO - 'cart']}, 16:31:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['tsvgx', 16:31:49 INFO - 'tsvgr_opacity', 16:31:49 INFO - 'tart', 16:31:49 INFO - 'tscrollx', 16:31:49 INFO - 'cart']}, 16:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['tp5o']}, 16:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--e10s'], 16:31:49 INFO - 'tests': ['tp5o']}, 16:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--xperf_path', 16:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:49 INFO - 'tests': ['tp5n']}, 16:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--e10s', 16:31:49 INFO - '--xperf_path', 16:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:49 INFO - 'tests': ['tp5n']}}, 16:31:49 INFO - 'talos.zip': {'path': '', 16:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:49 INFO - Running post-action listener: _resource_record_post_action 16:31:49 INFO - ##### 16:31:49 INFO - ##### Running create-virtualenv step. 16:31:49 INFO - ##### 16:31:49 INFO - Running pre-action listener: _resource_record_pre_action 16:31:49 INFO - Running main action method: create_virtualenv 16:31:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:49 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 16:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:49 INFO - Using real prefix '/tools/python27' 16:31:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:53 INFO - Installing pip.................done. 16:31:53 INFO - Return code: 0 16:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:53 INFO - 'HOME': '/Users/cltbld', 16:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:53 INFO - 'LOGNAME': 'cltbld', 16:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:53 INFO - 'MOZ_NO_REMOTE': '1', 16:31:53 INFO - 'NO_EM_RESTART': '1', 16:31:53 INFO - 'PAGER': '/bin/cat', 16:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:53 INFO - 'PWD': '/builds/slave/test', 16:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:53 INFO - 'SHELL': '/bin/bash', 16:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:31:53 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:53 INFO - 'USER': 'cltbld', 16:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:53 INFO - 'XPC_FLAGS': '0x0', 16:31:53 INFO - 'XPC_SERVICE_NAME': '0', 16:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:53 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 16:31:53 INFO - Cleaning up... 16:31:53 INFO - Return code: 0 16:31:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:53 INFO - 'HOME': '/Users/cltbld', 16:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:53 INFO - 'LOGNAME': 'cltbld', 16:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:53 INFO - 'MOZ_NO_REMOTE': '1', 16:31:53 INFO - 'NO_EM_RESTART': '1', 16:31:53 INFO - 'PAGER': '/bin/cat', 16:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:53 INFO - 'PWD': '/builds/slave/test', 16:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:53 INFO - 'SHELL': '/bin/bash', 16:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:31:53 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:53 INFO - 'USER': 'cltbld', 16:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:53 INFO - 'XPC_FLAGS': '0x0', 16:31:53 INFO - 'XPC_SERVICE_NAME': '0', 16:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:53 INFO - Downloading/unpacking psutil>=0.7.1 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:57 INFO - Installing collected packages: psutil 16:31:57 INFO - Running setup.py install for psutil 16:31:57 INFO - building 'psutil._psutil_osx' extension 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:58 INFO - building 'psutil._psutil_posix' extension 16:31:58 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 16:31:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:58 INFO - ^ 16:31:58 INFO - 1 warning generated. 16:31:58 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 16:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:58 INFO - Successfully installed psutil 16:31:58 INFO - Cleaning up... 16:31:58 INFO - Return code: 0 16:31:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:31:58 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 16:31:58 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 16:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:58 INFO - 'HOME': '/Users/cltbld', 16:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:58 INFO - 'LOGNAME': 'cltbld', 16:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:58 INFO - 'MOZ_NO_REMOTE': '1', 16:31:58 INFO - 'NO_EM_RESTART': '1', 16:31:58 INFO - 'PAGER': '/bin/cat', 16:31:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:58 INFO - 'PWD': '/builds/slave/test', 16:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:58 INFO - 'SHELL': '/bin/bash', 16:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:31:58 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:58 INFO - 'USER': 'cltbld', 16:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:58 INFO - 'XPC_FLAGS': '0x0', 16:31:58 INFO - 'XPC_SERVICE_NAME': '0', 16:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:32:00 INFO - Installing collected packages: mozsystemmonitor 16:32:00 INFO - Running setup.py install for mozsystemmonitor 16:32:01 INFO - Successfully installed mozsystemmonitor 16:32:01 INFO - Cleaning up... 16:32:01 INFO - Return code: 0 16:32:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:01 INFO - 'HOME': '/Users/cltbld', 16:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:01 INFO - 'LOGNAME': 'cltbld', 16:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:01 INFO - 'MOZ_NO_REMOTE': '1', 16:32:01 INFO - 'NO_EM_RESTART': '1', 16:32:01 INFO - 'PAGER': '/bin/cat', 16:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:01 INFO - 'PWD': '/builds/slave/test', 16:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:01 INFO - 'SHELL': '/bin/bash', 16:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:01 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:01 INFO - 'USER': 'cltbld', 16:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:01 INFO - 'XPC_FLAGS': '0x0', 16:32:01 INFO - 'XPC_SERVICE_NAME': '0', 16:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:01 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 16:32:01 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 16:32:01 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 16:32:01 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 16:32:01 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 16:32:01 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 16:32:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:05 INFO - Downloading docopt-0.6.1.tar.gz 16:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:05 INFO - Running setup.py install for blobuploader 16:32:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:05 INFO - Running setup.py install for requests 16:32:05 INFO - Running setup.py install for docopt 16:32:06 INFO - Successfully installed blobuploader requests docopt 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:06 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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:06 INFO - 'HOME': '/Users/cltbld', 16:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PAGER': '/bin/cat', 16:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:06 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - 'XPC_FLAGS': '0x0', 16:32:06 INFO - 'XPC_SERVICE_NAME': '0', 16:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lXG5VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-FMBUJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DO5vQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-1k0XMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-y7iHJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-FElhlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-FnAJ39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0LVq6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ItsftU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-AnA1X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-AijUgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9KWJ44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ZaU7To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lUZWqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-enwKlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:08 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-bWjFmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:08 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-460qe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:08 INFO - Running setup.py install for manifestparser 16:32:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:08 INFO - Running setup.py install for mozcrash 16:32:08 INFO - Running setup.py install for mozdebug 16:32:08 INFO - Running setup.py install for mozdevice 16:32:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:08 INFO - Running setup.py install for mozfile 16:32:08 INFO - Running setup.py install for mozhttpd 16:32:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Running setup.py install for mozinfo 16:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Running setup.py install for mozInstall 16:32:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Running setup.py install for mozleak 16:32:09 INFO - Running setup.py install for mozlog 16:32:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Running setup.py install for moznetwork 16:32:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Running setup.py install for mozprocess 16:32:09 INFO - Running setup.py install for mozprofile 16:32:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Running setup.py install for mozrunner 16:32:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Running setup.py install for mozscreenshot 16:32:10 INFO - Running setup.py install for moztest 16:32:10 INFO - Running setup.py install for mozversion 16:32:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:10 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:10 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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:10 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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:10 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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:10 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 16:32:10 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 16:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:10 INFO - 'HOME': '/Users/cltbld', 16:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PAGER': '/bin/cat', 16:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:10 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - 'XPC_FLAGS': '0x0', 16:32:10 INFO - 'XPC_SERVICE_NAME': '0', 16:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-m2zvJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-bcZNIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-PGm87y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wLxz7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-sO6GNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-IQ4Blm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-I01rk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-CqiRwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-qE8GHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:11 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)) 16:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-b3XB1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7AIsLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Zyfekc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kYDF6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zOgDZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-_cpFdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5A1odP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:12 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)) 16:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-19AArD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:12 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)) 16:32:12 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)) 16:32:12 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)) 16:32:12 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)) 16:32:12 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)) 16:32:12 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)) 16:32:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:15 INFO - Downloading blessings-1.6.tar.gz 16:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:15 INFO - Installing collected packages: blessings 16:32:15 INFO - Running setup.py install for blessings 16:32:15 INFO - Successfully installed blessings 16:32:15 INFO - Cleaning up... 16:32:15 INFO - Return code: 0 16:32:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:15 INFO - Reading from file tmpfile_stdout 16:32:15 INFO - Current package versions: 16:32:15 INFO - blessings == 1.6 16:32:15 INFO - blobuploader == 1.2.4 16:32:15 INFO - docopt == 0.6.1 16:32:15 INFO - manifestparser == 1.1 16:32:15 INFO - mozInstall == 1.12 16:32:15 INFO - mozcrash == 0.17 16:32:15 INFO - mozdebug == 0.1 16:32:15 INFO - mozdevice == 0.48 16:32:15 INFO - mozfile == 1.2 16:32:15 INFO - mozhttpd == 0.7 16:32:15 INFO - mozinfo == 0.9 16:32:15 INFO - mozleak == 0.1 16:32:15 INFO - mozlog == 3.1 16:32:15 INFO - moznetwork == 0.27 16:32:15 INFO - mozprocess == 0.22 16:32:15 INFO - mozprofile == 0.28 16:32:15 INFO - mozrunner == 6.11 16:32:15 INFO - mozscreenshot == 0.1 16:32:15 INFO - mozsystemmonitor == 0.0 16:32:15 INFO - moztest == 0.7 16:32:15 INFO - mozversion == 1.4 16:32:15 INFO - psutil == 3.1.1 16:32:15 INFO - requests == 1.2.3 16:32:15 INFO - wsgiref == 0.1.2 16:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:15 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')]} 16:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:15 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')]} 16:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:15 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 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:15 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 16:32:15 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 16:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:15 INFO - 'HOME': '/Users/cltbld', 16:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:15 INFO - 'LOGNAME': 'cltbld', 16:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:15 INFO - 'MOZ_NO_REMOTE': '1', 16:32:15 INFO - 'NO_EM_RESTART': '1', 16:32:15 INFO - 'PAGER': '/bin/cat', 16:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:15 INFO - 'PWD': '/builds/slave/test', 16:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:15 INFO - 'SHELL': '/bin/bash', 16:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:15 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:15 INFO - 'USER': 'cltbld', 16:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:15 INFO - 'XPC_FLAGS': '0x0', 16:32:15 INFO - 'XPC_SERVICE_NAME': '0', 16:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 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)) 16:32:16 INFO - Cleaning up... 16:32:16 INFO - Return code: 0 16:32:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:16 INFO - 'HOME': '/Users/cltbld', 16:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:16 INFO - 'LOGNAME': 'cltbld', 16:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:16 INFO - 'MOZ_NO_REMOTE': '1', 16:32:16 INFO - 'NO_EM_RESTART': '1', 16:32:16 INFO - 'PAGER': '/bin/cat', 16:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:16 INFO - 'PWD': '/builds/slave/test', 16:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:16 INFO - 'SHELL': '/bin/bash', 16:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:16 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:16 INFO - 'USER': 'cltbld', 16:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:16 INFO - 'XPC_FLAGS': '0x0', 16:32:16 INFO - 'XPC_SERVICE_NAME': '0', 16:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:16 INFO - Downloading/unpacking jsonschema 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:18 INFO - Downloading/unpacking functools32 (from jsonschema) 16:32:18 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 16:32:18 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 16:32:18 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 16:32:18 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 16:32:18 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 16:32:18 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 16:32:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:19 INFO - warning: no files found matching '*.txt' 16:32:19 INFO - no previously-included directories found matching 'build' 16:32:19 INFO - no previously-included directories found matching 'dist' 16:32:19 INFO - no previously-included directories found matching '.git*' 16:32:19 INFO - Installing collected packages: jsonschema, functools32 16:32:19 INFO - Running setup.py install for functools32 16:32:19 INFO - warning: no files found matching '*.txt' 16:32:19 INFO - no previously-included directories found matching 'build' 16:32:19 INFO - no previously-included directories found matching 'dist' 16:32:19 INFO - no previously-included directories found matching '.git*' 16:32:19 INFO - Successfully installed jsonschema functools32 16:32:19 INFO - Cleaning up... 16:32:19 INFO - Return code: 0 16:32:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c94ba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, '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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:19 INFO - 'HOME': '/Users/cltbld', 16:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:19 INFO - 'LOGNAME': 'cltbld', 16:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:19 INFO - 'MOZ_NO_REMOTE': '1', 16:32:19 INFO - 'NO_EM_RESTART': '1', 16:32:19 INFO - 'PAGER': '/bin/cat', 16:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:19 INFO - 'PWD': '/builds/slave/test', 16:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:19 INFO - 'SHELL': '/bin/bash', 16:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:19 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:19 INFO - 'USER': 'cltbld', 16:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:19 INFO - 'XPC_FLAGS': '0x0', 16:32:19 INFO - 'XPC_SERVICE_NAME': '0', 16:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:19 INFO - Downloading/unpacking flake8 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:32:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:32:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:23 INFO - no previously-included directories found matching 'docs/_build' 16:32:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:32:23 INFO - Running setup.py install for pep8 16:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:23 INFO - no previously-included directories found matching 'docs/_build' 16:32:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:32:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:32:23 INFO - Cleaning up... 16:32:23 INFO - Return code: 0 16:32:23 INFO - Running post-action listener: _resource_record_post_action 16:32:23 INFO - Running post-action listener: _start_resource_monitoring 16:32:23 INFO - Starting resource monitoring. 16:32:23 INFO - ##### 16:32:23 INFO - ##### Running install step. 16:32:23 INFO - ##### 16:32:23 INFO - Running pre-action listener: _resource_record_pre_action 16:32:23 INFO - Running main action method: install 16:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:24 INFO - Reading from file tmpfile_stdout 16:32:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:24 INFO - Reading from file tmpfile_stdout 16:32:24 INFO - Output received: 16:32:24 INFO - Usage: mozinstall [options] installer 16:32:24 INFO - Options: 16:32:24 INFO - -h, --help show this help message and exit 16:32:24 INFO - -d DEST, --destination=DEST 16:32:24 INFO - Directory to install application into. [default: 16:32:24 INFO - "/builds/slave/test"] 16:32:24 INFO - --app=APP Application being installed. [default: firefox] 16:32:24 INFO - mkdir: /builds/slave/test/build/application 16:32:24 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'] 16:32:24 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 16:32:46 INFO - Reading from file tmpfile_stdout 16:32:46 INFO - Output received: 16:32:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:32:46 INFO - Running post-action listener: _resource_record_post_action 16:32:46 INFO - ##### 16:32:46 INFO - ##### Running run-tests step. 16:32:46 INFO - ##### 16:32:46 INFO - Running pre-action listener: _resource_record_pre_action 16:32:46 INFO - Running main action method: run_tests 16:32:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:46 INFO - 2016-05-04 16:32:46.527 screenresolution[1649:7755] starting screenresolution argv=screenresolution get 16:32:46 INFO - 2016-05-04 16:32:46.529 screenresolution[1649:7755] Display 0: 1600x1200x32@60 16:32:46 INFO - 2016-05-04 16:32:46.535 screenresolution[1650:7757] starting screenresolution argv=screenresolution list 16:32:46 INFO - Available Modes on Display 0 16:32:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:46 INFO - Intel Iris: 16:32:46 INFO - Chipset Model: Intel Iris 16:32:46 INFO - Type: GPU 16:32:46 INFO - Bus: Built-In 16:32:46 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:46 INFO - Vendor: Intel (0x8086) 16:32:46 INFO - Device ID: 0x0a2e 16:32:46 INFO - Revision ID: 0x0009 16:32:46 INFO - Displays: 16:32:46 INFO - Display: 16:32:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:46 INFO - Display Serial Number: 1600x1200 60 16:32:46 INFO - Main Display: Yes 16:32:46 INFO - Mirror: Off 16:32:46 INFO - Online: Yes 16:32:46 INFO - Rotation: Supported 16:32:46 INFO - Return code: 0 16:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:46 INFO - Python 2.7.3 16:32:46 INFO - Return code: 0 16:32:46 INFO - grabbing minidump binary from tooltool 16:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:46 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 0x101b51d30>, '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 0x1019b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b48b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:46 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 16:32:46 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 16:32:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:46 INFO - Return code: 0 16:32:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:32:48 INFO - Return code: 0 16:32:48 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/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 16:32:48 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/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 16:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GfDpdbIPoK/Render', 16:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:48 INFO - 'HOME': '/Users/cltbld', 16:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:48 INFO - 'LOGNAME': 'cltbld', 16:32:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:48 INFO - 'MOZ_NO_REMOTE': '1', 16:32:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:48 INFO - 'NO_EM_RESTART': '1', 16:32:48 INFO - 'PAGER': '/bin/cat', 16:32:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:48 INFO - 'PWD': '/builds/slave/test', 16:32:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:48 INFO - 'SHELL': '/bin/bash', 16:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X4nRq6pkbM/Listeners', 16:32:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:48 INFO - 'USER': 'cltbld', 16:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:48 INFO - 'XPC_FLAGS': '0x0', 16:32:48 INFO - 'XPC_SERVICE_NAME': '0', 16:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:48 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/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 16:32:48 INFO - mozversion application_buildid: 20160504140135 16:32:48 INFO - mozversion application_changeset: 02a85cdafe4c0b956124e6f122e37e272b3c5055 16:32:48 INFO - mozversion application_display_name: Firefox 16:32:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:48 INFO - mozversion application_name: Firefox 16:32:48 INFO - mozversion application_remotingname: firefox 16:32:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:48 INFO - mozversion application_vendor: Mozilla 16:32:48 INFO - mozversion application_version: 47.0 16:32:48 INFO - mozversion platform_buildid: 20160504140135 16:32:48 INFO - mozversion platform_changeset: 02a85cdafe4c0b956124e6f122e37e272b3c5055 16:32:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:48 INFO - mozversion platform_version: 47.0 16:32:48 INFO - using testdate: 1462404768 16:32:48 INFO - actual date: 1462404768 16:32:48 INFO - starting webserver on 'localhost:49270' 16:32:48 INFO - SUITE-START | Running 2 tests 16:32:48 INFO - TEST-START | dromaeo_css 16:32:48 INFO - operating with platform_type : mac_ 16:32:48 INFO - Initialising browser for dromaeo_css test... 16:32:48 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpsE1t_p/profile http://localhost:49270/getInfo.html) 16:32:51 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 16:32:51 INFO - PROCESS | 1668 | colorDepth:24 16:32:51 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 16:32:51 INFO - PROCESS | 1668 | __metrics 16:32:51 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:32:51 INFO - TEST-INFO | 1668: exit 0 16:32:51 INFO - Browser initialized. 16:32:51 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:51 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpsE1t_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:03 INFO - PROCESS | 1672 | RSS: Main: 167624704 16:33:03 INFO - PROCESS | 1672 | 16:33:53 INFO - PROCESS | 1672 | 1462404833136 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] 16:36:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:36:05 INFO - PROCESS | 1672 | RSS: Main: 178761728 16:36:05 INFO - PROCESS | 1672 | 16:39:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:39:07 INFO - PROCESS | 1672 | RSS: Main: 190021632 16:39:07 INFO - PROCESS | 1672 | 16:42:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:42:09 INFO - PROCESS | 1672 | RSS: Main: 192057344 16:42:09 INFO - PROCESS | 1672 | 16:45:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:45:12 INFO - PROCESS | 1672 | RSS: Main: 195379200 16:45:12 INFO - PROCESS | 1672 | 16:48:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:48:15 INFO - PROCESS | 1672 | RSS: Main: 194510848 16:48:15 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:51:17 INFO - PROCESS | 1672 | RSS: Main: 200204288 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | __start_tp_report 16:51:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 16:51:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 16:51:17 INFO - PROCESS | 1672 | |i|pagename|runs| 16:51:17 INFO - PROCESS | 1672 | |0;dojo.html;3613.8012409317485;3661.6704496595307;3685.8525658973645;3704.4813726078355;3722.9255414891704;5962.195103661004;5991.670458124801;5995.850103747398;5997.550183736221;6008.429199226072;5949.821505354836;5968.79109231177;5984.341722410542;5995.370486098962;6016.488598469125;5321.866953326169;5329.653572517774;5362.195670649414;5373.6775793452325;5469.261649677283;5219.42586315505;5344.518993290603;5344.652597581165;5359.330083739533;5372.677639341632;5350.973245133769;5359.035373632744;5376.247325374451;5379.838604841861;5417.7291135443265;4477.306017567283;5346.117890548055;5379.731013449351;5433.945660543423;5465.59008074394;5301.310829592167;5355.866103347408;5387.81142660005;5397.001554712351;5404.270423492857;5714.457126572969;5932.902413053599;5964.224650795412;5989.191459153002;6068.211132552784;5777.508911742507;5880.97059514704;6159.568830181889;6229.0967809667345;6261.311255761862;5420.7018613976215;5601.327840659147;6062.120992456069;6327.3988971047675;6391.296957334689;4920.5571498565305;5900.291964964146;5918.585699001072;6058.545609079292;6062.211912451397;5595.804146854841;6415.839604009937;6425.903611445832;6434.388733070351;6454.6449945252525;6309.337519560472;6313.684315784192;6332.68336583169;6340.080688300263;6347.270063942613;6218.098375735493;6254.030625253093;6300.897342964963;6312;6354.110424540568;5847.9415205848245;6285.308616052231;6301.653409062454;6302.590331628521;6317.4946004319545;5921.61509501881;6212.9378706213265;6270.811875643738;6284.622922624566;6311.431971122621;4062.898427539276;4237.385579091077;5001.674891132065;5050.393952725696;5099.031184075014;4515.9548404515535;4527.981204229022;4531.456225252925;4584.472785629695;4590.380298659638;5929.822105336761;6041.577089603686;6095.085737139465;6101.389861013952;6125.356837532084;6115.027386288435;6172.259328880563;6262.2172228471445;6315.305316415191;6338.30278669346;6107.725152368154;6120.326764055951;6125.295591007091;6127.509799216141;6160.661163636043;5618.438156184349;5623.381428042912;5630.042892708249;5651.886962260814;5663.490285874291;6324.430801227912;6448.516361272923;6501.0898474213645;6545.574537655038;6569.770058048041;6291.465225455888;6312.179416675803;6334.936650633619;6336.20797400325;6339.619622822461;6313.43179113882;6493.772717954849;6560.803175904731;6593.307702691341;6606.306337834458;6205.069239614094;6237.313895471404;6278.497720182283;6280.466160376419;6290.622562646256;6299.338569450142;6317.526185536011;6323.905141422974;6340.795248902694;6348.301686814539;6143.665407145256;6177.227846519185;6256.812295631138;6279.748810047547;6312.084747711648;5730.971345143247;6238.875222495615;6250.9062364065485;6255.687215639291;6280.120783090462;6027.186329845415;6141;6178.969105154445;6194.287656919331;6196.690165491617;6131.601445906002;6143.96928015357;6148.815535533941;6196.721147548461;6252.558227759743;6197.380261973947;6213.782517612042;6214.658193799384;6234.220722409699;6266.624002559861 16:51:17 INFO - PROCESS | 1672 | |1;ext.html;574.3194314737037;598.8322770597333;620.0791824141153;677.7664650336387;681.1757773094555;39044;39709.205815883666;39799.00502487432;39832.80501584953;39836.60163398365;43383;43500.78249608755;44200.55799442004;44231.77884110583;44322.778386108104;9878.999999999982;9986.600535978589;10010.949945250264;10116.14012808912;10132;9844.803103937953;9918.851217231748;9963.551640176209;9998.950005249964;10000.2499812514;9919;9920.057594528509;9920.40477571348;9952.651657192;10024.398536087821;9880.160186384166;9951.95504472031;9961.40231586107;9966;9989.400635961865;9819.607215711363;9949.403035817873;9962.601495940155;9977.052180042885;9982.90017099827;34415.82792086023;40588.98527536835;40800.387994179815;40904.79547602273;40998.79500602508;3210.2455922858107;3383.7293016558615;3389.8983030509125;3404.0468668772783;3536.876209332687;27544;27946.161615151577;28675.42649147026;28885;29337.853310733524;2765.958510622342;2768.764655004327;2795.55271156616;2863.155369166101;2959.0235222376564;345618;347731;349297.25351373333;349760;349767.502324976;48748.5125148751;49021.01957960821;49269.75365123151;68222;69754.65122674355;47493.05013899702;47764;47796.522034779206;47820.760896195294;47879.76060119677;17250.482485525456;17251.82748172527;17280.481585552454;17364.739528907077;17377.56556086083;13383.19700817954;13439.059265851492;13577.59267221985;13694.109882857583;13791.034627575973;15463.304151313218;15523.223838808015;15577.922110389602;15631.76552351693;15879.28543215558;5537.861553461195;5549.944500555023;6518.294907613382;6599.901001484982;6653.933460665428;982.1651596143221;1018.1396719771781;1087.396494945297;1145.7135716070982;1251.1929805275547;31254.53118203229;31482.685173148435;31836.204094897814;31978.520322195185;32065;1100.4772732951783;1117.273772048159;1117.3016864459712;1239.7086684629105;1263.9304838233986;13851.445942162401;16078.276477558538;16177.867549271674;16185.6084876843;16379.754303685455;552788;554839.2258038765;558933;561776;565349.1732541394;64637.03044454337;65051.34948650453;65215;65246.67376663086;65383.692326153214;1533.8159420869345;1540.0374765771394;1554.494789193494;1571.395012920034;1572.5046610317713;28756.281092972844;29566.260843479085;30971.69028309688;31511.684883151793;32053;55997;56018.43981560132;56116.5970850732;56258.71870640621;56369;514049;514091;515511;516611;516991;35381.93854184379;35406.82296588604;47981.28028079651;48842.75578622084;49915;46038;46052.7697361511;46171.30743038924;46903.82740431517;46997;40243.798781005906;40302.39546406748;40522.59477405188;41936.1612767749;42740.78629606832;37443.43834842425;38435;38453.4231986526;38637.420438694004;39006.41490377703;38695.6130438692;40803.59196408117;41601.37597936094;41813.58186418218;42713.78643106889;32711.67288327086;34293;35160.82419587886;35206.823965881034;35828.64171358253;26339.604905926808;26544.8672756635;26570;26750.197494075208;26860.59709104404 16:51:17 INFO - PROCESS | 1672 | |2;jquery.html;366.67549218941235;374.8912815283568;385.6856661820614;386.0406888881131;388.8444622151141;20749.896250518763;21676.783232167672;22164.335069947887;22410.215642452516;22511.437214069636;12907.096503244777;12968.93515532421;20583;22164.335069947887;23133.19033833816;5392.299001129857;5585.3297604287545;5639.210510528529;5644.943550564483;5656.547476201915;4130.607592278729;5964.612300200495;6124.081387791823;6181.690915454209;6225.221847269091;5988.401159883999;6171.228596425447;6195.163652906845;6212.347703491136;6240.282367527724;6061.605995610315;6151.784687535915;6220.066989951543;6222.9688851555675;6224.875502489947;5793.536517078624;5957.6127551709;5968.910466343008;5979.730912108966;6035.577509574332;14633.268336583234;14885.627859303604;20468.283610073726;27164.45671086587;27816.443671126668;1649.6948064608086;1864.3102052240622;2052.72288241087;2162.426956856434;2203.372038968886;8813.559322033872;10132.848007279898;10587.629432969887;10593.523291451904;10637.57449702011;1428.8285405751376;1752.1239380309846;1839.8344149026518;1843.5575461889184;1845.3541260558832;100195.49902250514;102265.95468090597;106191.46904265507;106204;112746.87253127446;11717.824232636518;11745.706357341134;11803.23278986863;11829.822552661717;11846.229995050295;12226.633201003984;14689.92655036718;14698.63253418673;14758.704825903422;14929.328180231916;9030.232430243503;9067.727968160965;9090.772730681785;9183.816323673489;9260.907390926139;9452;9494;9516.90483095174;9570.95214523937;9572.760680982892;4267.679924005712;4613.63090952723;4669.392978912788;4701.811927522929;4721.881952951135;1825.3618269473652;1857.9721304180448;1906.485248982767;1982.553925366781;1983.1571582077559;819.6680344460503;975.5561219645044;988.7528117970508;1008.9545970431349;1076.4025965589017;21520;22053.558928821654;22159.00284487202;22273.22043728494;22344.441388965082;1036.3781730961364;1043.6764602973103;1056.0970370333407;1081.5565618096543;1084.360227465799;11504.712382190512;11884.524619015316;11905.583304584472;11917.880821191851;11998.920097191294;472718;651582;663043;676724;677851;87491;122726;124034;126592;127933.36033319774;1051.5373235776235;1072.710368200597;1080.7190130565953;1082.0802318029612;1082.118073769875;18762.96803675811;19340.516487087934;19420.611587767882;19432.2227110914;19718.014099295266;49196.50803491919;49772.75568110826;51027;51961.7401912988;52513.47486525086;71724.28275717176;73021.26978730144;73553.26446735465;74056.25943740494;75572;7012.649367531705;7405.370543503647;8388.664453421794;8597.441166324168;8742;10087.394756314645;11062.668119956414;13812.723745525234;13853.37659805291;14273.072250303698;9022.548872556215;9402.482863442303;11859;11929.82105268439;11979.880201197877;11296.43517824122;11666.358350290815;11821.704457388634;12078.879211207775;12092.274463532216;11529.538818447503;11814.409279536161;11834.171607987359;11985.580504682293;12102.576409825613;8484.745457636034;8508.106648802035;8586.098459661645;8726.649084409799;8747.956260218658;10335.431551264752;11751.412429378326;11855.466504007512;11881.702957425789;12057.879421206027 16:51:17 INFO - PROCESS | 1672 | |3;mootools.html;1686.6036481426866;1688.7044767165746;2074.5021194913215;2105.8947052647363;2143.992323607904;8339.12439193885;9104.40821346612;9222.492762898039;9386.6245350186;9418.670346537872;9204.447733136016;9241.90758092419;9331.973482916874;9332.766680832983;9360.157585817275;2239.2722365231284;2599.3111825366295;2614.1504011196344;2628.053900595784;2628.47430513897;2569.576019956705;2597.688277406714;2608.334874606973;2631.2369412870244;2631.947361052778;2587.3570282870323;2616.502864455757;2630.0926180467804;2635.2752992927003;2638.498685249806;2192.7149470568884;2518.3955850595908;2595.883185256668;2628.434886499402;2637.512060268856;2603.7526434988645;2603.8437693738247;2629.395239095019;2632.9868350658317;2634.1570697376847;9208.953955230249;9241.214496767716;9486.95256523713;9509.5720692569;9520.095590918922;5684.687342196177;5732.828015159552;5808.912866307009;5887.499562537189;5979.491743201833;3136.623605167372;3697.630236976308;3838.7696738195796;3853.9229215415535;3854.2676891390824;1078.5308390850005;1092.82514797632;1096.8848270931517;1097.6377795327523;1129.350623391545;12672.80990785139;12676.873231267662;12699.428525716365;12818.166819156819;12840.55058072963;5117.513836185556;5134.948650513522;5146.768395422215;5248.2390053442805;5266.078436273637;10733.302335348177;10754.73113172177;10838.241323107306;10920.781584368267;10931.906809319164;5714.314282286152;5729.427057294237;5862.12068189775;5878.2064421302575;5911.7635294587735;4663.836765713184;5196.402413722395;5223.268742376071;5261.447548007404;5297.152455607084;3729.4778730977687;4000.6399424051974;4146.5853414658895;4170.082581831992;4187.958120418818;1373.4231622718482;1390.1728471559406;1391.373881753215;1398.454602704946;1399.139529189541;1350.3045931345364;1390.9652258693613;1412.5621057472217;1420.4105296301918;1433.218895701845;8654.524001179996;8795.47227166372;8815.779605509913;8838.779030524289;8863.689770857989;452.57005844447906;534.0493920820945;535.9142537194031;536.3376230355585;538.9622726409192;6370.681465926685;6397.6801159941815;6453.870922581522;6455.903161452582;6462.838429039311;11196.888031119584;11284.887151128383;11526.077913766878;11530.192886497865;11591.76816463666;10877.83683244752;11281.21031527785;11387.487563059682;11400.372979486043;11444.54221831134;7675.078990521173;8612.837266969005;8905.599248033983;8926.419782714103;8940.105989401009;7286.1985181631035;7782.377409807089;8357.623906924082;8373.748787536384;8509.74470765878;9127.178553930178;9860.802783944138;10111.443870587189;10205.897941020496;10300.536475858455;10190.184785217312;10261.74345641365;10278.434686092038;10345.793084138124;10669.199810014436;7237.601931893796;7751.457397982087;7933.722319718782;7946.404019698662;8058.637361318638;8590.82818343642;8692.130786921258;8797.032326444214;8829.426087304304;8851.734447966572;6020.4280593343565;7671.961640191764;7763.72826951054;7813.531188128731;7911.28798408123;6717.932820671731;7738.729144479917;7769.223077692185;7864.1742617026675;7889.605519724106;8105.351571874118;8200.507969521848;8244.54654993981;8265.628046737791;8269.95865020671;7189.2810718927685;7367.963160184165;7385.150707668687;7414.369778568666;7430.108386993379;6426.678666066771;7512.136104347851;7573.848523029619;7629.046369203849;7655.732049378245 16:51:17 INFO - PROCESS | 1672 | |4;prototype.html;288;320.47122248290316;343.4847728407389;346.80578875829553;348.37814501115497;5632.267805185325;7020.15758109027;7118.786436406916;7124.85750284994;7140.464465165108;6985.301469853012;7061.258567850379;7064.364207221349;7068.363847253746;7070.5050646454765;3945.9210815783667;4976.975115124419;5055.949440505603;5067.49325067494;5206.7917283308625;5022.296878437021;5053.949460505385;5057.59539236862;5061.493850614946;5092.236164575324;4999.900001999958;5005.899882002358;5015.971725796203;5021.271915572258;5023.372078490189;4950.059488697154;5004.274380214867;5010.749462526859;5020.523050310215;5030.144875371196;4372.825086996516;4380.846670366522;4384;4394.516603173648;4402.7798610069685;6472.514561407913;6763.661816909135;6774.220964589086;6778.084958530634;6784.660766961632;5940.227770389865;5944.019236825919;5954.940450595482;5958.076498142795;6014.789482368096;7468.21583733711;7489.2510748925215;7490.812729681747;7498.550086994744;7505.737299194502;4826.734529600871;4827.275908613701;4830.058138662962;4835.6131509479155;4846;7204.783856484366;7884;7955.681772729084;7970;7996.880046799302;4807.687500312469;4843.491433399513;4929.457759646436;4944.505549445027;4953.653244272867;5009.599232061426;5014.899702006012;5020.3724534433195;5023.748812559431;5024;4895.926561101586;6010.699465026732;6011.128386384037;6011.218541589653;6011.879762404815;7535.6985720570565;7565.2812982766545;7566.659500322498;7573.015507984037;7577.16651168382;1474.4691910912063;1646.0617448054495;1719.3896166860584;1785.973210401845;1820.4447643468868;1159.3391766693073;1179.127445690183;1191.541256616209;1199.5681554640323;1201.0571701214506;6327.620342779448;6457.677116144174;6995.195552511526;7006.509544331848;7024;6716.697748601325;7756.108047574601;7779.688812447552;7784.727534536264;7810.1799311072655;6954.7218111276;7006.124234470692;7016.719331226694;7020.7542736004;7054.5061845671335;3788.753731007476;4096.3855421686385;4101.892489028005;4114.827274226831;4125.566815484391;6695.866082678319;7948.523088614702;8096.10942796292;8124.431289809657;8219.589020549069;7486.475946683789;7941.523508589503;8099.149589293157;8107;8115.269625733712;8213.753587392388;8217.465864718773;8217.630206640715;8219.671213151407;8505.574721264036;6433.453156481564;7568.886466702894;7587.430942679432;7839.294463498312;7841.803954901173;7708.229177082247;7728.072631284282;7733.419993500397;7735.303822655988;7744.186860379579;8222.83554328922;8225;8239.711610093618;8241.093479717347;8257.298129658806;5177.922331165111;5178.818741344035;5182.300389447527;5184.118699821115;5194.22086687;7472.589007604634;7785.455018148676;7835.921640783519;7838.568878711726;7841.843163136591;7444.553326800409;7527.397808175223;7534.171241163577;7558.206388329147;7558.886616700864;6055.394460553909;7505.587192704235;7516.812079697833;7527;7542.2834830691;6394.1687580614225;6449.871272527383;7011.263817299314;7306.780796576111;7365.447591430771;5701.828945131652;7514.248575142442;7556.58438785872;7582.734604288823;7614.923850761422;7365.742199023222;7379.298966598165;7380.557166570023;7386.704531818882;7388.815279617837 16:51:17 INFO - PROCESS | 1672 | |5;yui.html;725.8258018075662;747.4842358772447;782.3037496627999;798.2416704131075;808.5957021489255;15623.84376156238;15791.605209869758;15913;15961.361545538164;15981.760273595906;14760.852391476083;14767.630809229775;14820.962532622721;14822.184779837105;14822.703545929075;797.8603744344746;949.050949050949;966.7148191283588;968.4867020479139;982.5873133284002;979.8089372572351;982.9557669904872;989.990100098997;996.6661168508558;1004.342155887891;1013.0780989299739;1024.1243736605206;1026.4149434822154;1032.1742605915276;1035.6582327831798;1010.4594042187431;1023.1967905194462;1024.6464969585556;1028.172321281368;1033.5659023210233;749.9587522686251;759.3621358059256;763.8357753083059;765.3303359560384;774.8450309938034;15685.372585096582;15917.840821591752;16004.279807408695;16004.75992860108;16045.598860028476;13368.665783355495;13410.195388276637;13438;13509.662258443617;13632.591022269347;10426.791464170674;10460.372377657364;10470.005349491787;10523.631672891412;10613.41626210558;3647.74465787395;3650.8357123929486;3655.5796083450214;3661.9084522886874;3707.0528929500842;84242.15757842465;86296;86296.56851715701;86535;87114;9982.201423886218;10079.24405669563;10135.239857010754;10236.53935572901;10249.84625230622;19021;23269.53460930772;23288.301350959497;23345.94943227559;23396.415089622897;6762.628055456898;7495.362894154058;7671.07947046358;7795.493292935941;7945;3557.5019497270405;3609.8556057757396;4080.6735461163034;4165.250254954077;4201.642860356904;3699.2971335446177;3733.4026555751493;3763.1532905096683;3764.322421964073;3779.905502362408;655.5476721062452;664.9035889795953;667.0361327881166;690.3234829866658;690.9654517274216;597.1878245586087;603.2067830802481;604.6311749832598;610.1579819848581;612.124661733725;8603.698870539502;8655.6970506032;8721.476711397336;8744.825103497895;8904.465732056098;510.4512648902445;525.2436491452296;594.349187639534;623.8409205652621;628.2335550628226;3903.551091624443;4007.519097708294;4057.391391291271;4065.2072845794787;4171.186618609342;99214.50392748135;99406.52670629839;101448.49275753574;101481;101892;82560.76158857622;83017;83582.58208708918;83942.9014274648;84736.57631711925;51646;54172.729136354064;70057.35794945323;70363;70521.64739176373;7969.561674107747;8168.387370947322;8204.83590328202;8309.418340716093;8403.243708066304;41232.14455349457;52981.73509132584;53127;54106;54135.45864541304;69809.3019069823;74050;74084.25915740989;74631;75067.8739818914;10373.325733827278;10592.470376480991;10638.722754186108;10813.945930270298;10894.400807955639;10943.726406839893;11192.776144477228;11273.098152147972;11495.597654082067;11600.30398176112;9531.446901134228;10496.370217786956;10535.051845333957;10796.892031079902;11158.10735141203;10486.632967846088;10545.841812372668;10743.086837618577;10872.238943273895;11307.208495405243;10422.947885260828;10444.947775261075;10470.581176752845;10770.192235582206;11059.336439813636;7551.791713325842;8254.669813207645;8839.51382673959;8909.777255568404;8961.865572016555;9100.681476148568;9256.629734810533;9321.30090243221;9351.719448416557;9388.483633400228 16:51:17 INFO - PROCESS | 1672 | __end_tp_report 16:51:17 INFO - PROCESS | 1672 | __start_cc_report 16:51:17 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,354 16:51:17 INFO - PROCESS | 1672 | __end_cc_report 16:51:17 INFO - PROCESS | 1672 | __startTimestamp1462405877618__endTimestamp 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | ------- Summary: start ------- 16:51:17 INFO - PROCESS | 1672 | Number of tests: 6 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5862.91 Median:6125.30 stddev:638.98 (10.4%) stddev-sans-first:616.10 16:51:17 INFO - PROCESS | 1672 | Values: 3613.8 3661.7 3685.9 3704.5 3722.9 5962.2 5991.7 5995.9 5997.6 6008.4 5949.8 5968.8 5984.3 5995.4 6016.5 5321.9 5329.7 5362.2 5373.7 5469.3 5219.4 5344.5 5344.7 5359.3 5372.7 5351.0 5359.0 5376.2 5379.8 5417.7 4477.3 5346.1 5379.7 5433.9 5465.6 5301.3 5355.9 5387.8 5397.0 5404.3 5714.5 5932.9 5964.2 5989.2 6068.2 5777.5 5881.0 6159.6 6229.1 6261.3 5420.7 5601.3 6062.1 6327.4 6391.3 4920.6 5900.3 5918.6 6058.5 6062.2 5595.8 6415.8 6425.9 6434.4 6454.6 6309.3 6313.7 6332.7 6340.1 6347.3 6218.1 6254.0 6300.9 6312.0 6354.1 5847.9 6285.3 6301.7 6302.6 6317.5 5921.6 6212.9 6270.8 6284.6 6311.4 4062.9 4237.4 5001.7 5050.4 5099.0 4516.0 4528.0 4531.5 4584.5 4590.4 5929.8 6041.6 6095.1 6101.4 6125.4 6115.0 6172.3 6262.2 6315.3 6338.3 6107.7 6120.3 6125.3 6127.5 6160.7 5618.4 5623.4 5630.0 5651.9 5663.5 6324.4 6448.5 6501.1 6545.6 6569.8 6291.5 6312.2 6334.9 6336.2 6339.6 6313.4 6493.8 6560.8 6593.3 6606.3 6205.1 6237.3 6278.5 6280.5 6290.6 6299.3 6317.5 6323.9 6340.8 6348.3 6143.7 6177.2 6256.8 6279.7 6312.1 5731.0 6238.9 6250.9 6255.7 6280.1 6027.2 6141.0 6179.0 6194.3 6196.7 6131.6 6144.0 6148.8 6196.7 6252.6 6197.4 6213.8 6214.7 6234.2 6266.6 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:62868.26 Median:39815.91 stddev:128404.93 (322.5%) stddev-sans-first:128679.96 16:51:17 INFO - PROCESS | 1672 | Values: 574.3 598.8 620.1 677.8 681.2 39044.0 39709.2 39799.0 39832.8 39836.6 43383.0 43500.8 44200.6 44231.8 44322.8 9879.0 9986.6 10010.9 10116.1 10132.0 9844.8 9918.9 9963.6 9999.0 10000.2 9919.0 9920.1 9920.4 9952.7 10024.4 9880.2 9952.0 9961.4 9966.0 9989.4 9819.6 9949.4 9962.6 9977.1 9982.9 34415.8 40589.0 40800.4 40904.8 40998.8 3210.2 3383.7 3389.9 3404.0 3536.9 27544.0 27946.2 28675.4 28885.0 29337.9 2766.0 2768.8 2795.6 2863.2 2959.0 345618.0 347731.0 349297.3 349760.0 349767.5 48748.5 49021.0 49269.8 68222.0 69754.7 47493.1 47764.0 47796.5 47820.8 47879.8 17250.5 17251.8 17280.5 17364.7 17377.6 13383.2 13439.1 13577.6 13694.1 13791.0 15463.3 15523.2 15577.9 15631.8 15879.3 5537.9 5549.9 6518.3 6599.9 6653.9 982.2 1018.1 1087.4 1145.7 1251.2 31254.5 31482.7 31836.2 31978.5 32065.0 1100.5 1117.3 1117.3 1239.7 1263.9 13851.4 16078.3 16177.9 16185.6 16379.8 552788.0 554839.2 558933.0 561776.0 565349.2 64637.0 65051.3 65215.0 65246.7 65383.7 1533.8 1540.0 1554.5 1571.4 1572.5 28756.3 29566.3 30971.7 31511.7 32053.0 55997.0 56018.4 56116.6 56258.7 56369.0 514049.0 514091.0 515511.0 516611.0 516991.0 35381.9 35406.8 47981.3 48842.8 49915.0 46038.0 46052.8 46171.3 46903.8 46997.0 40243.8 40302.4 40522.6 41936.2 42740.8 37443.4 38435.0 38453.4 38637.4 39006.4 38695.6 40803.6 41601.4 41813.6 42713.8 32711.7 34293.0 35160.8 35206.8 35828.6 26339.6 26544.9 26570.0 26750.2 26860.6 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:35114.40 Median:11940.08 stddev:104889.76 (878.5%) stddev-sans-first:105151.55 16:51:17 INFO - PROCESS | 1672 | Values: 366.7 374.9 385.7 386.0 388.8 20749.9 21676.8 22164.3 22410.2 22511.4 12907.1 12968.9 20583.0 22164.3 23133.2 5392.3 5585.3 5639.2 5644.9 5656.5 4130.6 5964.6 6124.1 6181.7 6225.2 5988.4 6171.2 6195.2 6212.3 6240.3 6061.6 6151.8 6220.1 6223.0 6224.9 5793.5 5957.6 5968.9 5979.7 6035.6 14633.3 14885.6 20468.3 27164.5 27816.4 1649.7 1864.3 2052.7 2162.4 2203.4 8813.6 10132.8 10587.6 10593.5 10637.6 1428.8 1752.1 1839.8 1843.6 1845.4 100195.5 102266.0 106191.5 106204.0 112746.9 11717.8 11745.7 11803.2 11829.8 11846.2 12226.6 14689.9 14698.6 14758.7 14929.3 9030.2 9067.7 9090.8 9183.8 9260.9 9452.0 9494.0 9516.9 9571.0 9572.8 4267.7 4613.6 4669.4 4701.8 4721.9 1825.4 1858.0 1906.5 1982.6 1983.2 819.7 975.6 988.8 1009.0 1076.4 21520.0 22053.6 22159.0 22273.2 22344.4 1036.4 1043.7 1056.1 1081.6 1084.4 11504.7 11884.5 11905.6 11917.9 11998.9 472718.0 651582.0 663043.0 676724.0 677851.0 87491.0 122726.0 124034.0 126592.0 127933.4 1051.5 1072.7 1080.7 1082.1 1082.1 18763.0 19340.5 19420.6 19432.2 19718.0 49196.5 49772.8 51027.0 51961.7 52513.5 71724.3 73021.3 73553.3 74056.3 75572.0 7012.6 7405.4 8388.7 8597.4 8742.0 10087.4 11062.7 13812.7 13853.4 14273.1 9022.5 9402.5 11859.0 11929.8 11979.9 11296.4 11666.4 11821.7 12078.9 12092.3 11529.5 11814.4 11834.2 11985.6 12102.6 8484.7 8508.1 8586.1 8726.6 8748.0 10335.4 11751.4 11855.5 11881.7 12057.9 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6379.52 Median:5254.84 stddev:3402.82 (64.8%) stddev-sans-first:3394.09 16:51:17 INFO - PROCESS | 1672 | Values: 1686.6 1688.7 2074.5 2105.9 2144.0 8339.1 9104.4 9222.5 9386.6 9418.7 9204.4 9241.9 9332.0 9332.8 9360.2 2239.3 2599.3 2614.2 2628.1 2628.5 2569.6 2597.7 2608.3 2631.2 2631.9 2587.4 2616.5 2630.1 2635.3 2638.5 2192.7 2518.4 2595.9 2628.4 2637.5 2603.8 2603.8 2629.4 2633.0 2634.2 9209.0 9241.2 9487.0 9509.6 9520.1 5684.7 5732.8 5808.9 5887.5 5979.5 3136.6 3697.6 3838.8 3853.9 3854.3 1078.5 1092.8 1096.9 1097.6 1129.4 12672.8 12676.9 12699.4 12818.2 12840.6 5117.5 5134.9 5146.8 5248.2 5266.1 10733.3 10754.7 10838.2 10920.8 10931.9 5714.3 5729.4 5862.1 5878.2 5911.8 4663.8 5196.4 5223.3 5261.4 5297.2 3729.5 4000.6 4146.6 4170.1 4188.0 1373.4 1390.2 1391.4 1398.5 1399.1 1350.3 1391.0 1412.6 1420.4 1433.2 8654.5 8795.5 8815.8 8838.8 8863.7 452.6 534.0 535.9 536.3 539.0 6370.7 6397.7 6453.9 6455.9 6462.8 11196.9 11284.9 11526.1 11530.2 11591.8 10877.8 11281.2 11387.5 11400.4 11444.5 7675.1 8612.8 8905.6 8926.4 8940.1 7286.2 7782.4 8357.6 8373.7 8509.7 9127.2 9860.8 10111.4 10205.9 10300.5 10190.2 10261.7 10278.4 10345.8 10669.2 7237.6 7751.5 7933.7 7946.4 8058.6 8590.8 8692.1 8797.0 8829.4 8851.7 6020.4 7672.0 7763.7 7813.5 7911.3 6717.9 7738.7 7769.2 7864.2 7889.6 8105.4 8200.5 8244.5 8265.6 8270.0 7189.3 7368.0 7385.2 7414.4 7430.1 6426.7 7512.1 7573.8 7629.0 7655.7 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:6096.26 Median:6970.01 stddev:1970.98 (28.3%) stddev-sans-first:1927.69 16:51:17 INFO - PROCESS | 1672 | Values: 288.0 320.5 343.5 346.8 348.4 5632.3 7020.2 7118.8 7124.9 7140.5 6985.3 7061.3 7064.4 7068.4 7070.5 3945.9 4977.0 5055.9 5067.5 5206.8 5022.3 5053.9 5057.6 5061.5 5092.2 4999.9 5005.9 5016.0 5021.3 5023.4 4950.1 5004.3 5010.7 5020.5 5030.1 4372.8 4380.8 4384.0 4394.5 4402.8 6472.5 6763.7 6774.2 6778.1 6784.7 5940.2 5944.0 5954.9 5958.1 6014.8 7468.2 7489.3 7490.8 7498.6 7505.7 4826.7 4827.3 4830.1 4835.6 4846.0 7204.8 7884.0 7955.7 7970.0 7996.9 4807.7 4843.5 4929.5 4944.5 4953.7 5009.6 5014.9 5020.4 5023.7 5024.0 4895.9 6010.7 6011.1 6011.2 6011.9 7535.7 7565.3 7566.7 7573.0 7577.2 1474.5 1646.1 1719.4 1786.0 1820.4 1159.3 1179.1 1191.5 1199.6 1201.1 6327.6 6457.7 6995.2 7006.5 7024.0 6716.7 7756.1 7779.7 7784.7 7810.2 6954.7 7006.1 7016.7 7020.8 7054.5 3788.8 4096.4 4101.9 4114.8 4125.6 6695.9 7948.5 8096.1 8124.4 8219.6 7486.5 7941.5 8099.1 8107.0 8115.3 8213.8 8217.5 8217.6 8219.7 8505.6 6433.5 7568.9 7587.4 7839.3 7841.8 7708.2 7728.1 7733.4 7735.3 7744.2 8222.8 8225.0 8239.7 8241.1 8257.3 5177.9 5178.8 5182.3 5184.1 5194.2 7472.6 7785.5 7835.9 7838.6 7841.8 7444.6 7527.4 7534.2 7558.2 7558.9 6055.4 7505.6 7516.8 7527.0 7542.3 6394.2 6449.9 7011.3 7306.8 7365.4 5701.8 7514.2 7556.6 7582.7 7614.9 7365.7 7379.3 7380.6 7386.7 7388.8 16:51:17 INFO - PROCESS | 1672 | 16:51:17 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18899.95 Median:4168.22 stddev:27178.89 (652.1%) stddev-sans-first:27220.88 16:51:17 INFO - PROCESS | 1672 | Values: 725.8 747.5 782.3 798.2 808.6 15623.8 15791.6 15913.0 15961.4 15981.8 14760.9 14767.6 14821.0 14822.2 14822.7 797.9 949.1 966.7 968.5 982.6 979.8 983.0 990.0 996.7 1004.3 1013.1 1024.1 1026.4 1032.2 1035.7 1010.5 1023.2 1024.6 1028.2 1033.6 750.0 759.4 763.8 765.3 774.8 15685.4 15917.8 16004.3 16004.8 16045.6 13368.7 13410.2 13438.0 13509.7 13632.6 10426.8 10460.4 10470.0 10523.6 10613.4 3647.7 3650.8 3655.6 3661.9 3707.1 84242.2 86296.0 86296.6 86535.0 87114.0 9982.2 10079.2 10135.2 10236.5 10249.8 19021.0 23269.5 23288.3 23345.9 23396.4 6762.6 7495.4 7671.1 7795.5 7945.0 3557.5 3609.9 4080.7 4165.3 4201.6 3699.3 3733.4 3763.2 3764.3 3779.9 655.5 664.9 667.0 690.3 691.0 597.2 603.2 604.6 610.2 612.1 8603.7 8655.7 8721.5 8744.8 8904.5 510.5 525.2 594.3 623.8 628.2 3903.6 4007.5 4057.4 4065.2 4171.2 99214.5 99406.5 101448.5 101481.0 101892.0 82560.8 83017.0 83582.6 83942.9 84736.6 51646.0 54172.7 70057.4 70363.0 70521.6 7969.6 8168.4 8204.8 8309.4 8403.2 41232.1 52981.7 53127.0 54106.0 54135.5 69809.3 74050.0 74084.3 74631.0 75067.9 10373.3 10592.5 10638.7 10813.9 10894.4 10943.7 11192.8 11273.1 11495.6 11600.3 9531.4 10496.4 10535.1 10796.9 11158.1 10486.6 10545.8 10743.1 10872.2 11307.2 10422.9 10444.9 10470.6 10770.2 11059.3 7551.8 8254.7 8839.5 8909.8 8961.9 9100.7 9256.6 9321.3 9351.7 9388.5 16:51:17 INFO - PROCESS | 1672 | -------- Summary: end -------- 16:51:17 INFO - PROCESS | 1672 | 16:51:18 INFO - TEST-INFO | 1672: exit 0 16:51:18 INFO - TEST-OK | dromaeo_css | took 1109964ms 16:51:18 INFO - TEST-START | kraken 16:51:18 INFO - operating with platform_type : mac_ 16:51:18 INFO - Initialising browser for kraken test... 16:51:18 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmprR40gL/profile http://localhost:49270/getInfo.html) 16:51:20 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 16:51:20 INFO - PROCESS | 1681 | colorDepth:24 16:51:20 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 16:51:20 INFO - PROCESS | 1681 | __metrics 16:51:20 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:51:21 INFO - TEST-INFO | 1681: exit 0 16:51:21 INFO - Browser initialized. 16:51:21 INFO - Running cycle 1/1 for kraken test... 16:51:21 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmprR40gL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:33 INFO - PROCESS | 1685 | RSS: Main: 168259584 16:51:33 INFO - PROCESS | 1685 | 16:51:35 INFO - PROCESS | 1685 | 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) 16:51:36 INFO - PROCESS | 1685 | RSS: Main: 179593216 16:51:36 INFO - PROCESS | 1685 | 16:51:39 INFO - PROCESS | 1685 | 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) 16:51:39 INFO - PROCESS | 1685 | RSS: Main: 189173760 16:51:39 INFO - PROCESS | 1685 | 16:51:43 INFO - PROCESS | 1685 | 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) 16:51:43 INFO - PROCESS | 1685 | RSS: Main: 192700416 16:51:43 INFO - PROCESS | 1685 | 16:51:45 INFO - PROCESS | 1685 | 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) 16:51:46 INFO - PROCESS | 1685 | RSS: Main: 193658880 16:51:46 INFO - PROCESS | 1685 | 16:51:48 INFO - PROCESS | 1685 | 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) 16:51:49 INFO - PROCESS | 1685 | RSS: Main: 194437120 16:51:49 INFO - PROCESS | 1685 | 16:51:51 INFO - PROCESS | 1685 | 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) 16:51:52 INFO - PROCESS | 1685 | RSS: Main: 195178496 16:51:52 INFO - PROCESS | 1685 | 16:51:55 INFO - PROCESS | 1685 | 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) 16:51:55 INFO - PROCESS | 1685 | RSS: Main: 195145728 16:51:55 INFO - PROCESS | 1685 | 16:51:58 INFO - PROCESS | 1685 | 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) 16:51:59 INFO - PROCESS | 1685 | RSS: Main: 194543616 16:51:59 INFO - PROCESS | 1685 | 16:52:00 INFO - PROCESS | 1685 | 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) 16:52:01 INFO - PROCESS | 1685 | RSS: Main: 194707456 16:52:01 INFO - PROCESS | 1685 | 16:52:03 INFO - PROCESS | 1685 | 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) 16:52:04 INFO - PROCESS | 1685 | RSS: Main: 194879488 16:52:04 INFO - PROCESS | 1685 | 16:52:06 INFO - PROCESS | 1685 | 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) 16:52:06 INFO - PROCESS | 1685 | RSS: Main: 195137536 16:52:06 INFO - PROCESS | 1685 | 16:52:09 INFO - PROCESS | 1685 | 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) 16:52:10 INFO - PROCESS | 1685 | RSS: Main: 195018752 16:52:10 INFO - PROCESS | 1685 | 16:52:12 INFO - PROCESS | 1685 | 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) 16:52:13 INFO - PROCESS | 1685 | RSS: Main: 195215360 16:52:13 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | 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) 16:52:14 INFO - PROCESS | 1685 | RSS: Main: 196079616 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | __start_tp_report 16:52:14 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 16:52:14 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 16:52:14 INFO - PROCESS | 1685 | |i|pagename|runs| 16:52:14 INFO - PROCESS | 1685 | |0;ai-astar;114;127;120;115;114;130;113;115;114;132 16:52:14 INFO - PROCESS | 1685 | |1;audio-beat-detection;151;121;141;150;117;136;121;157;167;155 16:52:14 INFO - PROCESS | 1685 | |2;audio-dft;217;199;267;193;279;273;217;197;194;199 16:52:14 INFO - PROCESS | 1685 | |3;audio-fft;66;72;72;113;59;55;57;59;120;57 16:52:14 INFO - PROCESS | 1685 | |4;audio-oscillator;81;84;124;73;72;103;151;116;111;135 16:52:14 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;90;86;88;87;89;86;90;86;88;86 16:52:14 INFO - PROCESS | 1685 | |6;imaging-darkroom;95;96;95;96;96;96;96;97;97;91 16:52:14 INFO - PROCESS | 1685 | |7;imaging-desaturate;155;149;93;92;92;96;133;117;136;140 16:52:14 INFO - PROCESS | 1685 | |8;json-parse-financial;54;59;58;54;58;50;52;80;49;70 16:52:14 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;67;71;81;98;63;88;54;68;90;92 16:52:14 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;84;80;84;75;98;73;89;108;109;112 16:52:14 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;131;120;132;122;130;137;108;126;144;134 16:52:14 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;137;136;142;136;134;135;135;136;134;139 16:52:14 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;65;67;66;65;68;63;64;67;67;66 16:52:14 INFO - PROCESS | 1685 | __end_tp_report 16:52:14 INFO - PROCESS | 1685 | __start_cc_report 16:52:14 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,916 16:52:14 INFO - PROCESS | 1685 | __end_cc_report 16:52:14 INFO - PROCESS | 1685 | __startTimestamp1462405934962__endTimestamp 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | ------- Summary: start ------- 16:52:14 INFO - PROCESS | 1685 | Number of tests: 14 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:119.40 Median:117.50 stddev:7.43 (6.3%) stddev-sans-first:7.62 16:52:14 INFO - PROCESS | 1685 | Values: 114.0 127.0 120.0 115.0 114.0 130.0 113.0 115.0 114.0 132.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:150.50 stddev:17.34 (11.5%) stddev-sans-first:18.06 16:52:14 INFO - PROCESS | 1685 | Values: 151.0 121.0 141.0 150.0 117.0 136.0 121.0 157.0 167.0 155.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:223.50 Median:217.00 stddev:35.29 (16.3%) stddev-sans-first:37.36 16:52:14 INFO - PROCESS | 1685 | Values: 217.0 199.0 267.0 193.0 279.0 273.0 217.0 197.0 194.0 199.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:73.00 Median:59.00 stddev:23.78 (40.3%) stddev-sans-first:25.08 16:52:14 INFO - PROCESS | 1685 | Values: 66.0 72.0 72.0 113.0 59.0 55.0 57.0 59.0 120.0 57.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:111.50 stddev:27.22 (24.4%) stddev-sans-first:27.45 16:52:14 INFO - PROCESS | 1685 | Values: 81.0 84.0 124.0 73.0 72.0 103.0 151.0 116.0 111.0 135.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.50 16:52:14 INFO - PROCESS | 1685 | Values: 90.0 86.0 88.0 87.0 89.0 86.0 90.0 86.0 88.0 86.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:96.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 16:52:14 INFO - PROCESS | 1685 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 97.0 97.0 91.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:120.30 Median:123.50 stddev:25.32 (20.5%) stddev-sans-first:23.54 16:52:14 INFO - PROCESS | 1685 | Values: 155.0 149.0 93.0 92.0 92.0 96.0 133.0 117.0 136.0 140.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:9.66 (16.7%) stddev-sans-first:10.12 16:52:14 INFO - PROCESS | 1685 | Values: 54.0 59.0 58.0 54.0 58.0 50.0 52.0 80.0 49.0 70.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:84.50 stddev:14.58 (17.3%) stddev-sans-first:14.99 16:52:14 INFO - PROCESS | 1685 | Values: 67.0 71.0 81.0 98.0 63.0 88.0 54.0 68.0 90.0 92.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:82.00 stddev:14.55 (17.7%) stddev-sans-first:15.20 16:52:14 INFO - PROCESS | 1685 | Values: 84.0 80.0 84.0 75.0 98.0 73.0 89.0 108.0 109.0 112.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.50 stddev:10.02 (7.6%) stddev-sans-first:10.59 16:52:14 INFO - PROCESS | 1685 | Values: 131.0 120.0 132.0 122.0 130.0 137.0 108.0 126.0 144.0 134.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:136.00 stddev:2.46 (1.8%) stddev-sans-first:2.60 16:52:14 INFO - PROCESS | 1685 | Values: 137.0 136.0 142.0 136.0 134.0 135.0 135.0 136.0 134.0 139.0 16:52:14 INFO - PROCESS | 1685 | 16:52:14 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 16:52:14 INFO - PROCESS | 1685 | Values: 65.0 67.0 66.0 65.0 68.0 63.0 64.0 67.0 67.0 66.0 16:52:14 INFO - PROCESS | 1685 | -------- Summary: end -------- 16:52:14 INFO - PROCESS | 1685 | 16:52:15 INFO - TEST-INFO | 1685: exit 0 16:52:15 INFO - TEST-OK | kraken | took 57458ms 16:52:15 INFO - SUITE-END | took 1167s 16:52:16 INFO - Completed test suite (00:19:27) 16:52:16 INFO - javascript benchmark 16:52:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3613.8012409317485, 3661.6704496595307, 3685.8525658973645, 3704.4813726078355, 3722.9255414891704, 5962.195103661004, 5991.670458124801, 5995.850103747398, 5997.550183736221, 6008.429199226072, 5949.821505354836, 5968.79109231177, 5984.341722410542, 5995.370486098962, 6016.488598469125, 5321.866953326169, 5329.653572517774, 5362.195670649414, 5373.6775793452325, 5469.261649677283, 5219.42586315505, 5344.518993290603, 5344.652597581165, 5359.330083739533, 5372.677639341632, 5350.973245133769, 5359.035373632744, 5376.247325374451, 5379.838604841861, 5417.7291135443265, 4477.306017567283, 5346.117890548055, 5379.731013449351, 5433.945660543423, 5465.59008074394, 5301.310829592167, 5355.866103347408, 5387.81142660005, 5397.001554712351, 5404.270423492857, 5714.457126572969, 5932.902413053599, 5964.224650795412, 5989.191459153002, 6068.211132552784, 5777.508911742507, 5880.97059514704, 6159.568830181889, 6229.0967809667345, 6261.311255761862, 5420.7018613976215, 5601.327840659147, 6062.120992456069, 6327.3988971047675, 6391.296957334689, 4920.5571498565305, 5900.291964964146, 5918.585699001072, 6058.545609079292, 6062.211912451397, 5595.804146854841, 6415.839604009937, 6425.903611445832, 6434.388733070351, 6454.6449945252525, 6309.337519560472, 6313.684315784192, 6332.68336583169, 6340.080688300263, 6347.270063942613, 6218.098375735493, 6254.030625253093, 6300.897342964963, 6312.0, 6354.110424540568, 5847.9415205848245, 6285.308616052231, 6301.653409062454, 6302.590331628521, 6317.4946004319545, 5921.61509501881, 6212.9378706213265, 6270.811875643738, 6284.622922624566, 6311.431971122621, 4062.898427539276, 4237.385579091077, 5001.674891132065, 5050.393952725696, 5099.031184075014, 4515.9548404515535, 4527.981204229022, 4531.456225252925, 4584.472785629695, 4590.380298659638, 5929.822105336761, 6041.577089603686, 6095.085737139465, 6101.389861013952, 6125.356837532084, 6115.027386288435, 6172.259328880563, 6262.2172228471445, 6315.305316415191, 6338.30278669346, 6107.725152368154, 6120.326764055951, 6125.295591007091, 6127.509799216141, 6160.661163636043, 5618.438156184349, 5623.381428042912, 5630.042892708249, 5651.886962260814, 5663.490285874291, 6324.430801227912, 6448.516361272923, 6501.0898474213645, 6545.574537655038, 6569.770058048041, 6291.465225455888, 6312.179416675803, 6334.936650633619, 6336.20797400325, 6339.619622822461, 6313.43179113882, 6493.772717954849, 6560.803175904731, 6593.307702691341, 6606.306337834458, 6205.069239614094, 6237.313895471404, 6278.497720182283, 6280.466160376419, 6290.622562646256, 6299.338569450142, 6317.526185536011, 6323.905141422974, 6340.795248902694, 6348.301686814539, 6143.665407145256, 6177.227846519185, 6256.812295631138, 6279.748810047547, 6312.084747711648, 5730.971345143247, 6238.875222495615, 6250.9062364065485, 6255.687215639291, 6280.120783090462, 6027.186329845415, 6141.0, 6178.969105154445, 6194.287656919331, 6196.690165491617, 6131.601445906002, 6143.96928015357, 6148.815535533941, 6196.721147548461, 6252.558227759743, 6197.380261973947, 6213.782517612042, 6214.658193799384, 6234.220722409699, 6266.624002559861], "unit": "score", "name": "dojo.html", "value": 5825.465969650616}, {"lowerIsBetter": false, "replicates": [574.3194314737037, 598.8322770597333, 620.0791824141153, 677.7664650336387, 681.1757773094555, 39044.0, 39709.205815883666, 39799.00502487432, 39832.80501584953, 39836.60163398365, 43383.0, 43500.78249608755, 44200.55799442004, 44231.77884110583, 44322.778386108104, 9878.999999999982, 9986.600535978589, 10010.949945250264, 10116.14012808912, 10132.0, 9844.803103937953, 9918.851217231748, 9963.551640176209, 9998.950005249964, 10000.2499812514, 9919.0, 9920.057594528509, 9920.40477571348, 9952.651657192, 10024.398536087821, 9880.160186384166, 9951.95504472031, 9961.40231586107, 9966.0, 9989.400635961865, 9819.607215711363, 9949.403035817873, 9962.601495940155, 9977.052180042885, 9982.90017099827, 34415.82792086023, 40588.98527536835, 40800.387994179815, 40904.79547602273, 40998.79500602508, 3210.2455922858107, 3383.7293016558615, 3389.8983030509125, 3404.0468668772783, 3536.876209332687, 27544.0, 27946.161615151577, 28675.42649147026, 28885.0, 29337.853310733524, 2765.958510622342, 2768.764655004327, 2795.55271156616, 2863.155369166101, 2959.0235222376564, 345618.0, 347731.0, 349297.25351373333, 349760.0, 349767.502324976, 48748.5125148751, 49021.01957960821, 49269.75365123151, 68222.0, 69754.65122674355, 47493.05013899702, 47764.0, 47796.522034779206, 47820.760896195294, 47879.76060119677, 17250.482485525456, 17251.82748172527, 17280.481585552454, 17364.739528907077, 17377.56556086083, 13383.19700817954, 13439.059265851492, 13577.59267221985, 13694.109882857583, 13791.034627575973, 15463.304151313218, 15523.223838808015, 15577.922110389602, 15631.76552351693, 15879.28543215558, 5537.861553461195, 5549.944500555023, 6518.294907613382, 6599.901001484982, 6653.933460665428, 982.1651596143221, 1018.1396719771781, 1087.396494945297, 1145.7135716070982, 1251.1929805275547, 31254.53118203229, 31482.685173148435, 31836.204094897814, 31978.520322195185, 32065.0, 1100.4772732951783, 1117.273772048159, 1117.3016864459712, 1239.7086684629105, 1263.9304838233986, 13851.445942162401, 16078.276477558538, 16177.867549271674, 16185.6084876843, 16379.754303685455, 552788.0, 554839.2258038765, 558933.0, 561776.0, 565349.1732541394, 64637.03044454337, 65051.34948650453, 65215.0, 65246.67376663086, 65383.692326153214, 1533.8159420869345, 1540.0374765771394, 1554.494789193494, 1571.395012920034, 1572.5046610317713, 28756.281092972844, 29566.260843479085, 30971.69028309688, 31511.684883151793, 32053.0, 55997.0, 56018.43981560132, 56116.5970850732, 56258.71870640621, 56369.0, 514049.0, 514091.0, 515511.0, 516611.0, 516991.0, 35381.93854184379, 35406.82296588604, 47981.28028079651, 48842.75578622084, 49915.0, 46038.0, 46052.7697361511, 46171.30743038924, 46903.82740431517, 46997.0, 40243.798781005906, 40302.39546406748, 40522.59477405188, 41936.1612767749, 42740.78629606832, 37443.43834842425, 38435.0, 38453.4231986526, 38637.420438694004, 39006.41490377703, 38695.6130438692, 40803.59196408117, 41601.37597936094, 41813.58186418218, 42713.78643106889, 32711.67288327086, 34293.0, 35160.82419587886, 35206.823965881034, 35828.64171358253, 26339.604905926808, 26544.8672756635, 26570.0, 26750.197494075208, 26860.59709104404], "unit": "score", "name": "ext.html", "value": 20192.285805800293}, {"lowerIsBetter": false, "replicates": [366.67549218941235, 374.8912815283568, 385.6856661820614, 386.0406888881131, 388.8444622151141, 20749.896250518763, 21676.783232167672, 22164.335069947887, 22410.215642452516, 22511.437214069636, 12907.096503244777, 12968.93515532421, 20583.0, 22164.335069947887, 23133.19033833816, 5392.299001129857, 5585.3297604287545, 5639.210510528529, 5644.943550564483, 5656.547476201915, 4130.607592278729, 5964.612300200495, 6124.081387791823, 6181.690915454209, 6225.221847269091, 5988.401159883999, 6171.228596425447, 6195.163652906845, 6212.347703491136, 6240.282367527724, 6061.605995610315, 6151.784687535915, 6220.066989951543, 6222.9688851555675, 6224.875502489947, 5793.536517078624, 5957.6127551709, 5968.910466343008, 5979.730912108966, 6035.577509574332, 14633.268336583234, 14885.627859303604, 20468.283610073726, 27164.45671086587, 27816.443671126668, 1649.6948064608086, 1864.3102052240622, 2052.72288241087, 2162.426956856434, 2203.372038968886, 8813.559322033872, 10132.848007279898, 10587.629432969887, 10593.523291451904, 10637.57449702011, 1428.8285405751376, 1752.1239380309846, 1839.8344149026518, 1843.5575461889184, 1845.3541260558832, 100195.49902250514, 102265.95468090597, 106191.46904265507, 106204.0, 112746.87253127446, 11717.824232636518, 11745.706357341134, 11803.23278986863, 11829.822552661717, 11846.229995050295, 12226.633201003984, 14689.92655036718, 14698.63253418673, 14758.704825903422, 14929.328180231916, 9030.232430243503, 9067.727968160965, 9090.772730681785, 9183.816323673489, 9260.907390926139, 9452.0, 9494.0, 9516.90483095174, 9570.95214523937, 9572.760680982892, 4267.679924005712, 4613.63090952723, 4669.392978912788, 4701.811927522929, 4721.881952951135, 1825.3618269473652, 1857.9721304180448, 1906.485248982767, 1982.553925366781, 1983.1571582077559, 819.6680344460503, 975.5561219645044, 988.7528117970508, 1008.9545970431349, 1076.4025965589017, 21520.0, 22053.558928821654, 22159.00284487202, 22273.22043728494, 22344.441388965082, 1036.3781730961364, 1043.6764602973103, 1056.0970370333407, 1081.5565618096543, 1084.360227465799, 11504.712382190512, 11884.524619015316, 11905.583304584472, 11917.880821191851, 11998.920097191294, 472718.0, 651582.0, 663043.0, 676724.0, 677851.0, 87491.0, 122726.0, 124034.0, 126592.0, 127933.36033319774, 1051.5373235776235, 1072.710368200597, 1080.7190130565953, 1082.0802318029612, 1082.118073769875, 18762.96803675811, 19340.516487087934, 19420.611587767882, 19432.2227110914, 19718.014099295266, 49196.50803491919, 49772.75568110826, 51027.0, 51961.7401912988, 52513.47486525086, 71724.28275717176, 73021.26978730144, 73553.26446735465, 74056.25943740494, 75572.0, 7012.649367531705, 7405.370543503647, 8388.664453421794, 8597.441166324168, 8742.0, 10087.394756314645, 11062.668119956414, 13812.723745525234, 13853.37659805291, 14273.072250303698, 9022.548872556215, 9402.482863442303, 11859.0, 11929.82105268439, 11979.880201197877, 11296.43517824122, 11666.358350290815, 11821.704457388634, 12078.879211207775, 12092.274463532216, 11529.538818447503, 11814.409279536161, 11834.171607987359, 11985.580504682293, 12102.576409825613, 8484.745457636034, 8508.106648802035, 8586.098459661645, 8726.649084409799, 8747.956260218658, 10335.431551264752, 11751.412429378326, 11855.466504007512, 11881.702957425789, 12057.879421206027], "unit": "score", "name": "jquery.html", "value": 9636.791882036523}, {"lowerIsBetter": false, "replicates": [1686.6036481426866, 1688.7044767165746, 2074.5021194913215, 2105.8947052647363, 2143.992323607904, 8339.12439193885, 9104.40821346612, 9222.492762898039, 9386.6245350186, 9418.670346537872, 9204.447733136016, 9241.90758092419, 9331.973482916874, 9332.766680832983, 9360.157585817275, 2239.2722365231284, 2599.3111825366295, 2614.1504011196344, 2628.053900595784, 2628.47430513897, 2569.576019956705, 2597.688277406714, 2608.334874606973, 2631.2369412870244, 2631.947361052778, 2587.3570282870323, 2616.502864455757, 2630.0926180467804, 2635.2752992927003, 2638.498685249806, 2192.7149470568884, 2518.3955850595908, 2595.883185256668, 2628.434886499402, 2637.512060268856, 2603.7526434988645, 2603.8437693738247, 2629.395239095019, 2632.9868350658317, 2634.1570697376847, 9208.953955230249, 9241.214496767716, 9486.95256523713, 9509.5720692569, 9520.095590918922, 5684.687342196177, 5732.828015159552, 5808.912866307009, 5887.499562537189, 5979.491743201833, 3136.623605167372, 3697.630236976308, 3838.7696738195796, 3853.9229215415535, 3854.2676891390824, 1078.5308390850005, 1092.82514797632, 1096.8848270931517, 1097.6377795327523, 1129.350623391545, 12672.80990785139, 12676.873231267662, 12699.428525716365, 12818.166819156819, 12840.55058072963, 5117.513836185556, 5134.948650513522, 5146.768395422215, 5248.2390053442805, 5266.078436273637, 10733.302335348177, 10754.73113172177, 10838.241323107306, 10920.781584368267, 10931.906809319164, 5714.314282286152, 5729.427057294237, 5862.12068189775, 5878.2064421302575, 5911.7635294587735, 4663.836765713184, 5196.402413722395, 5223.268742376071, 5261.447548007404, 5297.152455607084, 3729.4778730977687, 4000.6399424051974, 4146.5853414658895, 4170.082581831992, 4187.958120418818, 1373.4231622718482, 1390.1728471559406, 1391.373881753215, 1398.454602704946, 1399.139529189541, 1350.3045931345364, 1390.9652258693613, 1412.5621057472217, 1420.4105296301918, 1433.218895701845, 8654.524001179996, 8795.47227166372, 8815.779605509913, 8838.779030524289, 8863.689770857989, 452.57005844447906, 534.0493920820945, 535.9142537194031, 536.3376230355585, 538.9622726409192, 6370.681465926685, 6397.6801159941815, 6453.870922581522, 6455.903161452582, 6462.838429039311, 11196.888031119584, 11284.887151128383, 11526.077913766878, 11530.192886497865, 11591.76816463666, 10877.83683244752, 11281.21031527785, 11387.487563059682, 11400.372979486043, 11444.54221831134, 7675.078990521173, 8612.837266969005, 8905.599248033983, 8926.419782714103, 8940.105989401009, 7286.1985181631035, 7782.377409807089, 8357.623906924082, 8373.748787536384, 8509.74470765878, 9127.178553930178, 9860.802783944138, 10111.443870587189, 10205.897941020496, 10300.536475858455, 10190.184785217312, 10261.74345641365, 10278.434686092038, 10345.793084138124, 10669.199810014436, 7237.601931893796, 7751.457397982087, 7933.722319718782, 7946.404019698662, 8058.637361318638, 8590.82818343642, 8692.130786921258, 8797.032326444214, 8829.426087304304, 8851.734447966572, 6020.4280593343565, 7671.961640191764, 7763.72826951054, 7813.531188128731, 7911.28798408123, 6717.932820671731, 7738.729144479917, 7769.223077692185, 7864.1742617026675, 7889.605519724106, 8105.351571874118, 8200.507969521848, 8244.54654993981, 8265.628046737791, 8269.95865020671, 7189.2810718927685, 7367.963160184165, 7385.150707668687, 7414.369778568666, 7430.108386993379, 6426.678666066771, 7512.136104347851, 7573.848523029619, 7629.046369203849, 7655.732049378245], "unit": "score", "name": "mootools.html", "value": 5112.29249467737}, {"lowerIsBetter": false, "replicates": [288.0, 320.47122248290316, 343.4847728407389, 346.80578875829553, 348.37814501115497, 5632.267805185325, 7020.15758109027, 7118.786436406916, 7124.85750284994, 7140.464465165108, 6985.301469853012, 7061.258567850379, 7064.364207221349, 7068.363847253746, 7070.5050646454765, 3945.9210815783667, 4976.975115124419, 5055.949440505603, 5067.49325067494, 5206.7917283308625, 5022.296878437021, 5053.949460505385, 5057.59539236862, 5061.493850614946, 5092.236164575324, 4999.900001999958, 5005.899882002358, 5015.971725796203, 5021.271915572258, 5023.372078490189, 4950.059488697154, 5004.274380214867, 5010.749462526859, 5020.523050310215, 5030.144875371196, 4372.825086996516, 4380.846670366522, 4384.0, 4394.516603173648, 4402.7798610069685, 6472.514561407913, 6763.661816909135, 6774.220964589086, 6778.084958530634, 6784.660766961632, 5940.227770389865, 5944.019236825919, 5954.940450595482, 5958.076498142795, 6014.789482368096, 7468.21583733711, 7489.2510748925215, 7490.812729681747, 7498.550086994744, 7505.737299194502, 4826.734529600871, 4827.275908613701, 4830.058138662962, 4835.6131509479155, 4846.0, 7204.783856484366, 7884.0, 7955.681772729084, 7970.0, 7996.880046799302, 4807.687500312469, 4843.491433399513, 4929.457759646436, 4944.505549445027, 4953.653244272867, 5009.599232061426, 5014.899702006012, 5020.3724534433195, 5023.748812559431, 5024.0, 4895.926561101586, 6010.699465026732, 6011.128386384037, 6011.218541589653, 6011.879762404815, 7535.6985720570565, 7565.2812982766545, 7566.659500322498, 7573.015507984037, 7577.16651168382, 1474.4691910912063, 1646.0617448054495, 1719.3896166860584, 1785.973210401845, 1820.4447643468868, 1159.3391766693073, 1179.127445690183, 1191.541256616209, 1199.5681554640323, 1201.0571701214506, 6327.620342779448, 6457.677116144174, 6995.195552511526, 7006.509544331848, 7024.0, 6716.697748601325, 7756.108047574601, 7779.688812447552, 7784.727534536264, 7810.1799311072655, 6954.7218111276, 7006.124234470692, 7016.719331226694, 7020.7542736004, 7054.5061845671335, 3788.753731007476, 4096.3855421686385, 4101.892489028005, 4114.827274226831, 4125.566815484391, 6695.866082678319, 7948.523088614702, 8096.10942796292, 8124.431289809657, 8219.589020549069, 7486.475946683789, 7941.523508589503, 8099.149589293157, 8107.0, 8115.269625733712, 8213.753587392388, 8217.465864718773, 8217.630206640715, 8219.671213151407, 8505.574721264036, 6433.453156481564, 7568.886466702894, 7587.430942679432, 7839.294463498312, 7841.803954901173, 7708.229177082247, 7728.072631284282, 7733.419993500397, 7735.303822655988, 7744.186860379579, 8222.83554328922, 8225.0, 8239.711610093618, 8241.093479717347, 8257.298129658806, 5177.922331165111, 5178.818741344035, 5182.300389447527, 5184.118699821115, 5194.22086687, 7472.589007604634, 7785.455018148676, 7835.921640783519, 7838.568878711726, 7841.843163136591, 7444.553326800409, 7527.397808175223, 7534.171241163577, 7558.206388329147, 7558.886616700864, 6055.394460553909, 7505.587192704235, 7516.812079697833, 7527.0, 7542.2834830691, 6394.1687580614225, 6449.871272527383, 7011.263817299314, 7306.780796576111, 7365.447591430771, 5701.828945131652, 7514.248575142442, 7556.58438785872, 7582.734604288823, 7614.923850761422, 7365.742199023222, 7379.298966598165, 7380.557166570023, 7386.704531818882, 7388.815279617837], "unit": "score", "name": "prototype.html", "value": 5436.618965786856}, {"lowerIsBetter": false, "replicates": [725.8258018075662, 747.4842358772447, 782.3037496627999, 798.2416704131075, 808.5957021489255, 15623.84376156238, 15791.605209869758, 15913.0, 15961.361545538164, 15981.760273595906, 14760.852391476083, 14767.630809229775, 14820.962532622721, 14822.184779837105, 14822.703545929075, 797.8603744344746, 949.050949050949, 966.7148191283588, 968.4867020479139, 982.5873133284002, 979.8089372572351, 982.9557669904872, 989.990100098997, 996.6661168508558, 1004.342155887891, 1013.0780989299739, 1024.1243736605206, 1026.4149434822154, 1032.1742605915276, 1035.6582327831798, 1010.4594042187431, 1023.1967905194462, 1024.6464969585556, 1028.172321281368, 1033.5659023210233, 749.9587522686251, 759.3621358059256, 763.8357753083059, 765.3303359560384, 774.8450309938034, 15685.372585096582, 15917.840821591752, 16004.279807408695, 16004.75992860108, 16045.598860028476, 13368.665783355495, 13410.195388276637, 13438.0, 13509.662258443617, 13632.591022269347, 10426.791464170674, 10460.372377657364, 10470.005349491787, 10523.631672891412, 10613.41626210558, 3647.74465787395, 3650.8357123929486, 3655.5796083450214, 3661.9084522886874, 3707.0528929500842, 84242.15757842465, 86296.0, 86296.56851715701, 86535.0, 87114.0, 9982.201423886218, 10079.24405669563, 10135.239857010754, 10236.53935572901, 10249.84625230622, 19021.0, 23269.53460930772, 23288.301350959497, 23345.94943227559, 23396.415089622897, 6762.628055456898, 7495.362894154058, 7671.07947046358, 7795.493292935941, 7945.0, 3557.5019497270405, 3609.8556057757396, 4080.6735461163034, 4165.250254954077, 4201.642860356904, 3699.2971335446177, 3733.4026555751493, 3763.1532905096683, 3764.322421964073, 3779.905502362408, 655.5476721062452, 664.9035889795953, 667.0361327881166, 690.3234829866658, 690.9654517274216, 597.1878245586087, 603.2067830802481, 604.6311749832598, 610.1579819848581, 612.124661733725, 8603.698870539502, 8655.6970506032, 8721.476711397336, 8744.825103497895, 8904.465732056098, 510.4512648902445, 525.2436491452296, 594.349187639534, 623.8409205652621, 628.2335550628226, 3903.551091624443, 4007.519097708294, 4057.391391291271, 4065.2072845794787, 4171.186618609342, 99214.50392748135, 99406.52670629839, 101448.49275753574, 101481.0, 101892.0, 82560.76158857622, 83017.0, 83582.58208708918, 83942.9014274648, 84736.57631711925, 51646.0, 54172.729136354064, 70057.35794945323, 70363.0, 70521.64739176373, 7969.561674107747, 8168.387370947322, 8204.83590328202, 8309.418340716093, 8403.243708066304, 41232.14455349457, 52981.73509132584, 53127.0, 54106.0, 54135.45864541304, 69809.3019069823, 74050.0, 74084.25915740989, 74631.0, 75067.8739818914, 10373.325733827278, 10592.470376480991, 10638.722754186108, 10813.945930270298, 10894.400807955639, 10943.726406839893, 11192.776144477228, 11273.098152147972, 11495.597654082067, 11600.30398176112, 9531.446901134228, 10496.370217786956, 10535.051845333957, 10796.892031079902, 11158.10735141203, 10486.632967846088, 10545.841812372668, 10743.086837618577, 10872.238943273895, 11307.208495405243, 10422.947885260828, 10444.947775261075, 10470.581176752845, 10770.192235582206, 11059.336439813636, 7551.791713325842, 8254.669813207645, 8839.51382673959, 8909.777255568404, 8961.865572016555, 9100.681476148568, 9256.629734810533, 9321.30090243221, 9351.719448416557, 9388.483633400228], "unit": "score", "name": "yui.html", "value": 7070.330548877519}], "name": "dromaeo_css", "value": 7785.937988168604}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 127.0, 120.0, 115.0, 114.0, 130.0, 113.0, 115.0, 114.0, 132.0], "unit": "score", "name": "ai-astar", "value": 119.4}, {"lowerIsBetter": true, "replicates": [151.0, 121.0, 141.0, 150.0, 117.0, 136.0, 121.0, 157.0, 167.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [217.0, 199.0, 267.0, 193.0, 279.0, 273.0, 217.0, 197.0, 194.0, 199.0], "unit": "score", "name": "audio-dft", "value": 223.5}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 72.0, 113.0, 59.0, 55.0, 57.0, 59.0, 120.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.0}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 124.0, 73.0, 72.0, 103.0, 151.0, 116.0, 111.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 88.0, 87.0, 89.0, 86.0, 90.0, 86.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 95.5}, {"lowerIsBetter": true, "replicates": [155.0, 149.0, 93.0, 92.0, 92.0, 96.0, 133.0, 117.0, 136.0, 140.0], "unit": "score", "name": "imaging-desaturate", "value": 120.3}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 58.0, 54.0, 58.0, 50.0, 52.0, 80.0, 49.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 81.0, 98.0, 63.0, 88.0, 54.0, 68.0, 90.0, 92.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.2}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 84.0, 75.0, 98.0, 73.0, 89.0, 108.0, 109.0, 112.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.2}, {"lowerIsBetter": true, "replicates": [131.0, 120.0, 132.0, 122.0, 130.0, 137.0, 108.0, 126.0, 144.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [137.0, 136.0, 142.0, 136.0, 134.0, 135.0, 135.0, 136.0, 134.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 65.0, 68.0, 63.0, 64.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1523.3000000000002}]} 16:52:16 INFO - Return code: 0 16:52:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:52:16 ERROR - # TBPL SUCCESS # 16:52:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:52:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:52:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:52:16 INFO - 2016-05-04 16:52:16.296 screenresolution[1690:10701] starting screenresolution argv=screenresolution get 16:52:16 INFO - 2016-05-04 16:52:16.299 screenresolution[1690:10701] Display 0: 1600x1200x32@60 16:52:16 INFO - 2016-05-04 16:52:16.305 screenresolution[1691:10704] starting screenresolution argv=screenresolution list 16:52:16 INFO - Available Modes on Display 0 16:52:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:52:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:52:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:52:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:52:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:52:16 INFO - Intel Iris: 16:52:16 INFO - Chipset Model: Intel Iris 16:52:16 INFO - Type: GPU 16:52:16 INFO - Bus: Built-In 16:52:16 INFO - VRAM (Dynamic, Max): 1536 MB 16:52:16 INFO - Vendor: Intel (0x8086) 16:52:16 INFO - Device ID: 0x0a2e 16:52:16 INFO - Revision ID: 0x0009 16:52:16 INFO - Displays: 16:52:16 INFO - Display: 16:52:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:52:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:52:16 INFO - Display Serial Number: 1600x1200 60 16:52:16 INFO - Main Display: Yes 16:52:16 INFO - Mirror: Off 16:52:16 INFO - Online: Yes 16:52:16 INFO - Rotation: Supported 16:52:16 INFO - Return code: 0 16:52:16 INFO - Running post-action listener: _resource_record_post_action 16:52:16 INFO - Running post-run listener: _resource_record_post_run 16:52:17 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 36984320; Write bytes: 511304704; Read time: 395; Write time: 1745 16:52:17 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 203917824; Write bytes: 198756352; Read time: 17984; Write time: 418 16:52:17 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30584320; Write bytes: 302590976; Read time: 311; Write time: 1294 16:52:17 INFO - Running post-run listener: _upload_blobber_files 16:52:17 INFO - Blob upload gear active. 16:52:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:17 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 16:52:17 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'] 16:52:17 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 16:52:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:18 INFO - (blobuploader) - INFO - Done attempting. 16:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:19 INFO - (blobuploader) - INFO - Done attempting. 16:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:19 INFO - Return code: 0 16:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9bddbdfda3222b9dd66c5360c2a556656172684c8a9505bb5f1ea84c04a99db270585d03abd585eadc3519a9b7bacae9b03d4b250f0212d0d8ea2231a060932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/696785209fe67bc6cc638885502af2959bded3065b54c15ad4a0304371c32474b597e2bcf532fd71091b0da227313de4e24a2db1bae6d8820fb9a8db8d17646f"} 16:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:19 INFO - Contents: 16:52:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9bddbdfda3222b9dd66c5360c2a556656172684c8a9505bb5f1ea84c04a99db270585d03abd585eadc3519a9b7bacae9b03d4b250f0212d0d8ea2231a060932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/696785209fe67bc6cc638885502af2959bded3065b54c15ad4a0304371c32474b597e2bcf532fd71091b0da227313de4e24a2db1bae6d8820fb9a8db8d17646f"} 16:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:19 INFO - Copying logs to upload dir... 16:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.891679 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-04 16:52:19.944792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 16:52:19.948658) ========= 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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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/a9bddbdfda3222b9dd66c5360c2a556656172684c8a9505bb5f1ea84c04a99db270585d03abd585eadc3519a9b7bacae9b03d4b250f0212d0d8ea2231a060932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/696785209fe67bc6cc638885502af2959bded3065b54c15ad4a0304371c32474b597e2bcf532fd71091b0da227313de4e24a2db1bae6d8820fb9a8db8d17646f"} build_url:https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/O6q98FBsSoStHpFG4C__cQ/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/a9bddbdfda3222b9dd66c5360c2a556656172684c8a9505bb5f1ea84c04a99db270585d03abd585eadc3519a9b7bacae9b03d4b250f0212d0d8ea2231a060932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/696785209fe67bc6cc638885502af2959bded3065b54c15ad4a0304371c32474b597e2bcf532fd71091b0da227313de4e24a2db1bae6d8820fb9a8db8d17646f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 16:52:19.980601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 16:52:19.980931) ========= 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.GfDpdbIPoK/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.X4nRq6pkbM/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005236 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 16:52:20.030226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 16:52:20.030544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 16:52:20.030902) ========= ========= Total master_lag: 4.05 =========