builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1486765295.56 results: success (0) buildid: 20170210123454 builduid: 0a897735900642c38424569f77ecdfd7 revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.561249) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.561701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.561977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.590819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.591153) ========= 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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 --2017-02-10 14:21:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.6M=0s 2017-02-10 14:21:35 (72.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.723688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.724036) ========= 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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.025574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.775123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:35.778518) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4603dc332d7f1a384c5f4b39192e992f596a4c5b --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 4603dc332d7f1a384c5f4b39192e992f596a4c5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 2017-02-10 14:21:35,888 truncating revision to first 12 chars 2017-02-10 14:21:35,888 Setting DEBUG logging. 2017-02-10 14:21:35,889 attempt 1/10 2017-02-10 14:21:35,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4603dc332d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 14:21:36,577 unpacking tar archive at: mozilla-beta-4603dc332d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964995 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:36.771452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:36.771775) ========= script_repo_revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:36.772167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:36.772461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:21:36.790781) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-10 14:21:36.791051) ========= /tools/buildbot/bin/python -u 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', '-u', '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:21:36 INFO - MultiFileLogger online at 20170210 14:21:36 in /builds/slave/test 14:21:36 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 14:21:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:36 INFO - {'append_to_log': False, 14:21:36 INFO - 'base_work_dir': '/builds/slave/test', 14:21:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:21:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:36 INFO - 'branch': 'Mozilla-Beta', 14:21:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:36 INFO - 'config_files': ('talos/mac_config.py',), 14:21:36 INFO - 'default_actions': ('clobber', 14:21:36 INFO - 'read-buildbot-config', 14:21:36 INFO - 'download-and-extract', 14:21:36 INFO - 'populate-webroot', 14:21:36 INFO - 'create-virtualenv', 14:21:36 INFO - 'install', 14:21:36 INFO - 'run-tests'), 14:21:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:36 INFO - 'download_minidump_stackwalk': True, 14:21:36 INFO - 'download_symbols': 'ondemand', 14:21:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:36 INFO - 'installer_path': 'installer.exe', 14:21:36 INFO - 'log_level': 'info', 14:21:36 INFO - 'log_name': 'talos', 14:21:36 INFO - 'log_to_console': True, 14:21:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:21:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:21:36 INFO - 'opt_config_files': (), 14:21:36 INFO - 'pip_index': False, 14:21:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:36 INFO - 'cmd': ('bash', 14:21:36 INFO - '-c', 14:21:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:36 INFO - 'enabled': True, 14:21:36 INFO - 'halt_on_failure': False, 14:21:36 INFO - 'name': 'check_screen_resolution'},), 14:21:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:36 INFO - 'cmd': ('bash', 14:21:36 INFO - '-c', 14:21:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:36 INFO - 'enabled': True, 14:21:36 INFO - 'halt_on_failure': False, 14:21:36 INFO - 'name': 'check_screen_resolution'},), 14:21:36 INFO - 'run_cmd_checks_enabled': True, 14:21:36 INFO - 'sps_profile': False, 14:21:36 INFO - 'sps_profile_interval': 0, 14:21:36 INFO - 'suite': 'dromaeojs-e10s', 14:21:36 INFO - 'system_bits': '32', 14:21:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:36 INFO - 'title': 't-yosemite-r7-0220', 14:21:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:36 INFO - 'use_talos_json': True, 14:21:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:36 INFO - 'work_dir': 'build'} 14:21:36 INFO - [mozharness: 2017-02-10 22:21:36.993179Z] Running clobber step. 14:21:36 INFO - Running pre-action listener: _resource_record_pre_action 14:21:36 INFO - Running main action method: clobber 14:21:36 INFO - rmtree: /builds/slave/test/build 14:21:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:39 INFO - Running post-action listener: _resource_record_post_action 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.743279Z] Finished clobber step (success) 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.743434Z] Running read-buildbot-config step. 14:21:39 INFO - Running pre-action listener: _resource_record_pre_action 14:21:39 INFO - Running main action method: read_buildbot_config 14:21:39 INFO - Using buildbot properties: 14:21:39 INFO - { 14:21:39 INFO - "project": "", 14:21:39 INFO - "product": "firefox", 14:21:39 INFO - "script_repo_revision": "production", 14:21:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:21:39 INFO - "repository": "", 14:21:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:21:39 INFO - "buildid": "20170210123454", 14:21:39 INFO - "pgo_build": "False", 14:21:39 INFO - "basedir": "/builds/slave/test", 14:21:39 INFO - "buildnumber": 13, 14:21:39 INFO - "slavename": "t-yosemite-r7-0220", 14:21:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:21:39 INFO - "platform": "yosemite_r7", 14:21:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:21:39 INFO - "branch": "mozilla-beta", 14:21:39 INFO - "repo_path": "releases/mozilla-beta", 14:21:39 INFO - "revision": "4603dc332d7f1a384c5f4b39192e992f596a4c5b", 14:21:39 INFO - "stage_platform": "macosx64", 14:21:39 INFO - "builduid": "0a897735900642c38424569f77ecdfd7", 14:21:39 INFO - "slavebuilddir": "test" 14:21:39 INFO - } 14:21:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:21:39 INFO - Running post-action listener: _resource_record_post_action 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.746395Z] Finished read-buildbot-config step (success) 14:21:39 INFO - [mozharness: 2017-02-10 22:21:39.746505Z] Running download-and-extract step. 14:21:39 INFO - Running pre-action listener: _resource_record_pre_action 14:21:39 INFO - Running main action method: download_and_extract 14:21:39 INFO - mkdir: /builds/slave/test/build/tests 14:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:39 INFO - trying https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:21:39 INFO - Downloading https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:21:41 INFO - Downloaded 1165 bytes. 14:21:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:21:41 INFO - Using the following test package requirements: 14:21:41 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:21:41 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:21:41 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:21:41 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:21:41 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:21:41 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:21:41 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:21:41 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:21:41 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:21:41 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:21:41 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:21:41 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:21:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:21:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:41 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:21:41 INFO - Http code: 200 14:21:41 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 14:21:41 INFO - x-amz-cf-id: f1bBf9CZXH8kYhh-5s-FxRMjPjwfqWI_Npwx1rq_7c3X-SgAqJyANg== 14:21:41 INFO - x-amz-version-id: 2A45HoljFu9_OXTp2GrtsCeO8F4eqTzm 14:21:42 INFO - Expected file size: 16093627 14:21:42 INFO - Obtained file size: 16093627 14:21:48 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:21:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:21:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:48 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:21:49 INFO - Http code: 200 14:21:49 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 14:21:49 INFO - x-amz-cf-id: LNthCC8EJo5sIrr5NNvh-g8_TzQ-ptycKHvdT6XJxSsVeRkYKhcr3A== 14:21:49 INFO - x-amz-version-id: 2A45HoljFu9_OXTp2GrtsCeO8F4eqTzm 14:21:49 INFO - Expected file size: 16093627 14:21:49 INFO - Obtained file size: 16093627 14:21:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:21:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:21:55 INFO - Fetch https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:21:56 INFO - Http code: 200 14:21:56 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 14:21:56 INFO - x-amz-cf-id: 3Yu3YYaIjyzlOdsoBSDn-rU3503oOscm76B9KaSDoONY8Ud4-TRk1g== 14:21:56 INFO - x-amz-version-id: 9U4f7XjDwOpIb2Q8wJA2bSNBeLBZSEOo 14:21:56 INFO - Expected file size: 14403005 14:21:56 INFO - Obtained file size: 14403005 14:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:57 INFO - trying https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:21:57 INFO - Downloading https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:21:59 INFO - Downloaded 82129403 bytes. 14:21:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:21:59 INFO - mkdir: /builds/slave/test/properties 14:21:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:59 INFO - Contents: 14:21:59 INFO - build_url:https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:22:00 INFO - Running post-action listener: _resource_record_post_action 14:22:00 INFO - Running post-action listener: set_extra_try_arguments 14:22:00 INFO - [mozharness: 2017-02-10 22:22:00.359666Z] Finished download-and-extract step (success) 14:22:00 INFO - [mozharness: 2017-02-10 22:22:00.359824Z] Running populate-webroot step. 14:22:00 INFO - Running pre-action listener: _resource_record_pre_action 14:22:00 INFO - Running main action method: populate_webroot 14:22:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:22:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:22:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:22:00 INFO - '--tppagecycles', 14:22:00 INFO - '7'], 14:22:00 INFO - 'tests': ['tsvgm']}}, 14:22:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:22:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:22:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:22:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:22:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['damp', 'tps']}, 14:22:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'tests': ['damp', 'tps']}, 14:22:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['dromaeo_dom']}, 14:22:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['basic_compositor_video']}, 14:22:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:22:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'other-e10s': {'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['a11yr', 14:22:00 INFO - 'ts_paint', 14:22:00 INFO - 'tpaint', 14:22:00 INFO - 'sessionrestore', 14:22:00 INFO - 'sessionrestore_no_auto_restore', 14:22:00 INFO - 'tabpaint']}, 14:22:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['tsvgx', 14:22:00 INFO - 'tsvgr_opacity', 14:22:00 INFO - 'tart', 14:22:00 INFO - 'tscrollx', 14:22:00 INFO - 'cart']}, 14:22:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:22:00 INFO - 'tsvgr_opacity', 14:22:00 INFO - 'tart', 14:22:00 INFO - 'tscrollx', 14:22:00 INFO - 'cart']}, 14:22:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'talos_options': ['--disable-e10s'], 14:22:00 INFO - 'tests': ['tp5o']}, 14:22:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'tests': ['tp5o']}, 14:22:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'talos_options': ['--disable-e10s', 14:22:00 INFO - '--xperf_path', 14:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:00 INFO - 'tests': ['tp5n']}, 14:22:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:00 INFO - 'talos_options': ['--xperf_path', 14:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:00 INFO - 'tests': ['tp5n']}}, 14:22:00 INFO - 'talos.zip': {'path': '', 14:22:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:22:00 INFO - Running post-action listener: _resource_record_post_action 14:22:00 INFO - [mozharness: 2017-02-10 22:22:00.378400Z] Finished populate-webroot step (success) 14:22:00 INFO - [mozharness: 2017-02-10 22:22:00.378539Z] Running create-virtualenv step. 14:22:00 INFO - Running pre-action listener: _resource_record_pre_action 14:22:00 INFO - Running main action method: create_virtualenv 14:22:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:00 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 14:22:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:22:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:22:00 INFO - Using real prefix '/tools/python27' 14:22:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:22:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:22:04 INFO - Installing pip.................done. 14:22:04 INFO - Return code: 0 14:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:22:04 INFO - Reading from file tmpfile_stdout 14:22:04 INFO - Output received: 14:22:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:22:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:04 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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:04 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 14:22:04 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 14:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:04 INFO - 'HOME': '/Users/cltbld', 14:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:04 INFO - 'LOGNAME': 'cltbld', 14:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:04 INFO - 'MOZ_NO_REMOTE': '1', 14:22:04 INFO - 'NO_EM_RESTART': '1', 14:22:04 INFO - 'PAGER': '/bin/cat', 14:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:04 INFO - 'PWD': '/builds/slave/test', 14:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:04 INFO - 'SHELL': '/bin/bash', 14:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:04 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:04 INFO - 'USER': 'cltbld', 14:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:04 INFO - 'XPC_FLAGS': '0x0', 14:22:04 INFO - 'XPC_SERVICE_NAME': '0', 14:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:04 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 14:22:04 INFO - Cleaning up... 14:22:04 INFO - Return code: 0 14:22:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:04 INFO - 'HOME': '/Users/cltbld', 14:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:04 INFO - 'LOGNAME': 'cltbld', 14:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:04 INFO - 'MOZ_NO_REMOTE': '1', 14:22:04 INFO - 'NO_EM_RESTART': '1', 14:22:04 INFO - 'PAGER': '/bin/cat', 14:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:04 INFO - 'PWD': '/builds/slave/test', 14:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:04 INFO - 'SHELL': '/bin/bash', 14:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:04 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:04 INFO - 'USER': 'cltbld', 14:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:04 INFO - 'XPC_FLAGS': '0x0', 14:22:04 INFO - 'XPC_SERVICE_NAME': '0', 14:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:04 INFO - Downloading/unpacking psutil>=3.1.1 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:08 INFO - Installing collected packages: psutil 14:22:08 INFO - Running setup.py install for psutil 14:22:08 INFO - building 'psutil._psutil_osx' extension 14:22:08 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 14:22:08 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 14:22:09 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 14:22:09 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 14:22:09 INFO - building 'psutil._psutil_posix' extension 14:22:09 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 14:22:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:22:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:22:09 INFO - ^ 14:22:09 INFO - 1 warning generated. 14:22:09 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 14:22:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:09 INFO - Successfully installed psutil 14:22:09 INFO - Cleaning up... 14:22:09 INFO - Return code: 0 14:22:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:09 INFO - 'HOME': '/Users/cltbld', 14:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:09 INFO - 'LOGNAME': 'cltbld', 14:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:09 INFO - 'MOZ_NO_REMOTE': '1', 14:22:09 INFO - 'NO_EM_RESTART': '1', 14:22:09 INFO - 'PAGER': '/bin/cat', 14:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:09 INFO - 'PWD': '/builds/slave/test', 14:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:09 INFO - 'SHELL': '/bin/bash', 14:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:09 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:09 INFO - 'USER': 'cltbld', 14:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:09 INFO - 'XPC_FLAGS': '0x0', 14:22:09 INFO - 'XPC_SERVICE_NAME': '0', 14:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:12 INFO - Installing collected packages: mozsystemmonitor 14:22:12 INFO - Running setup.py install for mozsystemmonitor 14:22:12 INFO - Successfully installed mozsystemmonitor 14:22:12 INFO - Cleaning up... 14:22:12 INFO - Return code: 0 14:22:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:22:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:12 INFO - 'HOME': '/Users/cltbld', 14:22:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:12 INFO - 'LOGNAME': 'cltbld', 14:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:12 INFO - 'MOZ_NO_REMOTE': '1', 14:22:12 INFO - 'NO_EM_RESTART': '1', 14:22:12 INFO - 'PAGER': '/bin/cat', 14:22:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:12 INFO - 'PWD': '/builds/slave/test', 14:22:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:12 INFO - 'SHELL': '/bin/bash', 14:22:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:12 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:12 INFO - 'USER': 'cltbld', 14:22:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:12 INFO - 'XPC_FLAGS': '0x0', 14:22:12 INFO - 'XPC_SERVICE_NAME': '0', 14:22:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:13 INFO - Downloading/unpacking jsonschema==2.5.1 14:22:13 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 14:22:13 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 14:22:13 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 14:22:13 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 14:22:13 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 14:22:13 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 14:22:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:22:15 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 14:22:15 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 14:22:15 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 14:22:15 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 14:22:15 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 14:22:15 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 14:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:16 INFO - warning: no files found matching '*.txt' 14:22:16 INFO - no previously-included directories found matching 'build' 14:22:16 INFO - no previously-included directories found matching 'dist' 14:22:16 INFO - no previously-included directories found matching '.git*' 14:22:16 INFO - Installing collected packages: jsonschema, functools32 14:22:16 INFO - Running setup.py install for functools32 14:22:16 INFO - warning: no files found matching '*.txt' 14:22:16 INFO - no previously-included directories found matching 'build' 14:22:16 INFO - no previously-included directories found matching 'dist' 14:22:16 INFO - no previously-included directories found matching '.git*' 14:22:16 INFO - Successfully installed jsonschema functools32 14:22:16 INFO - Cleaning up... 14:22:16 INFO - Return code: 0 14:22:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:22: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 functools32==3.2.3-2 14:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:16 INFO - 'HOME': '/Users/cltbld', 14:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:16 INFO - 'LOGNAME': 'cltbld', 14:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:16 INFO - 'MOZ_NO_REMOTE': '1', 14:22:16 INFO - 'NO_EM_RESTART': '1', 14:22:16 INFO - 'PAGER': '/bin/cat', 14:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:16 INFO - 'PWD': '/builds/slave/test', 14:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:16 INFO - 'SHELL': '/bin/bash', 14:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:16 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:16 INFO - 'USER': 'cltbld', 14:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:16 INFO - 'XPC_FLAGS': '0x0', 14:22:16 INFO - 'XPC_SERVICE_NAME': '0', 14:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:22:16 INFO - Cleaning up... 14:22:16 INFO - Return code: 0 14:22:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', '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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:22: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 blobuploader==1.2.4 14:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:16 INFO - 'HOME': '/Users/cltbld', 14:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:16 INFO - 'LOGNAME': 'cltbld', 14:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:16 INFO - 'MOZ_NO_REMOTE': '1', 14:22:16 INFO - 'NO_EM_RESTART': '1', 14:22:16 INFO - 'PAGER': '/bin/cat', 14:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:16 INFO - 'PWD': '/builds/slave/test', 14:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:16 INFO - 'SHELL': '/bin/bash', 14:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:16 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:16 INFO - 'USER': 'cltbld', 14:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:16 INFO - 'XPC_FLAGS': '0x0', 14:22:16 INFO - 'XPC_SERVICE_NAME': '0', 14:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:20 INFO - Downloading docopt-0.6.1.tar.gz 14:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:20 INFO - Running setup.py install for blobuploader 14:22:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:21 INFO - Running setup.py install for requests 14:22:21 INFO - Running setup.py install for docopt 14:22:21 INFO - Successfully installed blobuploader requests docopt 14:22:21 INFO - Cleaning up... 14:22:21 INFO - Return code: 0 14:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:21 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 14:22:21 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 14:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:21 INFO - 'HOME': '/Users/cltbld', 14:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:21 INFO - 'LOGNAME': 'cltbld', 14:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:21 INFO - 'MOZ_NO_REMOTE': '1', 14:22:21 INFO - 'NO_EM_RESTART': '1', 14:22:21 INFO - 'PAGER': '/bin/cat', 14:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:21 INFO - 'PWD': '/builds/slave/test', 14:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:21 INFO - 'SHELL': '/bin/bash', 14:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:21 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:21 INFO - 'USER': 'cltbld', 14:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:21 INFO - 'XPC_FLAGS': '0x0', 14:22:21 INFO - 'XPC_SERVICE_NAME': '0', 14:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-W96z0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LCzGnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Gppgg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-fZQwoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2hbD2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xeEGlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RD4iVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ul3Ixr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-PhXDxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:22 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-u9odDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-kdQwuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vtf_Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Qam4s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-7zjU8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-W3qBWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MmnkaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:23 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Vf8Vqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:23 INFO - Running setup.py install for manifestparser 14:22:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:23 INFO - Running setup.py install for mozcrash 14:22:24 INFO - Running setup.py install for mozdebug 14:22:24 INFO - Running setup.py install for mozdevice 14:22:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Running setup.py install for mozfile 14:22:24 INFO - Running setup.py install for mozhttpd 14:22:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Running setup.py install for mozinfo 14:22:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Running setup.py install for mozInstall 14:22:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:24 INFO - Running setup.py install for mozleak 14:22:25 INFO - Running setup.py install for mozlog 14:22:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Running setup.py install for moznetwork 14:22:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Running setup.py install for mozprocess 14:22:25 INFO - Running setup.py install for mozprofile 14:22:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Running setup.py install for mozrunner 14:22:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:25 INFO - Running setup.py install for mozscreenshot 14:22:26 INFO - Running setup.py install for moztest 14:22:26 INFO - Running setup.py install for mozversion 14:22:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:26 INFO - Cleaning up... 14:22:26 INFO - Return code: 0 14:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:26 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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:26 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 14:22:26 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 14:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:26 INFO - 'HOME': '/Users/cltbld', 14:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:26 INFO - 'LOGNAME': 'cltbld', 14:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:26 INFO - 'MOZ_NO_REMOTE': '1', 14:22:26 INFO - 'NO_EM_RESTART': '1', 14:22:26 INFO - 'PAGER': '/bin/cat', 14:22:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:26 INFO - 'PWD': '/builds/slave/test', 14:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:26 INFO - 'SHELL': '/bin/bash', 14:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:26 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:26 INFO - 'USER': 'cltbld', 14:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:26 INFO - 'XPC_FLAGS': '0x0', 14:22:26 INFO - 'XPC_SERVICE_NAME': '0', 14:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KFwBGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:26 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)) 14:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xegzJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-f46yD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:26 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)) 14:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-rVJ9bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SSBZX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zq7bHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-DldnUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-EoMO_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZLkL59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mJ40Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-wqjrTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:27 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-jc03P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TRF59P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:28 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)) 14:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SKFmFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gwr4Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:28 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)) 14:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Tsmxui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9ciISR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:28 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)) 14:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:22:28 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)) 14:22:28 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)) 14:22:28 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)) 14:22:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:28 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 14:22:28 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 14:22:28 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 14:22:28 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 14:22:28 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 14:22:28 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 14:22:31 INFO - Downloading blessings-1.6.tar.gz 14:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:31 INFO - Installing collected packages: blessings 14:22:31 INFO - Running setup.py install for blessings 14:22:31 INFO - Successfully installed blessings 14:22:31 INFO - Cleaning up... 14:22:31 INFO - Return code: 0 14:22:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:32 INFO - Reading from file tmpfile_stdout 14:22:32 INFO - Current package versions: 14:22:32 INFO - blessings == 1.6 14:22:32 INFO - blobuploader == 1.2.4 14:22:32 INFO - docopt == 0.6.1 14:22:32 INFO - functools32 == 3.2.3-2 14:22:32 INFO - jsonschema == 2.5.1 14:22:32 INFO - manifestparser == 1.1 14:22:32 INFO - mozInstall == 1.12 14:22:32 INFO - mozcrash == 1.0 14:22:32 INFO - mozdebug == 0.1 14:22:32 INFO - mozdevice == 0.48 14:22:32 INFO - mozfile == 1.2 14:22:32 INFO - mozhttpd == 0.7 14:22:32 INFO - mozinfo == 0.9 14:22:32 INFO - mozleak == 0.1 14:22:32 INFO - mozlog == 3.4 14:22:32 INFO - moznetwork == 0.27 14:22:32 INFO - mozprocess == 0.23 14:22:32 INFO - mozprofile == 0.28 14:22:32 INFO - mozrunner == 6.13 14:22:32 INFO - mozscreenshot == 0.1 14:22:32 INFO - mozsystemmonitor == 0.3 14:22:32 INFO - moztest == 0.8 14:22:32 INFO - mozversion == 1.4 14:22:32 INFO - psutil == 3.1.1 14:22:32 INFO - requests == 1.2.3 14:22:32 INFO - wsgiref == 0.1.2 14:22:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:32 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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:32 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 14:22:32 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 14:22:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:32 INFO - 'HOME': '/Users/cltbld', 14:22:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:32 INFO - 'LOGNAME': 'cltbld', 14:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:32 INFO - 'MOZ_NO_REMOTE': '1', 14:22:32 INFO - 'NO_EM_RESTART': '1', 14:22:32 INFO - 'PAGER': '/bin/cat', 14:22:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:32 INFO - 'PWD': '/builds/slave/test', 14:22:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:32 INFO - 'SHELL': '/bin/bash', 14:22:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:32 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:32 INFO - 'USER': 'cltbld', 14:22:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:32 INFO - 'XPC_FLAGS': '0x0', 14:22:32 INFO - 'XPC_SERVICE_NAME': '0', 14:22:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 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)) 14:22:32 INFO - Cleaning up... 14:22:32 INFO - Return code: 0 14:22:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:32 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 0x10494f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa15b04b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, '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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 14:22:32 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 14:22:32 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 14:22:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:32 INFO - 'HOME': '/Users/cltbld', 14:22:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:32 INFO - 'LOGNAME': 'cltbld', 14:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:32 INFO - 'MOZ_NO_REMOTE': '1', 14:22:32 INFO - 'NO_EM_RESTART': '1', 14:22:32 INFO - 'PAGER': '/bin/cat', 14:22:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:32 INFO - 'PWD': '/builds/slave/test', 14:22:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:32 INFO - 'SHELL': '/bin/bash', 14:22:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:32 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:32 INFO - 'USER': 'cltbld', 14:22:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:32 INFO - 'XPC_FLAGS': '0x0', 14:22:32 INFO - 'XPC_SERVICE_NAME': '0', 14:22:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:32 INFO - Cleaning up... 14:22:32 INFO - Return code: 0 14:22:32 INFO - Running post-action listener: _resource_record_post_action 14:22:32 INFO - Running post-action listener: _start_resource_monitoring 14:22:33 INFO - Starting resource monitoring. 14:22:33 INFO - [mozharness: 2017-02-10 22:22:33.015223Z] Finished create-virtualenv step (success) 14:22:33 INFO - [mozharness: 2017-02-10 22:22:33.016170Z] Running install step. 14:22:33 INFO - Running pre-action listener: _resource_record_pre_action 14:22:33 INFO - Running main action method: install 14:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:33 INFO - Reading from file tmpfile_stdout 14:22:33 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:33 INFO - Reading from file tmpfile_stdout 14:22:33 INFO - Output received: 14:22:33 INFO - Usage: mozinstall [options] installer 14:22:33 INFO - Options: 14:22:33 INFO - -h, --help show this help message and exit 14:22:33 INFO - -d DEST, --destination=DEST 14:22:33 INFO - Directory to install application into. [default: 14:22:33 INFO - "/builds/slave/test"] 14:22:33 INFO - --app=APP Application being installed. [default: firefox] 14:22:33 INFO - mkdir: /builds/slave/test/build/application 14:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:54 INFO - Reading from file tmpfile_stdout 14:22:54 INFO - Output received: 14:22:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:22:54 INFO - Running post-action listener: _resource_record_post_action 14:22:54 INFO - [mozharness: 2017-02-10 22:22:54.721325Z] Finished install step (success) 14:22:54 INFO - [mozharness: 2017-02-10 22:22:54.721446Z] Running run-tests step. 14:22:54 INFO - Running pre-action listener: _resource_record_pre_action 14:22:54 INFO - Running main action method: run_tests 14:22:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:54 INFO - 2017-02-10 14:22:54.735 screenresolution[1623:7255] starting screenresolution argv=screenresolution get 14:22:54 INFO - 2017-02-10 14:22:54.738 screenresolution[1623:7255] Display 0: 1600x1200x32@60 14:22:54 INFO - 2017-02-10 14:22:54.744 screenresolution[1624:7258] starting screenresolution argv=screenresolution list 14:22:54 INFO - Available Modes on Display 0 14:22:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:54 INFO - Intel Iris: 14:22:54 INFO - Chipset Model: Intel Iris 14:22:54 INFO - Type: GPU 14:22:54 INFO - Bus: Built-In 14:22:54 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:54 INFO - Vendor: Intel (0x8086) 14:22:54 INFO - Device ID: 0x0a2e 14:22:54 INFO - Revision ID: 0x0009 14:22:54 INFO - Displays: 14:22:54 INFO - Display: 14:22:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:54 INFO - Display Serial Number: 1600x1200 60 14:22:54 INFO - Main Display: Yes 14:22:54 INFO - Mirror: Off 14:22:54 INFO - Online: Yes 14:22:54 INFO - Rotation: Supported 14:22:54 INFO - Return code: 0 14:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:54 INFO - Python 2.7.3 14:22:54 INFO - Return code: 0 14:22:54 INFO - grabbing minidump binary from tooltool 14:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104763d30>, '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 0x1045c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10475bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:22:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:22:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:55 INFO - Return code: 0 14:22:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 14:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 14:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MmRdU6d9Ae/Render', 14:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:55 INFO - 'HOME': '/Users/cltbld', 14:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:55 INFO - 'LOGNAME': 'cltbld', 14:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:55 INFO - 'MOZ_NO_REMOTE': '1', 14:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:55 INFO - 'NO_EM_RESTART': '1', 14:22:55 INFO - 'PAGER': '/bin/cat', 14:22:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:55 INFO - 'PWD': '/builds/slave/test', 14:22:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:55 INFO - 'SHELL': '/bin/bash', 14:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQjh5IcQAH/Listeners', 14:22:55 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:55 INFO - 'USER': 'cltbld', 14:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:55 INFO - 'XPC_FLAGS': '0x0', 14:22:55 INFO - 'XPC_SERVICE_NAME': '0', 14:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 14:22:55 INFO - mozversion application_buildid: 20170210123454 14:22:55 INFO - mozversion application_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:22:55 INFO - mozversion application_display_name: Firefox 14:22:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:55 INFO - mozversion application_name: Firefox 14:22:55 INFO - mozversion application_remotingname: firefox 14:22:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:55 INFO - mozversion application_vendor: Mozilla 14:22:55 INFO - mozversion application_version: 52.0 14:22:55 INFO - mozversion platform_buildid: 20170210123454 14:22:55 INFO - mozversion platform_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:22:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:55 INFO - mozversion platform_version: 52.0 14:22:55 INFO - using testdate: 1486765375 14:22:55 INFO - actual date: 1486765375 14:22:55 INFO - starting webserver on 'localhost:49241' 14:22:55 INFO - SUITE-START | Running 2 tests 14:22:55 INFO - TEST-START | dromaeo_css 14:22:55 INFO - operating with platform_type : mac_ 14:22:55 INFO - Initialising browser for dromaeo_css test... 14:22:55 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpsM48nP/profile http://localhost:49241/getInfo.html) 14:22:58 INFO - PROCESS | 1634 | 2017-02-10 14:22:58.618 plugin-container[1638:7452] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 14:22:58 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:58 INFO - PROCESS | 1634 | 2017-02-10 14:22:58.618 plugin-container[1638:7452] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 14:22:58 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:58 INFO - PROCESS | 1634 | 2017-02-10 14:22:58.618 plugin-container[1638:7452] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:22:58 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 14:22:58 INFO - PROCESS | 1634 | colorDepth:24 14:22:58 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 14:22:58 INFO - PROCESS | 1634 | __metrics 14:22:58 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:22:59 INFO - TEST-INFO | 1634: exit 0 14:22:59 INFO - Browser initialized. 14:22:59 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:59 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpsM48nP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:01 INFO - PROCESS | 1639 | 2017-02-10 14:23:01.938 plugin-container[1640:7584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 14:23:01 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:23:01 INFO - PROCESS | 1639 | 2017-02-10 14:23:01.939 plugin-container[1640:7584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8617, name = 'com.apple.CFPasteboardClient' 14:23:01 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:23:01 INFO - PROCESS | 1639 | 2017-02-10 14:23:01.939 plugin-container[1640:7584] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:23:11 INFO - PROCESS | 1639 | RSS: Main: 177033216 14:23:11 INFO - PROCESS | 1639 | 14:26:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:26:14 INFO - PROCESS | 1639 | RSS: Main: 183189504 14:26:14 INFO - PROCESS | 1639 | 14:29:16 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:29:17 INFO - PROCESS | 1639 | RSS: Main: 193490944 14:29:17 INFO - PROCESS | 1639 | 14:32:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 14:32:19 INFO - PROCESS | 1639 | RSS: Main: 198434816 14:32:19 INFO - PROCESS | 1639 | 14:35:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 14:35:22 INFO - PROCESS | 1639 | RSS: Main: 202522624 14:35:22 INFO - PROCESS | 1639 | 14:38:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 14:38:25 INFO - PROCESS | 1639 | RSS: Main: 203878400 14:38:25 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 14:41:28 INFO - PROCESS | 1639 | RSS: Main: 205361152 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | __start_tp_report 14:41:28 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 14:41:28 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 14:41:28 INFO - PROCESS | 1639 | |i|pagename|runs| 14:41:28 INFO - PROCESS | 1639 | |0;dojo.html;2987.3427845873925;3064.187990182602;3119.5320701894716;3673.3204357193913;3689.5203623528955;4937.234728617065;6016.969915150424;6059.303180134286;6078.939210607892;6086.026235802273;4963.205887058071;5438.592105592086;6022.217111775474;6130.8160755177305;6136.570440069197;4263.658907287425;5293.470652934714;5376.274202982596;5439.292891924044;5473.67157970521;5485.341758988927;5488.423715509874;5513.117901135819;5515.145152501349;5525.11598144297;5347.171188465774;5398.8920221595545;5494;5497.972510137443;5498.642588231772;5454.7272636368225;5458.099413596752;5489.204065410533;5501.614886957915;5544.16837474378;5332.146856502941;5420.783168673248;5444.727763611803;5470.5350045245805;5497.312835895513;6094.756209751605;6102.72537735803;6114;6176.351483094255;6198.969005154945;6207.906881396782;6210.192674952273;6211.720472578745;6256.593321434138;6272.56092073555;6334.429901308904;6357.300696923335;6360.0459931010255;6360.141380913564;6371.171747672773;6094.573379863411;6106.786262480836;6124.203853499106;6127.724252408652;6132.356102609251;6254.593451425642;6366.236051673829;6372.394622510854;6412.551121421549;6464.256610489854;6226.813195604049;6259.405356491126;6266.279377871603;6267.811965641038;6268.968655156695;6393.073004414334;6395.840103997344;6398.944174211296;6404.551681382259;6415.486761059104;5114.977004599095;6193.102000209944;6235.407636274546;6267.6866156692895;6275.058741188767;6190.566660333733;6208.4722798562625;6288.151099601495;6293.685315734195;6304.401081897304;5095.617828662865;5128.692278463304;5136.075506408883;5146.305248791366;5156.175011998137;4470.754108524063;4507.887302817456;4624.6993945394115;4636.559526844944;4640.2807564826835;4969.27945447908;5983.461488466059;6076.696165191723;6130.570860039755;6139.171211886338;6385.553011289165;6400.967995159995;6401.263854656681;6423.582467139621;6424.325445828121;6014.458698717136;6079.08813677943;6080.0575910733905;6144.907826382608;6162.907556386658;5654.802081927113;5662.348829884616;5669.234653321749;5674.375818659944;5713.2572765541045;6552.672366381662;6576.473882089422;6609.339066093352;6631.436327912182;6652.866942661217;5335.466453354634;5498.725063746717;6011.098335249748;6278.246610406781;6374.521910856612;6467.547271690936;6538.346165383424;6593.142891424084;6597.340265973365;6608.43828274602;6306.432421081941;6319.52603554726;6327.11420401135;6327.17746692927;6338.968305158444;5583.274174357308;6177.413145751147;6251.4061164189325;6398.488120950406;6404.583702059351;6164;6167.84580385476;6187.319394866471;6211.130441738251;6213.378662133931;6209.441150296495;6226.688665566794;6231.065340198825;6231.75072997075;6234.719437625408;4936;6090.573659843945;6118.235220597426;6162.137300777984;6177.567570270217;5191.377034755854;6130.703893785035;6173.876522469615;6192.473639740672;6238.970569855923;5103.260027296095;6003.309619393825;6097.939020609737;6129.908051379144;6131.080337949344 14:41:28 INFO - PROCESS | 1639 | |1;ext.html;495.81654787728525;531.3544043986556;537.9704116273606;543.0388212863235;544.8665077056121;33087;34986;40567.39148912765;40676.59323406769;42314.57685423145;42078.57921420785;42478;42553;42609.93475163123;42651.57348426515;9527.80944381112;9561.952190239073;9653.662121825737;9697.515124243795;9709.368891022097;9553.187979021792;9643.987381324965;9659.90340096597;9691.273154513405;9741;9633.807323853518;9713.902860971406;9751.073648003428;9776.217902567778;9804.705858824247;9601.135897769234;9641.084097010773;9681.951590242074;9708.174805141502;9715.174210192143;9509.429434233969;9519.857202141973;9578;9658.082482164184;9704.70885873425;38827.22345553073;38848.61151388478;38920.41619375712;39398.60601393978;39421.40867886984;2675.719049499794;3369.7304215662934;3390.423627983249;3397.9830100849586;3406.9659303406897;25139.748602513922;27898.581521277196;29124.98062567821;29755.256118597208;30235.546466803014;3293.176705823544;3326.6673332666783;3332.600087989457;3447.3622379859808;3471.704905083071;476922;478227;479301;481806;482757;61162.694186529676;61442.692786536674;61493.69253153705;61648.38351616516;61796.382036179064;63068.68465657642;63344.683276583324;63943.680281598296;64310.356896431374;64388.034179487346;16326.183690815411;16488.83511164897;16829;16861.662766744597;16977.830221697874;12608.054395920342;13005.154664946747;13006.544770932973;13042.673933151747;13044.869551304555;17340.393086241922;17548.29806807739;17594.824051759573;17621.295148194185;17671.911640441973;7406.629668516553;7413.518121322097;7451.105867295959;7503.124218945263;7596.734114305973;925.7454200095028;999.9050090241416;1066.7226521104415;1087.9609972476267;1093.9671809845718;26227.73772262253;30493.501319655308;30507.55939524833;30794;30808.92168774082;1046.1578429364436;1071.989280107189;1097.928634638746;1108.4845546820768;1179.0390831472323;13051.21692698441;15361;15571.532854014398;15699.607509812346;15989.360425582847;173124;667518;884696;885941;886090;58833.70583147142;59071;59340;59505.40494595085;59587;1263.879931406515;1355.9186448813102;1408.0917808013774;1436.6480212348042;1439.8848092152602;26239.868800655873;28255.57616635711;31496.527552087195;31624.683753162175;31725.841370792998;50682.49317506778;55980.16029759475;56674;57105;59850;564034;566756;570987;572107;572436;26601.733982659927;26663.33341666396;27023.054193103148;27129.321766955985;27175.592366114128;46696.766516167205;46831.76584117058;47506.28740568825;47726.52273477221;48232.276515852995;34766.82616586901;37925;38217.23565528618;39045;39180.41229381505;38596.80701596474;38874.61125388823;39266;39353.40969885511;39648.60351396449;37298;38157;38286;38695.6130438692;39380.40929386119;28060.45667488226;30941.226469338446;35100.473492897116;35166.82416587901;35302.29395412129;25670.61494077628;25908.8704556476;25950.740492594832;26013.349666258495;26401.60397594076 14:41:28 INFO - PROCESS | 1639 | |2;jquery.html;376.7965298738681;384.40801166204045;390.7655406755949;391.27613914258626;406.13087991697773;18750.2499900004;20107.497312567157;20387.388378348674;20457.386278411654;20721.06755196016;19267.03664816757;19279.518012049706;19751;20508.384748457534;20804;5848.152017957394;5905.379935106816;6080.817575472743;6103.725332360033;6151.108089327045;5879.265091863517;5896.38088000758;5921.73352199152;5955.851103722398;6025.397460253984;4705.764711764416;5971.611845230068;6022.367651396584;6075.270967483908;6145.907811382833;5878.706064696748;5972.880542389128;6093.664848433335;6104.3590423005835;6142.907856382158;5750.913736293959;5835.0372188588835;5887.587868849182;5903.026000709878;5916.290045194562;13078.280694561796;13162;13304.467821287137;13336.799948000787;13470.595882123553;2064.4013236161495;2245.1692873636694;2276.2943487518924;2493.364192131013;2668.6931002934716;9718.805623887483;9773.397245651742;10148.1374083203;10225.028622280872;10229.795404091876;1571.285065295288;1605.3177399605122;1818.1182126668555;1847.6304739052243;1879.577095153593;119072;124042.37978810139;126796;128540.35729821384;129351.35324323412;9258.444493330288;11190.776184476264;11826.704332391759;11901.10741694359;11936.28382297065;14500.927495362666;14508.709825803426;14755.55733328002;14949.775753363709;15085.396584136732;8500.914990850013;8721;8731.738047858575;8751.956240218758;8893.377463577488;8728.869066964;8748.737537873874;8768.736937891874;8872.556372181494;8877.467351958903;4041.6968727345566;4416.072624748838;4583.243764778774;4583.243764778774;4710.9764451177525;1734.9913250433667;1938.3215874444113;1955.6284305981817;2019.4648418169197;2029.553498230387;901.8872640919885;934.7195841247599;994.751312171957;1007.4106647611083;1011.0647650922867;16299.185040747916;19863.246156917492;20261;20776.065077071267;21086.05112769929;935.6444551070686;946.7349142240183;956.7799406136488;990.4849478271259;1042.9634962776267;10618.946905265424;11018.834717479243;11044.944775276072;11120.943510366502;11142;591143;594628;596607.0169649124;605724;608412;132683.3365833184;136877.3156134213;141098;142139;144536.5546344544;1002.5187909803335;1002.7743757654615;1011.858339832424;1020.9948950255201;1030.07808011829;14767.187804670846;17832.19755110997;18625.53436164107;18747.718784217974;19161.90419047896;53346.73326633497;54253.45746542484;54501;54681.63295917634;55391.72304138453;75969.62015189888;76474;79180.60409697915;79813.60093199497;80130;7948.483348582324;8123.309518690978;8177.4684645497855;8305.792355191168;8372.120927302789;10752;12532.310722909962;12837.743245135232;13060.08579399471;13110.147840390344;5575.247341608993;9142.680006199751;9369.953150234478;10389.324693894872;10876.23866329381;9105.317101217568;10220.693379198636;10459.790804184026;11036.392998384845;11088.501017454395;6484.870302593828;10848.783024339627;10873.401962892116;10909.236353455182;11150.386728729673;7957.880631790412;7993.600319984093;8116.959415202886;8230.135835737401;8247.711330103417;9157.633694652139;9265.212456940966;10650.307729997525;10945.890541094806;11150.275232109887 14:41:28 INFO - PROCESS | 1639 | |3;mootools.html;1457.8847181905844;1489.9851001489985;1512.1229686781667;1826.8081851405593;1852.1665250637209;7661.693532258703;7914.525128492294;8134.959325203373;8566.914330856689;8568.785780355494;8022.839543209132;8321.916780832189;8348.039975402831;8470.576471176448;8485.830283394329;2373.133806160756;2405.398650337416;2406.4224586099385;2412.4089598048504;2429.647701083342;2200.801927826495;2261.208576998054;2372.1578839511985;2413.7344892061947;2420.261820144855;1958.637652034371;2337.6610391493223;2378.3221781792195;2378.4172877644914;2387.1883559589737;2276.2488378834946;2314.837961342707;2341.5785158671433;2341.789238968501;2373.7181921762312;2153.6231159547174;2272.6023495550285;2369.7867191952805;2401.891914863835;2420.334408037786;6846.623435711034;7194.460415468809;8383.790405239857;8435.95782021092;8437.493750374997;5041.546260836506;5130.51260130287;5224.582033437316;5280.260763493114;5294.179402192666;3388.373150967079;3477.5826900771817;3600.117971097098;3607.603163651996;3631.6186800385844;1052.7787766191182;1055.2824079625852;1105.745678493951;1113.4321496036998;1118.0440723181725;9150.86273705895;9685.886123095794;10769.946150269277;10876.945615271952;10969.012788849042;4470.173017991682;4610.907781844345;4698.201305778026;4711.95288047122;4715.622750180046;7895.644695988694;9275.768105797275;9295.860562091573;9327.486988215713;9344.859827102599;5190.403103643054;5217.34783152106;5220.425753167148;5223.059849227176;5229.398619158846;4366.235908715962;4418.734875907456;4812.278158276286;4831.26074613139;4873.171560834667;3245.8701651933657;3870.3420418528917;3899.66852817508;3925.6270654287796;3963.4451176835264;1096.4188979840696;1280.4622058735354;1282.0512820512754;1292.8254685617321;1312.7112035352206;823.9340852731887;843.7976880342302;887.9378443509022;907.4373888189365;919.5632074764434;5621;5656.8868622627315;5671.886562268732;5704.458076482728;5763.7982670606325;791.9406044546682;949.1125797379473;957.7940742740344;976.5410257179115;1008.6721815410021;3687.778733276012;3694.612065733113;3747.6439738224826;3756.286305601927;3787.2046870157023;9908.950455247821;9982;10114.88736239013;10170.186385089175;10262.794744105076;9921.751956201007;9931.255155863339;10234.948825255826;10235.948820256;10274.948625256826;7848.489848159851;7848.921510784933;7891.842163156704;7922.049354077432;8030.116687164407;4387.407699960592;5375.892482150413;5496.972515137399;5513.862153446035;5541.722913854372;9221.86167207479;9246.398984066014;9343.672971445967;9413.52932353366;9480.336376453582;9399.718008459757;9519.428834269966;9606.991265916979;9654.27592930519;9706.563204655666;6282.340354262737;6486.6756662167645;6586.1438013058;6706.329367063449;6849.212340580897;7805.219478052377;7896.763097107096;7908.8813667793875;7910.446268761131;8003.759887203393;7062.576245425291;7200.603966781668;7232.385247254042;7248.202697703354;7312.96343518279;5933.436323549256;7043.119610048744;7055.858882822212;7089.397401220954;7153.248908864494;6675.265720770809;6691.397774200151;6713.865722685617;6746.797596072126;6753.392194702304;4752.643551733565;4771.95228047715;4794.520547945178;4796.8081276748535;4802.207635740064;4700.741459219776;4714.905701886011;4760.9047819042735;4876.5854902333695;4932.358793356841 14:41:28 INFO - PROCESS | 1639 | |4;prototype.html;306.80517871151824;310.27550669187445;316.96196456425224;319.6499832683211;320.9903702888914;4371.16947779922;5374.48942350476;5396.10964190909;5491.890162196753;5558.583106267026;5185.988732197223;5420.349558053029;5444.346678398588;5457.536109430703;5458.372287186975;3408.36945165144;4188.28280405034;4189.2040512302565;4190.476190476191;4216.957830421703;3808.038859987095;3875.9728671901967;3890.0160917931917;4119.691023173259;4204.663626909855;3591.9346375834;4073.5111786585653;4104.733192342503;4118.073433477473;4143.854965076223;3268.7548433867437;3392.185875389901;3889.6517288728;4114.897127571805;4136.276151673445;2799.510085734988;3153.30627262002;3262.890617190143;3597.892063238081;3631.1314061891076;4264.571368591525;4521.909561808779;4626.791794369262;5098.470458862364;5368.8389348319615;4674.672772905898;4677.508861569554;4683.88290292742;4705.294205869147;4706.9764651176865;5393.494228751343;5709.600327977043;5713.542916566665;5726.255586773693;5737.512311453532;3706.314331848617;3783.356829339019;3928.017995501125;3937.88186354407;3953.3476976298875;5933.021051526493;5958.34458209601;5995.460408563206;6006.939930600725;6015.105241848803;3311.7516186285643;3319.8838040668943;3960.5841386653988;3976.562578116405;3994.2211268802885;3908.3160446921675;3953.240807840541;3973.940390894139;4076.6331030207425;4096.112240870179;4631.276098379702;4636.148768507343;4643.930341044887;4660.976695116503;4681.414823147106;5087.516685914832;5421.722876391925;5791.594588378773;5794.391588883191;5804.303483581913;1011.2567263061644;1187.6674531131298;1276.789329760579;1279.9680007999689;1292.4636275945377;806.2904643913319;808.6846130009301;880.194621920948;891.3760367742606;895.5208963204655;5089.236614507779;5107.182850743863;5111.821086261963;5115.5396014358885;5124.5131712487255;4481.596656300949;4583.610393116555;5463.890722185613;5558.972205138948;5628.971855140698;4531.43357080365;4996.7501624918605;5010.649254552146;5071.54356107952;5110.514501122388;2612.725663805311;2971;2986.5813738474485;2993.5958645583005;3021.7582593392917;5136.223312319578;5640.492355688008;5916.792912248051;5943.009091954244;6020.638761674313;4814.9518504815205;5837.503812176013;5852.736626851802;5945;5956.374580668968;5017.523335283142;5388;5924.815036992705;5938.465538101505;5954.76180952757;4769.9046019080115;5065.303123453685;5561.6384934980715;5642.858928526655;5726.828195154152;4618.584327410549;4812.663113582015;5254.816081437131;5624.775008999758;5664.886702265849;5947.762089516371;5949.375315591974;5970;5981.252343457068;5982.141518720314;3198.8080715157166;3545.2200515886466;3749.8937813345674;3756.7182461314965;3778.6599206071587;4862.027594481047;4982.925256121089;5581.748821303132;5725.7137143141845;5770;5070.898582028265;5611.270534830446;5694.327158982516;5807.361190268983;5850.1626711044255;5456.890862182813;5781.277340332458;5787.334456537552;5791.971040144772;5795.406263277632;4823.986962737864;4885.8045678172475;4999.375078115236;5074.5686616637995;5668.546516278605;4744.9051018978735;5812.01195796724;5819.624617721796;5829.970850145722;5831.562632802472;4448.64410847125;4680.391549098732;5683.299129679225;5706.9714651426475;5717.256756621613 14:41:28 INFO - PROCESS | 1639 | |5;yui.html;712.4336152758557;716.4626530102423;727.181920339618;742.951708138971;772.1313522287427;14297.571072867817;14712.779308310384;15122.319495622696;15148.469803556878;15205.543833684993;13622.795658065137;13639.45442182314;13640.727185456284;13649.590512284623;13730.244836533986;695.5235663570458;717.5336031579463;829.8215883585028;853.5561508015859;873.8776571280026;851.221132663612;856.2935578148052;861.9051904290523;865.3164000439646;866.1684782608703;884.1732979664002;884.9734507964771;893.13366034946;915.0849150849151;920.2683866326253;879.8548239540501;888.9822203555892;891.2869704236617;917.3761841947473;917.8990311065777;653.7123665587127;654.290095246658;655.9180102487189;675.0684056002685;680.8502129531495;13810.792838107336;13858.514951976633;13872.375743091585;14345.067570607876;14635.560933172022;12326.5069397224;12649.430775615027;12803.295818729966;14388.928055359656;14555.563333100024;11735.23720958135;11746.882531174664;11849.822252666218;11954.641360759191;11989;4506.233940230169;4533.569310915458;4568.428946381702;4584.358189853423;4717.410323709536;91089.54455227748;93510;93975.53012234964;94104.58843117359;94605;8711.303095752324;9942.850857237147;10511.421871797125;10609.9469502652;10619.681409557727;19333.806661933482;19450.319238826574;19799.40601781949;20048.498787530138;20084.497887552927;7742.436151267021;7755.2632499912415;7772.18392068836;7823.843523129505;7852.882206766903;4229.302165142717;4319.568043195655;4338.566143385699;4354.608085272277;4390.407295015196;3225.9838700806345;3286.7206287465356;3297.1592243977634;3395.864165433355;3406.8977930662118;528.4161002092633;534.1240365800091;543.499980018384;636.1539152926597;640.7565125252374;573.4809996952764;585.9062549992066;599.5623195067625;602.6384169498266;614.6097228259997;8384.622691978753;8501.489910605384;8590.613422396007;8669.393142479967;8856.202941735275;506.5289280968661;521.3639359980817;551.5642642312528;586.1500823805499;617.2038070888503;3585.3367127081574;4121.9587804121575;4233.618974292329;4261.552536983634;4276.8289268429535;120687;121060;122088;122990;124793;101196;104330;106090.46954765331;106332.46833765936;107721;83936.58031709802;85034;86160;86632;87298.12701873027;6908.5509441886115;7726.2296717550535;8008.078061265371;8120.512769233865;8285.295749861329;44158.77920610376;53348.19977700415;54205.45794542004;54630.45369546254;57164;72571.63714181607;75349.62325188339;76193;81785.59107204426;82260;10694.679159625224;10743.570257189625;10789.838152427563;10850.945745271223;11141.2201145919;11700.122490813053;11819.645410637695;11870.584529541424;11892.456018288372;11931.058392353167;10880.564777408816;10918.399488028235;10991.175661825235;11049.39228342449;11478.82781758291;10872.635410657897;11025.724356891142;11083.168762343017;11202.887971120184;11326.83009754871;10556.419396933243;10633.89366106329;10777.083947864206;10973.341599504056;11466.369349685847;9314.534273286445;9471.526423678926;9597.47213903242;9636.373635713657;9910.86809976798;9111.681091161778;9480.146786789222;9480.241580673392;9502.857457138287;9621.941586425348 14:41:28 INFO - PROCESS | 1639 | __end_tp_report 14:41:28 INFO - PROCESS | 1639 | __start_cc_report 14:41:28 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,362 14:41:28 INFO - PROCESS | 1639 | __end_cc_report 14:41:28 INFO - PROCESS | 1639 | __startTimestamp1486766488351__endTimestamp 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | ------- Summary: start ------- 14:41:28 INFO - PROCESS | 1639 | Number of tests: 6 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5865.63 Median:6131.08 stddev:680.93 (11.1%) stddev-sans-first:644.49 14:41:28 INFO - PROCESS | 1639 | Values: 2987.3 3064.2 3119.5 3673.3 3689.5 4937.2 6017.0 6059.3 6078.9 6086.0 4963.2 5438.6 6022.2 6130.8 6136.6 4263.7 5293.5 5376.3 5439.3 5473.7 5485.3 5488.4 5513.1 5515.1 5525.1 5347.2 5398.9 5494.0 5498.0 5498.6 5454.7 5458.1 5489.2 5501.6 5544.2 5332.1 5420.8 5444.7 5470.5 5497.3 6094.8 6102.7 6114.0 6176.4 6199.0 6207.9 6210.2 6211.7 6256.6 6272.6 6334.4 6357.3 6360.0 6360.1 6371.2 6094.6 6106.8 6124.2 6127.7 6132.4 6254.6 6366.2 6372.4 6412.6 6464.3 6226.8 6259.4 6266.3 6267.8 6269.0 6393.1 6395.8 6398.9 6404.6 6415.5 5115.0 6193.1 6235.4 6267.7 6275.1 6190.6 6208.5 6288.2 6293.7 6304.4 5095.6 5128.7 5136.1 5146.3 5156.2 4470.8 4507.9 4624.7 4636.6 4640.3 4969.3 5983.5 6076.7 6130.6 6139.2 6385.6 6401.0 6401.3 6423.6 6424.3 6014.5 6079.1 6080.1 6144.9 6162.9 5654.8 5662.3 5669.2 5674.4 5713.3 6552.7 6576.5 6609.3 6631.4 6652.9 5335.5 5498.7 6011.1 6278.2 6374.5 6467.5 6538.3 6593.1 6597.3 6608.4 6306.4 6319.5 6327.1 6327.2 6339.0 5583.3 6177.4 6251.4 6398.5 6404.6 6164.0 6167.8 6187.3 6211.1 6213.4 6209.4 6226.7 6231.1 6231.8 6234.7 4936.0 6090.6 6118.2 6162.1 6177.6 5191.4 6130.7 6173.9 6192.5 6239.0 5103.3 6003.3 6097.9 6129.9 6131.1 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:71512.60 Median:39309.70 stddev:164476.59 (418.4%) stddev-sans-first:164851.56 14:41:28 INFO - PROCESS | 1639 | Values: 495.8 531.4 538.0 543.0 544.9 33087.0 34986.0 40567.4 40676.6 42314.6 42078.6 42478.0 42553.0 42609.9 42651.6 9527.8 9562.0 9653.7 9697.5 9709.4 9553.2 9644.0 9659.9 9691.3 9741.0 9633.8 9713.9 9751.1 9776.2 9804.7 9601.1 9641.1 9682.0 9708.2 9715.2 9509.4 9519.9 9578.0 9658.1 9704.7 38827.2 38848.6 38920.4 39398.6 39421.4 2675.7 3369.7 3390.4 3398.0 3407.0 25139.7 27898.6 29125.0 29755.3 30235.5 3293.2 3326.7 3332.6 3447.4 3471.7 476922.0 478227.0 479301.0 481806.0 482757.0 61162.7 61442.7 61493.7 61648.4 61796.4 63068.7 63344.7 63943.7 64310.4 64388.0 16326.2 16488.8 16829.0 16861.7 16977.8 12608.1 13005.2 13006.5 13042.7 13044.9 17340.4 17548.3 17594.8 17621.3 17671.9 7406.6 7413.5 7451.1 7503.1 7596.7 925.7 999.9 1066.7 1088.0 1094.0 26227.7 30493.5 30507.6 30794.0 30808.9 1046.2 1072.0 1097.9 1108.5 1179.0 13051.2 15361.0 15571.5 15699.6 15989.4 173124.0 667518.0 884696.0 885941.0 886090.0 58833.7 59071.0 59340.0 59505.4 59587.0 1263.9 1355.9 1408.1 1436.6 1439.9 26239.9 28255.6 31496.5 31624.7 31725.8 50682.5 55980.2 56674.0 57105.0 59850.0 564034.0 566756.0 570987.0 572107.0 572436.0 26601.7 26663.3 27023.1 27129.3 27175.6 46696.8 46831.8 47506.3 47726.5 48232.3 34766.8 37925.0 38217.2 39045.0 39180.4 38596.8 38874.6 39266.0 39353.4 39648.6 37298.0 38157.0 38286.0 38695.6 39380.4 28060.5 30941.2 35100.5 35166.8 35302.3 25670.6 25908.9 25950.7 26013.3 26401.6 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35120.06 Median:2384.83 stddev:100621.39 (4219.2%) stddev-sans-first:100869.84 14:41:28 INFO - PROCESS | 1639 | Values: 376.8 384.4 390.8 391.3 406.1 18750.2 20107.5 20387.4 20457.4 20721.1 19267.0 19279.5 19751.0 20508.4 20804.0 5848.2 5905.4 6080.8 6103.7 6151.1 5879.3 5896.4 5921.7 5955.9 6025.4 4705.8 5971.6 6022.4 6075.3 6145.9 5878.7 5972.9 6093.7 6104.4 6142.9 5750.9 5835.0 5887.6 5903.0 5916.3 13078.3 13162.0 13304.5 13336.8 13470.6 2064.4 2245.2 2276.3 2493.4 2668.7 9718.8 9773.4 10148.1 10225.0 10229.8 1571.3 1605.3 1818.1 1847.6 1879.6 119072.0 124042.4 126796.0 128540.4 129351.4 9258.4 11190.8 11826.7 11901.1 11936.3 14500.9 14508.7 14755.6 14949.8 15085.4 8500.9 8721.0 8731.7 8752.0 8893.4 8728.9 8748.7 8768.7 8872.6 8877.5 4041.7 4416.1 4583.2 4583.2 4711.0 1735.0 1938.3 1955.6 2019.5 2029.6 901.9 934.7 994.8 1007.4 1011.1 16299.2 19863.2 20261.0 20776.1 21086.1 935.6 946.7 956.8 990.5 1043.0 10618.9 11018.8 11044.9 11120.9 11142.0 591143.0 594628.0 596607.0 605724.0 608412.0 132683.3 136877.3 141098.0 142139.0 144536.6 1002.5 1002.8 1011.9 1021.0 1030.1 14767.2 17832.2 18625.5 18747.7 19161.9 53346.7 54253.5 54501.0 54681.6 55391.7 75969.6 76474.0 79180.6 79813.6 80130.0 7948.5 8123.3 8177.5 8305.8 8372.1 10752.0 12532.3 12837.7 13060.1 13110.1 5575.2 9142.7 9370.0 10389.3 10876.2 9105.3 10220.7 10459.8 11036.4 11088.5 6484.9 10848.8 10873.4 10909.2 11150.4 7957.9 7993.6 8117.0 8230.1 8247.7 9157.6 9265.2 10650.3 10945.9 11150.3 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5409.48 Median:5221.74 stddev:2934.16 (56.2%) stddev-sans-first:2927.37 14:41:28 INFO - PROCESS | 1639 | Values: 1457.9 1490.0 1512.1 1826.8 1852.2 7661.7 7914.5 8135.0 8566.9 8568.8 8022.8 8321.9 8348.0 8470.6 8485.8 2373.1 2405.4 2406.4 2412.4 2429.6 2200.8 2261.2 2372.2 2413.7 2420.3 1958.6 2337.7 2378.3 2378.4 2387.2 2276.2 2314.8 2341.6 2341.8 2373.7 2153.6 2272.6 2369.8 2401.9 2420.3 6846.6 7194.5 8383.8 8436.0 8437.5 5041.5 5130.5 5224.6 5280.3 5294.2 3388.4 3477.6 3600.1 3607.6 3631.6 1052.8 1055.3 1105.7 1113.4 1118.0 9150.9 9685.9 10769.9 10876.9 10969.0 4470.2 4610.9 4698.2 4712.0 4715.6 7895.6 9275.8 9295.9 9327.5 9344.9 5190.4 5217.3 5220.4 5223.1 5229.4 4366.2 4418.7 4812.3 4831.3 4873.2 3245.9 3870.3 3899.7 3925.6 3963.4 1096.4 1280.5 1282.1 1292.8 1312.7 823.9 843.8 887.9 907.4 919.6 5621.0 5656.9 5671.9 5704.5 5763.8 791.9 949.1 957.8 976.5 1008.7 3687.8 3694.6 3747.6 3756.3 3787.2 9909.0 9982.0 10114.9 10170.2 10262.8 9921.8 9931.3 10234.9 10235.9 10274.9 7848.5 7848.9 7891.8 7922.0 8030.1 4387.4 5375.9 5497.0 5513.9 5541.7 9221.9 9246.4 9343.7 9413.5 9480.3 9399.7 9519.4 9607.0 9654.3 9706.6 6282.3 6486.7 6586.1 6706.3 6849.2 7805.2 7896.8 7908.9 7910.4 8003.8 7062.6 7200.6 7232.4 7248.2 7313.0 5933.4 7043.1 7055.9 7089.4 7153.2 6675.3 6691.4 6713.9 6746.8 6753.4 4752.6 4772.0 4794.5 4796.8 4802.2 4700.7 4714.9 4760.9 4876.6 4932.4 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4526.35 Median:5014.09 stddev:1420.56 (28.3%) stddev-sans-first:1388.79 14:41:28 INFO - PROCESS | 1639 | Values: 306.8 310.3 317.0 319.6 321.0 4371.2 5374.5 5396.1 5491.9 5558.6 5186.0 5420.3 5444.3 5457.5 5458.4 3408.4 4188.3 4189.2 4190.5 4217.0 3808.0 3876.0 3890.0 4119.7 4204.7 3591.9 4073.5 4104.7 4118.1 4143.9 3268.8 3392.2 3889.7 4114.9 4136.3 2799.5 3153.3 3262.9 3597.9 3631.1 4264.6 4521.9 4626.8 5098.5 5368.8 4674.7 4677.5 4683.9 4705.3 4707.0 5393.5 5709.6 5713.5 5726.3 5737.5 3706.3 3783.4 3928.0 3937.9 3953.3 5933.0 5958.3 5995.5 6006.9 6015.1 3311.8 3319.9 3960.6 3976.6 3994.2 3908.3 3953.2 3973.9 4076.6 4096.1 4631.3 4636.1 4643.9 4661.0 4681.4 5087.5 5421.7 5791.6 5794.4 5804.3 1011.3 1187.7 1276.8 1280.0 1292.5 806.3 808.7 880.2 891.4 895.5 5089.2 5107.2 5111.8 5115.5 5124.5 4481.6 4583.6 5463.9 5559.0 5629.0 4531.4 4996.8 5010.6 5071.5 5110.5 2612.7 2971.0 2986.6 2993.6 3021.8 5136.2 5640.5 5916.8 5943.0 6020.6 4815.0 5837.5 5852.7 5945.0 5956.4 5017.5 5388.0 5924.8 5938.5 5954.8 4769.9 5065.3 5561.6 5642.9 5726.8 4618.6 4812.7 5254.8 5624.8 5664.9 5947.8 5949.4 5970.0 5981.3 5982.1 3198.8 3545.2 3749.9 3756.7 3778.7 4862.0 4982.9 5581.7 5725.7 5770.0 5070.9 5611.3 5694.3 5807.4 5850.2 5456.9 5781.3 5787.3 5792.0 5795.4 4824.0 4885.8 4999.4 5074.6 5668.5 4744.9 5812.0 5819.6 5830.0 5831.6 4448.6 4680.4 5683.3 5707.0 5717.3 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21016.84 Median:524.89 stddev:32387.30 (6170.3%) stddev-sans-first:32442.27 14:41:28 INFO - PROCESS | 1639 | Values: 712.4 716.5 727.2 743.0 772.1 14297.6 14712.8 15122.3 15148.5 15205.5 13622.8 13639.5 13640.7 13649.6 13730.2 695.5 717.5 829.8 853.6 873.9 851.2 856.3 861.9 865.3 866.2 884.2 885.0 893.1 915.1 920.3 879.9 889.0 891.3 917.4 917.9 653.7 654.3 655.9 675.1 680.9 13810.8 13858.5 13872.4 14345.1 14635.6 12326.5 12649.4 12803.3 14388.9 14555.6 11735.2 11746.9 11849.8 11954.6 11989.0 4506.2 4533.6 4568.4 4584.4 4717.4 91089.5 93510.0 93975.5 94104.6 94605.0 8711.3 9942.9 10511.4 10609.9 10619.7 19333.8 19450.3 19799.4 20048.5 20084.5 7742.4 7755.3 7772.2 7823.8 7852.9 4229.3 4319.6 4338.6 4354.6 4390.4 3226.0 3286.7 3297.2 3395.9 3406.9 528.4 534.1 543.5 636.2 640.8 573.5 585.9 599.6 602.6 614.6 8384.6 8501.5 8590.6 8669.4 8856.2 506.5 521.4 551.6 586.2 617.2 3585.3 4122.0 4233.6 4261.6 4276.8 120687.0 121060.0 122088.0 122990.0 124793.0 101196.0 104330.0 106090.5 106332.5 107721.0 83936.6 85034.0 86160.0 86632.0 87298.1 6908.6 7726.2 8008.1 8120.5 8285.3 44158.8 53348.2 54205.5 54630.5 57164.0 72571.6 75349.6 76193.0 81785.6 82260.0 10694.7 10743.6 10789.8 10850.9 11141.2 11700.1 11819.6 11870.6 11892.5 11931.1 10880.6 10918.4 10991.2 11049.4 11478.8 10872.6 11025.7 11083.2 11202.9 11326.8 10556.4 10633.9 10777.1 10973.3 11466.4 9314.5 9471.5 9597.5 9636.4 9910.9 9111.7 9480.1 9480.2 9502.9 9621.9 14:41:28 INFO - PROCESS | 1639 | -------- Summary: end -------- 14:41:28 INFO - PROCESS | 1639 | 14:41:28 INFO - TEST-INFO | 1639: exit 0 14:41:29 INFO - TEST-OK | dromaeo_css | took 1113689ms 14:41:29 INFO - TEST-START | kraken 14:41:29 INFO - operating with platform_type : mac_ 14:41:29 INFO - Initialising browser for kraken test... 14:41:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpr3M5ch/profile http://localhost:49241/getInfo.html) 14:41:31 INFO - PROCESS | 1652 | 2017-02-10 14:41:31.590 plugin-container[1654:9908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884b, name = 'com.apple.tsm.portname' 14:41:31 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:31 INFO - PROCESS | 1652 | 2017-02-10 14:41:31.590 plugin-container[1654:9908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 14:41:31 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:31 INFO - PROCESS | 1652 | 2017-02-10 14:41:31.590 plugin-container[1654:9908] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:41:31 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 14:41:31 INFO - PROCESS | 1652 | colorDepth:24 14:41:31 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 14:41:31 INFO - PROCESS | 1652 | __metrics 14:41:31 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:41:32 INFO - TEST-INFO | 1652: exit 0 14:41:32 INFO - Browser initialized. 14:41:32 INFO - Running cycle 1/1 for kraken test... 14:41:32 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpr3M5ch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:35 INFO - PROCESS | 1655 | 2017-02-10 14:41:35.088 plugin-container[1656:10028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 14:41:35 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:35 INFO - PROCESS | 1655 | 2017-02-10 14:41:35.089 plugin-container[1656:10028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x860b, name = 'com.apple.CFPasteboardClient' 14:41:35 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:35 INFO - PROCESS | 1655 | 2017-02-10 14:41:35.089 plugin-container[1656:10028] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:41:44 INFO - PROCESS | 1655 | RSS: Main: 177278976 14:41:44 INFO - PROCESS | 1655 | 14:41:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:48 INFO - PROCESS | 1655 | RSS: Main: 190361600 14:41:48 INFO - PROCESS | 1655 | 14:41:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 14:41:51 INFO - PROCESS | 1655 | RSS: Main: 198230016 14:41:51 INFO - PROCESS | 1655 | 14:41:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 14:41:55 INFO - PROCESS | 1655 | RSS: Main: 201965568 14:41:55 INFO - PROCESS | 1655 | 14:41:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 14:41:58 INFO - PROCESS | 1655 | RSS: Main: 203542528 14:41:58 INFO - PROCESS | 1655 | 14:42:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:00 INFO - PROCESS | 1655 | RSS: Main: 203653120 14:42:00 INFO - PROCESS | 1655 | 14:42:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:04 INFO - PROCESS | 1655 | RSS: Main: 207589376 14:42:04 INFO - PROCESS | 1655 | 14:42:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:07 INFO - PROCESS | 1655 | RSS: Main: 207564800 14:42:07 INFO - PROCESS | 1655 | 14:42:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 14:42:11 INFO - PROCESS | 1655 | RSS: Main: 207183872 14:42:11 INFO - PROCESS | 1655 | 14:42:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:13 INFO - PROCESS | 1655 | RSS: Main: 205983744 14:42:13 INFO - PROCESS | 1655 | 14:42:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:16 INFO - PROCESS | 1655 | RSS: Main: 206098432 14:42:16 INFO - PROCESS | 1655 | 14:42:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:18 INFO - PROCESS | 1655 | RSS: Main: 206090240 14:42:18 INFO - PROCESS | 1655 | 14:42:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:22 INFO - PROCESS | 1655 | RSS: Main: 206114816 14:42:22 INFO - PROCESS | 1655 | 14:42:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:25 INFO - PROCESS | 1655 | RSS: Main: 206438400 14:42:25 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 14:42:27 INFO - PROCESS | 1655 | RSS: Main: 208424960 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | __start_tp_report 14:42:27 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 14:42:27 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 14:42:27 INFO - PROCESS | 1655 | |i|pagename|runs| 14:42:27 INFO - PROCESS | 1655 | |0;ai-astar;108;117;126;119;118;117;116;145;161;119 14:42:27 INFO - PROCESS | 1655 | |1;audio-beat-detection;141;112;110;139;116;149;144;112;139;112 14:42:27 INFO - PROCESS | 1655 | |2;audio-dft;198;195;196;188;195;193;195;193;198;194 14:42:27 INFO - PROCESS | 1655 | |3;audio-fft;77;57;62;108;85;84;80;59;77;59 14:42:27 INFO - PROCESS | 1655 | |4;audio-oscillator;80;70;88;73;68;69;85;69;72;87 14:42:27 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;87;89;86;89;86;129;128;98;86 14:42:27 INFO - PROCESS | 1655 | |6;imaging-darkroom;98;111;99;100;100;99;100;100;110;135 14:42:27 INFO - PROCESS | 1655 | |7;imaging-desaturate;88;91;87;120;129;99;143;123;89;87 14:42:27 INFO - PROCESS | 1655 | |8;json-parse-financial;54;57;55;57;60;59;57;59;59;58 14:42:27 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;67;74;67;83;78;70;67;69;73;70 14:42:27 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;83;83;82;82;81;82;88;85;87 14:42:27 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;137;147;129;134;138;135;144;138;215;156 14:42:27 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;163;164;164;165;164;162;167;209;211;207 14:42:27 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;74;75;67;66;62;59;83;90;84;89 14:42:27 INFO - PROCESS | 1655 | __end_tp_report 14:42:27 INFO - PROCESS | 1655 | __start_cc_report 14:42:27 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,905 14:42:27 INFO - PROCESS | 1655 | __end_cc_report 14:42:27 INFO - PROCESS | 1655 | __startTimestamp1486766547985__endTimestamp 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | ------- Summary: start ------- 14:42:27 INFO - PROCESS | 1655 | Number of tests: 14 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:124.60 Median:119.00 stddev:16.04 (13.5%) stddev-sans-first:15.84 14:42:27 INFO - PROCESS | 1655 | Values: 108.0 117.0 126.0 119.0 118.0 117.0 116.0 145.0 161.0 119.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:139.00 stddev:16.13 (11.6%) stddev-sans-first:16.34 14:42:27 INFO - PROCESS | 1655 | Values: 141.0 112.0 110.0 139.0 116.0 149.0 144.0 112.0 139.0 112.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:194.50 Median:195.00 stddev:2.88 (1.5%) stddev-sans-first:2.76 14:42:27 INFO - PROCESS | 1655 | Values: 198.0 195.0 196.0 188.0 195.0 193.0 195.0 193.0 198.0 194.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:74.80 Median:77.00 stddev:16.01 (20.8%) stddev-sans-first:16.96 14:42:27 INFO - PROCESS | 1655 | Values: 77.0 57.0 62.0 108.0 85.0 84.0 80.0 59.0 77.0 59.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.50 stddev:8.06 (10.5%) stddev-sans-first:8.43 14:42:27 INFO - PROCESS | 1655 | Values: 80.0 70.0 88.0 73.0 68.0 69.0 85.0 69.0 72.0 87.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:88.00 stddev:17.08 (19.4%) stddev-sans-first:17.94 14:42:27 INFO - PROCESS | 1655 | Values: 90.0 87.0 89.0 86.0 89.0 86.0 129.0 128.0 98.0 86.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:123.00 stddev:11.46 (9.3%) stddev-sans-first:11.85 14:42:27 INFO - PROCESS | 1655 | Values: 98.0 111.0 99.0 100.0 100.0 99.0 100.0 100.0 110.0 135.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:87.50 stddev:21.06 (24.1%) stddev-sans-first:21.35 14:42:27 INFO - PROCESS | 1655 | Values: 88.0 91.0 87.0 120.0 129.0 99.0 143.0 123.0 89.0 87.0 14:42:27 INFO - PROCESS | 1655 | 14:42:27 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.50 stddev:1.90 (3.2%) stddev-sans-first:1.54 14:42:27 INFO - PROCESS | 1655 | Values: 54.0 57.0 55.0 57.0 60.0 59.0 57.0 59.0 59.0 58.0 14:42:27 INFO - PROCESS | 1655 | 14:42:28 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:5.31 (7.4%) stddev-sans-first:5.34 14:42:28 INFO - PROCESS | 1655 | Values: 67.0 74.0 67.0 83.0 78.0 70.0 67.0 69.0 73.0 70.0 14:42:28 INFO - PROCESS | 1655 | 14:42:28 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:2.35 (2.8%) stddev-sans-first:2.45 14:42:28 INFO - PROCESS | 1655 | Values: 85.0 83.0 83.0 82.0 82.0 81.0 82.0 88.0 85.0 87.0 14:42:28 INFO - PROCESS | 1655 | 14:42:28 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:141.00 stddev:24.97 (17.7%) stddev-sans-first:26.21 14:42:28 INFO - PROCESS | 1655 | Values: 137.0 147.0 129.0 134.0 138.0 135.0 144.0 138.0 215.0 156.0 14:42:28 INFO - PROCESS | 1655 | 14:42:28 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:166.00 stddev:21.73 (13.1%) stddev-sans-first:22.39 14:42:28 INFO - PROCESS | 1655 | Values: 163.0 164.0 164.0 165.0 164.0 162.0 167.0 209.0 211.0 207.0 14:42:28 INFO - PROCESS | 1655 | 14:42:28 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:79.00 stddev:11.24 (14.2%) stddev-sans-first:11.92 14:42:28 INFO - PROCESS | 1655 | Values: 74.0 75.0 67.0 66.0 62.0 59.0 83.0 90.0 84.0 89.0 14:42:28 INFO - PROCESS | 1655 | -------- Summary: end -------- 14:42:28 INFO - PROCESS | 1655 | 14:42:28 INFO - TEST-INFO | 1655: exit 0 14:42:28 INFO - TEST-OK | kraken | took 59965ms 14:42:28 INFO - SUITE-END | took 1173s 14:42:29 INFO - Completed test suite (00:19:33) 14:42:29 INFO - javascript benchmark 14:42:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.225915374725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.3427845873925, 3064.187990182602, 3119.5320701894716, 3673.3204357193913, 3689.5203623528955, 4937.234728617065, 6016.969915150424, 6059.303180134286, 6078.939210607892, 6086.026235802273, 4963.205887058071, 5438.592105592086, 6022.217111775474, 6130.8160755177305, 6136.570440069197, 4263.658907287425, 5293.470652934714, 5376.274202982596, 5439.292891924044, 5473.67157970521, 5485.341758988927, 5488.423715509874, 5513.117901135819, 5515.145152501349, 5525.11598144297, 5347.171188465774, 5398.8920221595545, 5494.0, 5497.972510137443, 5498.642588231772, 5454.7272636368225, 5458.099413596752, 5489.204065410533, 5501.614886957915, 5544.16837474378, 5332.146856502941, 5420.783168673248, 5444.727763611803, 5470.5350045245805, 5497.312835895513, 6094.756209751605, 6102.72537735803, 6114.0, 6176.351483094255, 6198.969005154945, 6207.906881396782, 6210.192674952273, 6211.720472578745, 6256.593321434138, 6272.56092073555, 6334.429901308904, 6357.300696923335, 6360.0459931010255, 6360.141380913564, 6371.171747672773, 6094.573379863411, 6106.786262480836, 6124.203853499106, 6127.724252408652, 6132.356102609251, 6254.593451425642, 6366.236051673829, 6372.394622510854, 6412.551121421549, 6464.256610489854, 6226.813195604049, 6259.405356491126, 6266.279377871603, 6267.811965641038, 6268.968655156695, 6393.073004414334, 6395.840103997344, 6398.944174211296, 6404.551681382259, 6415.486761059104, 5114.977004599095, 6193.102000209944, 6235.407636274546, 6267.6866156692895, 6275.058741188767, 6190.566660333733, 6208.4722798562625, 6288.151099601495, 6293.685315734195, 6304.401081897304, 5095.617828662865, 5128.692278463304, 5136.075506408883, 5146.305248791366, 5156.175011998137, 4470.754108524063, 4507.887302817456, 4624.6993945394115, 4636.559526844944, 4640.2807564826835, 4969.27945447908, 5983.461488466059, 6076.696165191723, 6130.570860039755, 6139.171211886338, 6385.553011289165, 6400.967995159995, 6401.263854656681, 6423.582467139621, 6424.325445828121, 6014.458698717136, 6079.08813677943, 6080.0575910733905, 6144.907826382608, 6162.907556386658, 5654.802081927113, 5662.348829884616, 5669.234653321749, 5674.375818659944, 5713.2572765541045, 6552.672366381662, 6576.473882089422, 6609.339066093352, 6631.436327912182, 6652.866942661217, 5335.466453354634, 5498.725063746717, 6011.098335249748, 6278.246610406781, 6374.521910856612, 6467.547271690936, 6538.346165383424, 6593.142891424084, 6597.340265973365, 6608.43828274602, 6306.432421081941, 6319.52603554726, 6327.11420401135, 6327.17746692927, 6338.968305158444, 5583.274174357308, 6177.413145751147, 6251.4061164189325, 6398.488120950406, 6404.583702059351, 6164.0, 6167.84580385476, 6187.319394866471, 6211.130441738251, 6213.378662133931, 6209.441150296495, 6226.688665566794, 6231.065340198825, 6231.75072997075, 6234.719437625408, 4936.0, 6090.573659843945, 6118.235220597426, 6162.137300777984, 6177.567570270217, 5191.377034755854, 6130.703893785035, 6173.876522469615, 6192.473639740672, 6238.970569855923, 5103.260027296095, 6003.309619393825, 6097.939020609737, 6129.908051379144, 6131.080337949344], "value": 5823.5848934406185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.81654787728525, 531.3544043986556, 537.9704116273606, 543.0388212863235, 544.8665077056121, 33087.0, 34986.0, 40567.39148912765, 40676.59323406769, 42314.57685423145, 42078.57921420785, 42478.0, 42553.0, 42609.93475163123, 42651.57348426515, 9527.80944381112, 9561.952190239073, 9653.662121825737, 9697.515124243795, 9709.368891022097, 9553.187979021792, 9643.987381324965, 9659.90340096597, 9691.273154513405, 9741.0, 9633.807323853518, 9713.902860971406, 9751.073648003428, 9776.217902567778, 9804.705858824247, 9601.135897769234, 9641.084097010773, 9681.951590242074, 9708.174805141502, 9715.174210192143, 9509.429434233969, 9519.857202141973, 9578.0, 9658.082482164184, 9704.70885873425, 38827.22345553073, 38848.61151388478, 38920.41619375712, 39398.60601393978, 39421.40867886984, 2675.719049499794, 3369.7304215662934, 3390.423627983249, 3397.9830100849586, 3406.9659303406897, 25139.748602513922, 27898.581521277196, 29124.98062567821, 29755.256118597208, 30235.546466803014, 3293.176705823544, 3326.6673332666783, 3332.600087989457, 3447.3622379859808, 3471.704905083071, 476922.0, 478227.0, 479301.0, 481806.0, 482757.0, 61162.694186529676, 61442.692786536674, 61493.69253153705, 61648.38351616516, 61796.382036179064, 63068.68465657642, 63344.683276583324, 63943.680281598296, 64310.356896431374, 64388.034179487346, 16326.183690815411, 16488.83511164897, 16829.0, 16861.662766744597, 16977.830221697874, 12608.054395920342, 13005.154664946747, 13006.544770932973, 13042.673933151747, 13044.869551304555, 17340.393086241922, 17548.29806807739, 17594.824051759573, 17621.295148194185, 17671.911640441973, 7406.629668516553, 7413.518121322097, 7451.105867295959, 7503.124218945263, 7596.734114305973, 925.7454200095028, 999.9050090241416, 1066.7226521104415, 1087.9609972476267, 1093.9671809845718, 26227.73772262253, 30493.501319655308, 30507.55939524833, 30794.0, 30808.92168774082, 1046.1578429364436, 1071.989280107189, 1097.928634638746, 1108.4845546820768, 1179.0390831472323, 13051.21692698441, 15361.0, 15571.532854014398, 15699.607509812346, 15989.360425582847, 173124.0, 667518.0, 884696.0, 885941.0, 886090.0, 58833.70583147142, 59071.0, 59340.0, 59505.40494595085, 59587.0, 1263.879931406515, 1355.9186448813102, 1408.0917808013774, 1436.6480212348042, 1439.8848092152602, 26239.868800655873, 28255.57616635711, 31496.527552087195, 31624.683753162175, 31725.841370792998, 50682.49317506778, 55980.16029759475, 56674.0, 57105.0, 59850.0, 564034.0, 566756.0, 570987.0, 572107.0, 572436.0, 26601.733982659927, 26663.33341666396, 27023.054193103148, 27129.321766955985, 27175.592366114128, 46696.766516167205, 46831.76584117058, 47506.28740568825, 47726.52273477221, 48232.276515852995, 34766.82616586901, 37925.0, 38217.23565528618, 39045.0, 39180.41229381505, 38596.80701596474, 38874.61125388823, 39266.0, 39353.40969885511, 39648.60351396449, 37298.0, 38157.0, 38286.0, 38695.6130438692, 39380.40929386119, 28060.45667488226, 30941.226469338446, 35100.473492897116, 35166.82416587901, 35302.29395412129, 25670.61494077628, 25908.8704556476, 25950.740492594832, 26013.349666258495, 26401.60397594076], "value": 20100.42224446694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7965298738681, 384.40801166204045, 390.7655406755949, 391.27613914258626, 406.13087991697773, 18750.2499900004, 20107.497312567157, 20387.388378348674, 20457.386278411654, 20721.06755196016, 19267.03664816757, 19279.518012049706, 19751.0, 20508.384748457534, 20804.0, 5848.152017957394, 5905.379935106816, 6080.817575472743, 6103.725332360033, 6151.108089327045, 5879.265091863517, 5896.38088000758, 5921.73352199152, 5955.851103722398, 6025.397460253984, 4705.764711764416, 5971.611845230068, 6022.367651396584, 6075.270967483908, 6145.907811382833, 5878.706064696748, 5972.880542389128, 6093.664848433335, 6104.3590423005835, 6142.907856382158, 5750.913736293959, 5835.0372188588835, 5887.587868849182, 5903.026000709878, 5916.290045194562, 13078.280694561796, 13162.0, 13304.467821287137, 13336.799948000787, 13470.595882123553, 2064.4013236161495, 2245.1692873636694, 2276.2943487518924, 2493.364192131013, 2668.6931002934716, 9718.805623887483, 9773.397245651742, 10148.1374083203, 10225.028622280872, 10229.795404091876, 1571.285065295288, 1605.3177399605122, 1818.1182126668555, 1847.6304739052243, 1879.577095153593, 119072.0, 124042.37978810139, 126796.0, 128540.35729821384, 129351.35324323412, 9258.444493330288, 11190.776184476264, 11826.704332391759, 11901.10741694359, 11936.28382297065, 14500.927495362666, 14508.709825803426, 14755.55733328002, 14949.775753363709, 15085.396584136732, 8500.914990850013, 8721.0, 8731.738047858575, 8751.956240218758, 8893.377463577488, 8728.869066964, 8748.737537873874, 8768.736937891874, 8872.556372181494, 8877.467351958903, 4041.6968727345566, 4416.072624748838, 4583.243764778774, 4583.243764778774, 4710.9764451177525, 1734.9913250433667, 1938.3215874444113, 1955.6284305981817, 2019.4648418169197, 2029.553498230387, 901.8872640919885, 934.7195841247599, 994.751312171957, 1007.4106647611083, 1011.0647650922867, 16299.185040747916, 19863.246156917492, 20261.0, 20776.065077071267, 21086.05112769929, 935.6444551070686, 946.7349142240183, 956.7799406136488, 990.4849478271259, 1042.9634962776267, 10618.946905265424, 11018.834717479243, 11044.944775276072, 11120.943510366502, 11142.0, 591143.0, 594628.0, 596607.0169649124, 605724.0, 608412.0, 132683.3365833184, 136877.3156134213, 141098.0, 142139.0, 144536.5546344544, 1002.5187909803335, 1002.7743757654615, 1011.858339832424, 1020.9948950255201, 1030.07808011829, 14767.187804670846, 17832.19755110997, 18625.53436164107, 18747.718784217974, 19161.90419047896, 53346.73326633497, 54253.45746542484, 54501.0, 54681.63295917634, 55391.72304138453, 75969.62015189888, 76474.0, 79180.60409697915, 79813.60093199497, 80130.0, 7948.483348582324, 8123.309518690978, 8177.4684645497855, 8305.792355191168, 8372.120927302789, 10752.0, 12532.310722909962, 12837.743245135232, 13060.08579399471, 13110.147840390344, 5575.247341608993, 9142.680006199751, 9369.953150234478, 10389.324693894872, 10876.23866329381, 9105.317101217568, 10220.693379198636, 10459.790804184026, 11036.392998384845, 11088.501017454395, 6484.870302593828, 10848.783024339627, 10873.401962892116, 10909.236353455182, 11150.386728729673, 7957.880631790412, 7993.600319984093, 8116.959415202886, 8230.135835737401, 8247.711330103417, 9157.633694652139, 9265.212456940966, 10650.307729997525, 10945.890541094806, 11150.275232109887], "value": 9355.46547220509, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.8847181905844, 1489.9851001489985, 1512.1229686781667, 1826.8081851405593, 1852.1665250637209, 7661.693532258703, 7914.525128492294, 8134.959325203373, 8566.914330856689, 8568.785780355494, 8022.839543209132, 8321.916780832189, 8348.039975402831, 8470.576471176448, 8485.830283394329, 2373.133806160756, 2405.398650337416, 2406.4224586099385, 2412.4089598048504, 2429.647701083342, 2200.801927826495, 2261.208576998054, 2372.1578839511985, 2413.7344892061947, 2420.261820144855, 1958.637652034371, 2337.6610391493223, 2378.3221781792195, 2378.4172877644914, 2387.1883559589737, 2276.2488378834946, 2314.837961342707, 2341.5785158671433, 2341.789238968501, 2373.7181921762312, 2153.6231159547174, 2272.6023495550285, 2369.7867191952805, 2401.891914863835, 2420.334408037786, 6846.623435711034, 7194.460415468809, 8383.790405239857, 8435.95782021092, 8437.493750374997, 5041.546260836506, 5130.51260130287, 5224.582033437316, 5280.260763493114, 5294.179402192666, 3388.373150967079, 3477.5826900771817, 3600.117971097098, 3607.603163651996, 3631.6186800385844, 1052.7787766191182, 1055.2824079625852, 1105.745678493951, 1113.4321496036998, 1118.0440723181725, 9150.86273705895, 9685.886123095794, 10769.946150269277, 10876.945615271952, 10969.012788849042, 4470.173017991682, 4610.907781844345, 4698.201305778026, 4711.95288047122, 4715.622750180046, 7895.644695988694, 9275.768105797275, 9295.860562091573, 9327.486988215713, 9344.859827102599, 5190.403103643054, 5217.34783152106, 5220.425753167148, 5223.059849227176, 5229.398619158846, 4366.235908715962, 4418.734875907456, 4812.278158276286, 4831.26074613139, 4873.171560834667, 3245.8701651933657, 3870.3420418528917, 3899.66852817508, 3925.6270654287796, 3963.4451176835264, 1096.4188979840696, 1280.4622058735354, 1282.0512820512754, 1292.8254685617321, 1312.7112035352206, 823.9340852731887, 843.7976880342302, 887.9378443509022, 907.4373888189365, 919.5632074764434, 5621.0, 5656.8868622627315, 5671.886562268732, 5704.458076482728, 5763.7982670606325, 791.9406044546682, 949.1125797379473, 957.7940742740344, 976.5410257179115, 1008.6721815410021, 3687.778733276012, 3694.612065733113, 3747.6439738224826, 3756.286305601927, 3787.2046870157023, 9908.950455247821, 9982.0, 10114.88736239013, 10170.186385089175, 10262.794744105076, 9921.751956201007, 9931.255155863339, 10234.948825255826, 10235.948820256, 10274.948625256826, 7848.489848159851, 7848.921510784933, 7891.842163156704, 7922.049354077432, 8030.116687164407, 4387.407699960592, 5375.892482150413, 5496.972515137399, 5513.862153446035, 5541.722913854372, 9221.86167207479, 9246.398984066014, 9343.672971445967, 9413.52932353366, 9480.336376453582, 9399.718008459757, 9519.428834269966, 9606.991265916979, 9654.27592930519, 9706.563204655666, 6282.340354262737, 6486.6756662167645, 6586.1438013058, 6706.329367063449, 6849.212340580897, 7805.219478052377, 7896.763097107096, 7908.8813667793875, 7910.446268761131, 8003.759887203393, 7062.576245425291, 7200.603966781668, 7232.385247254042, 7248.202697703354, 7312.96343518279, 5933.436323549256, 7043.119610048744, 7055.858882822212, 7089.397401220954, 7153.248908864494, 6675.265720770809, 6691.397774200151, 6713.865722685617, 6746.797596072126, 6753.392194702304, 4752.643551733565, 4771.95228047715, 4794.520547945178, 4796.8081276748535, 4802.207635740064, 4700.741459219776, 4714.905701886011, 4760.9047819042735, 4876.5854902333695, 4932.358793356841], "value": 4410.122549155135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.80517871151824, 310.27550669187445, 316.96196456425224, 319.6499832683211, 320.9903702888914, 4371.16947779922, 5374.48942350476, 5396.10964190909, 5491.890162196753, 5558.583106267026, 5185.988732197223, 5420.349558053029, 5444.346678398588, 5457.536109430703, 5458.372287186975, 3408.36945165144, 4188.28280405034, 4189.2040512302565, 4190.476190476191, 4216.957830421703, 3808.038859987095, 3875.9728671901967, 3890.0160917931917, 4119.691023173259, 4204.663626909855, 3591.9346375834, 4073.5111786585653, 4104.733192342503, 4118.073433477473, 4143.854965076223, 3268.7548433867437, 3392.185875389901, 3889.6517288728, 4114.897127571805, 4136.276151673445, 2799.510085734988, 3153.30627262002, 3262.890617190143, 3597.892063238081, 3631.1314061891076, 4264.571368591525, 4521.909561808779, 4626.791794369262, 5098.470458862364, 5368.8389348319615, 4674.672772905898, 4677.508861569554, 4683.88290292742, 4705.294205869147, 4706.9764651176865, 5393.494228751343, 5709.600327977043, 5713.542916566665, 5726.255586773693, 5737.512311453532, 3706.314331848617, 3783.356829339019, 3928.017995501125, 3937.88186354407, 3953.3476976298875, 5933.021051526493, 5958.34458209601, 5995.460408563206, 6006.939930600725, 6015.105241848803, 3311.7516186285643, 3319.8838040668943, 3960.5841386653988, 3976.562578116405, 3994.2211268802885, 3908.3160446921675, 3953.240807840541, 3973.940390894139, 4076.6331030207425, 4096.112240870179, 4631.276098379702, 4636.148768507343, 4643.930341044887, 4660.976695116503, 4681.414823147106, 5087.516685914832, 5421.722876391925, 5791.594588378773, 5794.391588883191, 5804.303483581913, 1011.2567263061644, 1187.6674531131298, 1276.789329760579, 1279.9680007999689, 1292.4636275945377, 806.2904643913319, 808.6846130009301, 880.194621920948, 891.3760367742606, 895.5208963204655, 5089.236614507779, 5107.182850743863, 5111.821086261963, 5115.5396014358885, 5124.5131712487255, 4481.596656300949, 4583.610393116555, 5463.890722185613, 5558.972205138948, 5628.971855140698, 4531.43357080365, 4996.7501624918605, 5010.649254552146, 5071.54356107952, 5110.514501122388, 2612.725663805311, 2971.0, 2986.5813738474485, 2993.5958645583005, 3021.7582593392917, 5136.223312319578, 5640.492355688008, 5916.792912248051, 5943.009091954244, 6020.638761674313, 4814.9518504815205, 5837.503812176013, 5852.736626851802, 5945.0, 5956.374580668968, 5017.523335283142, 5388.0, 5924.815036992705, 5938.465538101505, 5954.76180952757, 4769.9046019080115, 5065.303123453685, 5561.6384934980715, 5642.858928526655, 5726.828195154152, 4618.584327410549, 4812.663113582015, 5254.816081437131, 5624.775008999758, 5664.886702265849, 5947.762089516371, 5949.375315591974, 5970.0, 5981.252343457068, 5982.141518720314, 3198.8080715157166, 3545.2200515886466, 3749.8937813345674, 3756.7182461314965, 3778.6599206071587, 4862.027594481047, 4982.925256121089, 5581.748821303132, 5725.7137143141845, 5770.0, 5070.898582028265, 5611.270534830446, 5694.327158982516, 5807.361190268983, 5850.1626711044255, 5456.890862182813, 5781.277340332458, 5787.334456537552, 5791.971040144772, 5795.406263277632, 4823.986962737864, 4885.8045678172475, 4999.375078115236, 5074.5686616637995, 5668.546516278605, 4744.9051018978735, 5812.01195796724, 5819.624617721796, 5829.970850145722, 5831.562632802472, 4448.64410847125, 4680.391549098732, 5683.299129679225, 5706.9714651426475, 5717.256756621613], "value": 4071.850337701433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.4336152758557, 716.4626530102423, 727.181920339618, 742.951708138971, 772.1313522287427, 14297.571072867817, 14712.779308310384, 15122.319495622696, 15148.469803556878, 15205.543833684993, 13622.795658065137, 13639.45442182314, 13640.727185456284, 13649.590512284623, 13730.244836533986, 695.5235663570458, 717.5336031579463, 829.8215883585028, 853.5561508015859, 873.8776571280026, 851.221132663612, 856.2935578148052, 861.9051904290523, 865.3164000439646, 866.1684782608703, 884.1732979664002, 884.9734507964771, 893.13366034946, 915.0849150849151, 920.2683866326253, 879.8548239540501, 888.9822203555892, 891.2869704236617, 917.3761841947473, 917.8990311065777, 653.7123665587127, 654.290095246658, 655.9180102487189, 675.0684056002685, 680.8502129531495, 13810.792838107336, 13858.514951976633, 13872.375743091585, 14345.067570607876, 14635.560933172022, 12326.5069397224, 12649.430775615027, 12803.295818729966, 14388.928055359656, 14555.563333100024, 11735.23720958135, 11746.882531174664, 11849.822252666218, 11954.641360759191, 11989.0, 4506.233940230169, 4533.569310915458, 4568.428946381702, 4584.358189853423, 4717.410323709536, 91089.54455227748, 93510.0, 93975.53012234964, 94104.58843117359, 94605.0, 8711.303095752324, 9942.850857237147, 10511.421871797125, 10609.9469502652, 10619.681409557727, 19333.806661933482, 19450.319238826574, 19799.40601781949, 20048.498787530138, 20084.497887552927, 7742.436151267021, 7755.2632499912415, 7772.18392068836, 7823.843523129505, 7852.882206766903, 4229.302165142717, 4319.568043195655, 4338.566143385699, 4354.608085272277, 4390.407295015196, 3225.9838700806345, 3286.7206287465356, 3297.1592243977634, 3395.864165433355, 3406.8977930662118, 528.4161002092633, 534.1240365800091, 543.499980018384, 636.1539152926597, 640.7565125252374, 573.4809996952764, 585.9062549992066, 599.5623195067625, 602.6384169498266, 614.6097228259997, 8384.622691978753, 8501.489910605384, 8590.613422396007, 8669.393142479967, 8856.202941735275, 506.5289280968661, 521.3639359980817, 551.5642642312528, 586.1500823805499, 617.2038070888503, 3585.3367127081574, 4121.9587804121575, 4233.618974292329, 4261.552536983634, 4276.8289268429535, 120687.0, 121060.0, 122088.0, 122990.0, 124793.0, 101196.0, 104330.0, 106090.46954765331, 106332.46833765936, 107721.0, 83936.58031709802, 85034.0, 86160.0, 86632.0, 87298.12701873027, 6908.5509441886115, 7726.2296717550535, 8008.078061265371, 8120.512769233865, 8285.295749861329, 44158.77920610376, 53348.19977700415, 54205.45794542004, 54630.45369546254, 57164.0, 72571.63714181607, 75349.62325188339, 76193.0, 81785.59107204426, 82260.0, 10694.679159625224, 10743.570257189625, 10789.838152427563, 10850.945745271223, 11141.2201145919, 11700.122490813053, 11819.645410637695, 11870.584529541424, 11892.456018288372, 11931.058392353167, 10880.564777408816, 10918.399488028235, 10991.175661825235, 11049.39228342449, 11478.82781758291, 10872.635410657897, 11025.724356891142, 11083.168762343017, 11202.887971120184, 11326.83009754871, 10556.419396933243, 10633.89366106329, 10777.083947864206, 10973.341599504056, 11466.369349685847, 9314.534273286445, 9471.526423678926, 9597.47213903242, 9636.373635713657, 9910.86809976798, 9111.681091161778, 9480.146786789222, 9480.241580673392, 9502.857457138287, 9621.941586425348], "value": 7096.592392287927, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 126.0, 119.0, 118.0, 117.0, 116.0, 145.0, 161.0, 119.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 110.0, 139.0, 116.0, 149.0, 144.0, 112.0, 139.0, 112.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 196.0, 188.0, 195.0, 193.0, 195.0, 193.0, 198.0, 194.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 57.0, 62.0, 108.0, 85.0, 84.0, 80.0, 59.0, 77.0, 59.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 88.0, 73.0, 68.0, 69.0, 85.0, 69.0, 72.0, 87.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 89.0, 86.0, 129.0, 128.0, 98.0, 86.0], "value": 96.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 111.0, 99.0, 100.0, 100.0, 99.0, 100.0, 100.0, 110.0, 135.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 87.0, 120.0, 129.0, 99.0, 143.0, 123.0, 89.0, 87.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 55.0, 57.0, 60.0, 59.0, 57.0, 59.0, 59.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 67.0, 83.0, 78.0, 70.0, 67.0, 69.0, 73.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 82.0, 82.0, 81.0, 82.0, 88.0, 85.0, 87.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 147.0, 129.0, 134.0, 138.0, 135.0, 144.0, 138.0, 215.0, 156.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 165.0, 164.0, 162.0, 167.0, 209.0, 211.0, 207.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 67.0, 66.0, 62.0, 59.0, 83.0, 90.0, 84.0, 89.0], "value": 74.9, "unit": "score"}]}]} 14:42:29 INFO - Return code: 0 14:42:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:42:29 ERROR - # TBPL SUCCESS # 14:42:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:29 INFO - 2017-02-10 14:42:29.269 screenresolution[1660:10412] starting screenresolution argv=screenresolution get 14:42:29 INFO - 2017-02-10 14:42:29.272 screenresolution[1660:10412] Display 0: 1600x1200x32@60 14:42:29 INFO - 2017-02-10 14:42:29.278 screenresolution[1661:10415] starting screenresolution argv=screenresolution list 14:42:29 INFO - Available Modes on Display 0 14:42:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:29 INFO - Intel Iris: 14:42:29 INFO - Chipset Model: Intel Iris 14:42:29 INFO - Type: GPU 14:42:29 INFO - Bus: Built-In 14:42:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:42:29 INFO - Vendor: Intel (0x8086) 14:42:29 INFO - Device ID: 0x0a2e 14:42:29 INFO - Revision ID: 0x0009 14:42:29 INFO - Displays: 14:42:29 INFO - Display: 14:42:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:29 INFO - Display Serial Number: 1600x1200 60 14:42:29 INFO - Main Display: Yes 14:42:29 INFO - Mirror: Off 14:42:29 INFO - Online: Yes 14:42:29 INFO - Rotation: Supported 14:42:29 INFO - Return code: 0 14:42:29 INFO - Running post-action listener: _resource_record_post_action 14:42:29 INFO - [mozharness: 2017-02-10 22:42:29.522522Z] Finished run-tests step (success) 14:42:29 INFO - Running post-run listener: _resource_record_post_run 14:42:29 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 38987776; Write bytes: 504110592; Read time: 251; Write time: 1606 14:42:29 INFO - TinderboxPrint: CPU usage
54.3% 14:42:29 INFO - TinderboxPrint: I/O read bytes / time
38,987,776 / 251 14:42:29 INFO - TinderboxPrint: I/O write bytes / time
504,110,592 / 1,606 14:42:29 INFO - TinderboxPrint: CPU idle
2,187.0 (45.7%) 14:42:29 INFO - TinderboxPrint: CPU system
968.0 (20.2%) 14:42:29 INFO - TinderboxPrint: CPU user
1,630.7 (34.1%) 14:42:29 INFO - TinderboxPrint: Swap in / out
230,502,400 / 0 14:42:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183224832; Write bytes: 176731648; Read time: 16708; Write time: 371 14:42:29 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 38066176; Write bytes: 310695936; Read time: 239; Write time: 1182 14:42:30 INFO - Running post-run listener: _upload_blobber_files 14:42:30 INFO - Blob upload gear active. 14:42:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:30 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 14:42:30 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'] 14:42:30 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 14:42:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:31 INFO - (blobuploader) - INFO - Done attempting. 14:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:32 INFO - (blobuploader) - INFO - Done attempting. 14:42:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:34 INFO - (blobuploader) - INFO - Done attempting. 14:42:34 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:34 INFO - Return code: 0 14:42:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9147a605ff7de80e1608270e583856b8cffc8c7ef22b61b4428cb168b37492601aabace200d75b20e8685fd4d26da1e93bf7d4ce8512301df83fdb15fbe23806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3398082fa98fa88faf3cabfb4e8a957543208bf00d7fa205d2f2797b6b8e228d66bc94727027e9279d8d1c6a85be55ac0d2e84a8a34c0848c27ad92e3adb23e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ec2a578cd94bb252823ae7042731fc1be21ddf10d807effde56b4f4be2eb67efdb2fc73c2bc321bd323cbb6635f558860c5474242754561119dd24079bf2cf"} 14:42:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:34 INFO - Contents: 14:42:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9147a605ff7de80e1608270e583856b8cffc8c7ef22b61b4428cb168b37492601aabace200d75b20e8685fd4d26da1e93bf7d4ce8512301df83fdb15fbe23806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3398082fa98fa88faf3cabfb4e8a957543208bf00d7fa205d2f2797b6b8e228d66bc94727027e9279d8d1c6a85be55ac0d2e84a8a34c0848c27ad92e3adb23e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ec2a578cd94bb252823ae7042731fc1be21ddf10d807effde56b4f4be2eb67efdb2fc73c2bc321bd323cbb6635f558860c5474242754561119dd24079bf2cf"} 14:42:34 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:34 INFO - Copying logs to upload dir... 14:42:34 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.921174 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-10 14:42:34.886509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:34.890763) ========= 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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/9147a605ff7de80e1608270e583856b8cffc8c7ef22b61b4428cb168b37492601aabace200d75b20e8685fd4d26da1e93bf7d4ce8512301df83fdb15fbe23806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3398082fa98fa88faf3cabfb4e8a957543208bf00d7fa205d2f2797b6b8e228d66bc94727027e9279d8d1c6a85be55ac0d2e84a8a34c0848c27ad92e3adb23e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ec2a578cd94bb252823ae7042731fc1be21ddf10d807effde56b4f4be2eb67efdb2fc73c2bc321bd323cbb6635f558860c5474242754561119dd24079bf2cf"} build_url:https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011128 build_url: 'https://queue.taskcluster.net/v1/task/D6eoourFSpmrHr945mDgMw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9147a605ff7de80e1608270e583856b8cffc8c7ef22b61b4428cb168b37492601aabace200d75b20e8685fd4d26da1e93bf7d4ce8512301df83fdb15fbe23806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3398082fa98fa88faf3cabfb4e8a957543208bf00d7fa205d2f2797b6b8e228d66bc94727027e9279d8d1c6a85be55ac0d2e84a8a34c0848c27ad92e3adb23e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ec2a578cd94bb252823ae7042731fc1be21ddf10d807effde56b4f4be2eb67efdb2fc73c2bc321bd323cbb6635f558860c5474242754561119dd24079bf2cf"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:35.164741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:35.165077) ========= 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.MmRdU6d9Ae/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.sQjh5IcQAH/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005189 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:42:35.213011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:42:35.213306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:42:35.216664) ========= ========= Total master_lag: 0.56 =========