builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0358 starttime: 1475987288.05 results: success (0) buildid: 20161008164819 builduid: 2751bb0d23e547aebb7c8693e735a37e revision: 313a2d049350c88515b0b900aaf279a0ae61c7fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.046345) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.046834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.047157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.070247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.070546) ========= 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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-08 21:28:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.12M=0.001s 2016-10-08 21:28:08 (8.12 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.217205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.217530) ========= 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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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.020299 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:08.266777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-08 21:28:08.267148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 313a2d049350c88515b0b900aaf279a0ae61c7fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 313a2d049350c88515b0b900aaf279a0ae61c7fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-08 21:28:08,346 truncating revision to first 12 chars 2016-10-08 21:28:08,346 Setting DEBUG logging. 2016-10-08 21:28:08,346 attempt 1/10 2016-10-08 21:28:08,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/313a2d049350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 21:28:09,191 unpacking tar archive at: mozilla-central-313a2d049350/testing/mozharness/ program finished with exit code 0 elapsedTime=1.127105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-08 21:28:09.416285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:09.416624) ========= script_repo_revision: 313a2d049350c88515b0b900aaf279a0ae61c7fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:09.417032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:09.417298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 21:28:09.435078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-08 21:28:09.435355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:09 INFO - MultiFileLogger online at 20161008 21:28:09 in /builds/slave/test 21:28:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:28:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:09 INFO - {'append_to_log': False, 21:28:09 INFO - 'base_work_dir': '/builds/slave/test', 21:28:09 INFO - 'blob_upload_branch': 'Firefox', 21:28:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:09 INFO - 'branch': 'Firefox', 21:28:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:09 INFO - 'config_files': ('talos/mac_config.py',), 21:28:09 INFO - 'default_actions': ('clobber', 21:28:09 INFO - 'read-buildbot-config', 21:28:09 INFO - 'download-and-extract', 21:28:09 INFO - 'populate-webroot', 21:28:09 INFO - 'create-virtualenv', 21:28:09 INFO - 'install', 21:28:09 INFO - 'run-tests'), 21:28:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:09 INFO - 'download_minidump_stackwalk': True, 21:28:09 INFO - 'download_symbols': 'ondemand', 21:28:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:09 INFO - 'installer_path': 'installer.exe', 21:28:09 INFO - 'log_level': 'info', 21:28:09 INFO - 'log_name': 'talos', 21:28:09 INFO - 'log_to_console': True, 21:28:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:28:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:28:09 INFO - 'opt_config_files': (), 21:28:09 INFO - 'pip_index': False, 21:28:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:28:09 INFO - 'cmd': ('bash', 21:28:09 INFO - '-c', 21:28:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:28:09 INFO - 'enabled': True, 21:28:09 INFO - 'halt_on_failure': False, 21:28:09 INFO - 'name': 'check_screen_resolution'},), 21:28:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:28:09 INFO - 'cmd': ('bash', 21:28:09 INFO - '-c', 21:28:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:28:09 INFO - 'enabled': True, 21:28:09 INFO - 'halt_on_failure': False, 21:28:09 INFO - 'name': 'check_screen_resolution'},), 21:28:09 INFO - 'run_cmd_checks_enabled': True, 21:28:09 INFO - 'sps_profile': False, 21:28:09 INFO - 'sps_profile_interval': 0, 21:28:09 INFO - 'suite': 'dromaeojs-e10s', 21:28:09 INFO - 'system_bits': '32', 21:28:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:09 INFO - 'title': 't-yosemite-r7-0358', 21:28:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:09 INFO - 'use_talos_json': True, 21:28:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:09 INFO - 'work_dir': 'build'} 21:28:09 INFO - [mozharness: 2016-10-09 04:28:09.637318Z] Running clobber step. 21:28:09 INFO - Running pre-action listener: _resource_record_pre_action 21:28:09 INFO - Running main action method: clobber 21:28:09 INFO - rmtree: /builds/slave/test/build 21:28:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:11 INFO - Running post-action listener: _resource_record_post_action 21:28:11 INFO - [mozharness: 2016-10-09 04:28:11.468768Z] Finished clobber step (success) 21:28:11 INFO - [mozharness: 2016-10-09 04:28:11.468905Z] Running read-buildbot-config step. 21:28:11 INFO - Running pre-action listener: _resource_record_pre_action 21:28:11 INFO - Running main action method: read_buildbot_config 21:28:11 INFO - Using buildbot properties: 21:28:11 INFO - { 21:28:11 INFO - "project": "", 21:28:11 INFO - "product": "firefox", 21:28:11 INFO - "script_repo_revision": "production", 21:28:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:28:11 INFO - "repository": "", 21:28:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:28:11 INFO - "buildid": "20161008164819", 21:28:11 INFO - "pgo_build": "False", 21:28:11 INFO - "basedir": "/builds/slave/test", 21:28:11 INFO - "buildnumber": 42, 21:28:11 INFO - "slavename": "t-yosemite-r7-0358", 21:28:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:28:11 INFO - "platform": "yosemite_r7", 21:28:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:28:11 INFO - "branch": "mozilla-central", 21:28:11 INFO - "repo_path": "mozilla-central", 21:28:11 INFO - "revision": "313a2d049350c88515b0b900aaf279a0ae61c7fa", 21:28:11 INFO - "stage_platform": "macosx64", 21:28:11 INFO - "builduid": "2751bb0d23e547aebb7c8693e735a37e", 21:28:11 INFO - "slavebuilddir": "test" 21:28:11 INFO - } 21:28:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:28:11 INFO - Running post-action listener: _resource_record_post_action 21:28:11 INFO - [mozharness: 2016-10-09 04:28:11.472147Z] Finished read-buildbot-config step (success) 21:28:11 INFO - [mozharness: 2016-10-09 04:28:11.472281Z] Running download-and-extract step. 21:28:11 INFO - Running pre-action listener: _resource_record_pre_action 21:28:11 INFO - Running main action method: download_and_extract 21:28:11 INFO - mkdir: /builds/slave/test/build/tests 21:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:11 INFO - trying https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:28:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:28:12 INFO - Downloaded 1199 bytes. 21:28:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:28:12 INFO - Using the following test package requirements: 21:28:12 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:28:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:28:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:28:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'jsshell-mac.zip'], 21:28:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:28:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:28:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:28:12 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:28:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:28:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:28:12 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:28:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:28:13 INFO - Http code: 200 21:28:13 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:28:13 INFO - x-amz-cf-id: tN49GAy-YBjuO47SNWvUGH1JNIgQSWt5982qYvtEVfCV3WMfrjXNpg== 21:28:13 INFO - x-amz-version-id: ky1JdfU9IZ0gDFrVxhVG3b0_7UjYSoJ9 21:28:13 INFO - Expected file size: 16504560 21:28:13 INFO - Obtained file size: 16504560 21:28:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:28:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:28:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:28:20 INFO - Fetch https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:28:21 INFO - Http code: 200 21:28:21 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 21:28:21 INFO - x-amz-cf-id: bPV1ML5G9aX0-kVIok4a2B2GN_N5-2pqWF6T3r55p-oUjuHHaLHv_A== 21:28:21 INFO - x-amz-version-id: ky1JdfU9IZ0gDFrVxhVG3b0_7UjYSoJ9 21:28:21 INFO - Expected file size: 16504560 21:28:21 INFO - Obtained file size: 16504560 21:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:28:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:28:28 INFO - Http code: 200 21:28:28 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 21:28:28 INFO - x-amz-cf-id: Zb_bqJLn3J2X3LQPbbqFQJucibjZpb6R1hNuy5KpjkbjrYqqKOYCPg== 21:28:28 INFO - x-amz-version-id: OPJYOOb3gMJqc.DTFE_.x0yYsYCB3pda 21:28:28 INFO - Expected file size: 14409006 21:28:28 INFO - Obtained file size: 14409006 21:28:29 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')]} 21:28:29 INFO - trying https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:28:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:28:31 INFO - Downloaded 111721900 bytes. 21:28:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:28:31 INFO - mkdir: /builds/slave/test/properties 21:28:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:28:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:28:31 INFO - Contents: 21:28:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:28:32 INFO - Running post-action listener: _resource_record_post_action 21:28:32 INFO - Running post-action listener: set_extra_try_arguments 21:28:32 INFO - [mozharness: 2016-10-09 04:28:32.532564Z] Finished download-and-extract step (success) 21:28:32 INFO - [mozharness: 2016-10-09 04:28:32.532685Z] Running populate-webroot step. 21:28:32 INFO - Running pre-action listener: _resource_record_pre_action 21:28:32 INFO - Running main action method: populate_webroot 21:28:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:28:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:28:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:28:32 INFO - '--tppagecycles', 21:28:32 INFO - '7'], 21:28:32 INFO - 'tests': ['tsvgm']}}, 21:28:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:28:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:28:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:28:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:28:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['damp', 'tps']}, 21:28:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'tests': ['damp', 'tps']}, 21:28:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['dromaeo_dom']}, 21:28:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:28:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['basic_compositor_video']}, 21:28:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:28:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['a11yr', 21:28:32 INFO - 'ts_paint', 21:28:32 INFO - 'tpaint', 21:28:32 INFO - 'sessionrestore', 21:28:32 INFO - 'sessionrestore_no_auto_restore', 21:28:32 INFO - 'tabpaint']}, 21:28:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['tsvgx', 21:28:32 INFO - 'tsvgr_opacity', 21:28:32 INFO - 'tart', 21:28:32 INFO - 'tscrollx', 21:28:32 INFO - 'cart']}, 21:28:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:28:32 INFO - 'tsvgr_opacity', 21:28:32 INFO - 'tart', 21:28:32 INFO - 'tscrollx', 21:28:32 INFO - 'cart']}, 21:28:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'talos_options': ['--disable-e10s'], 21:28:32 INFO - 'tests': ['tp5o']}, 21:28:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'tests': ['tp5o']}, 21:28:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'talos_options': ['--disable-e10s', 21:28:32 INFO - '--xperf_path', 21:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:32 INFO - 'tests': ['tp5n']}, 21:28:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:32 INFO - 'talos_options': ['--xperf_path', 21:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:32 INFO - 'tests': ['tp5n']}}, 21:28:32 INFO - 'talos.zip': {'path': '', 21:28:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:28:32 INFO - Running post-action listener: _resource_record_post_action 21:28:32 INFO - [mozharness: 2016-10-09 04:28:32.552393Z] Finished populate-webroot step (success) 21:28:32 INFO - [mozharness: 2016-10-09 04:28:32.552507Z] Running create-virtualenv step. 21:28:32 INFO - Running pre-action listener: _resource_record_pre_action 21:28:32 INFO - Running main action method: create_virtualenv 21:28:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:28:32 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 21:28:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:28:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:28:32 INFO - Using real prefix '/tools/python27' 21:28:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:28:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:28:36 INFO - Installing pip.................done. 21:28:36 INFO - Return code: 0 21:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:28:36 INFO - Reading from file tmpfile_stdout 21:28:36 INFO - Output received: 21:28:36 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) 21:28:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:28:36 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')]} 21:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:36 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')]} 21:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:36 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 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:36 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 21:28:36 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 21:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:36 INFO - 'HOME': '/Users/cltbld', 21:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:36 INFO - 'LOGNAME': 'cltbld', 21:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:36 INFO - 'MOZ_NO_REMOTE': '1', 21:28:36 INFO - 'NO_EM_RESTART': '1', 21:28:36 INFO - 'PAGER': '/bin/cat', 21:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:36 INFO - 'PWD': '/builds/slave/test', 21:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:36 INFO - 'SHELL': '/bin/bash', 21:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:36 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:36 INFO - 'USER': 'cltbld', 21:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:36 INFO - 'XPC_FLAGS': '0x0', 21:28:36 INFO - 'XPC_SERVICE_NAME': '0', 21:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:36 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 21:28:36 INFO - Cleaning up... 21:28:36 INFO - Return code: 0 21:28:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:28:36 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')]} 21:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:36 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')]} 21:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:36 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 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:36 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 21:28:36 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 21:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:36 INFO - 'HOME': '/Users/cltbld', 21:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:36 INFO - 'LOGNAME': 'cltbld', 21:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:36 INFO - 'MOZ_NO_REMOTE': '1', 21:28:36 INFO - 'NO_EM_RESTART': '1', 21:28:36 INFO - 'PAGER': '/bin/cat', 21:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:36 INFO - 'PWD': '/builds/slave/test', 21:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:36 INFO - 'SHELL': '/bin/bash', 21:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:36 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:36 INFO - 'USER': 'cltbld', 21:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:36 INFO - 'XPC_FLAGS': '0x0', 21:28:36 INFO - 'XPC_SERVICE_NAME': '0', 21:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:37 INFO - Downloading/unpacking psutil>=3.1.1 21:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:40 INFO - Installing collected packages: psutil 21:28:40 INFO - Running setup.py install for psutil 21:28:40 INFO - building 'psutil._psutil_osx' extension 21:28:40 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 21:28:41 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 21:28:41 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 21:28:41 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 21:28:41 INFO - building 'psutil._psutil_posix' extension 21:28:41 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 21:28:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:28:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:28:41 INFO - ^ 21:28:41 INFO - 1 warning generated. 21:28:41 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 21:28:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:41 INFO - Successfully installed psutil 21:28:41 INFO - Cleaning up... 21:28:41 INFO - Return code: 0 21:28:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:41 INFO - 'HOME': '/Users/cltbld', 21:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:41 INFO - 'LOGNAME': 'cltbld', 21:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:41 INFO - 'MOZ_NO_REMOTE': '1', 21:28:41 INFO - 'NO_EM_RESTART': '1', 21:28:41 INFO - 'PAGER': '/bin/cat', 21:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:41 INFO - 'PWD': '/builds/slave/test', 21:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:41 INFO - 'SHELL': '/bin/bash', 21:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:41 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:41 INFO - 'USER': 'cltbld', 21:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:41 INFO - 'XPC_FLAGS': '0x0', 21:28:41 INFO - 'XPC_SERVICE_NAME': '0', 21:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:28:44 INFO - Installing collected packages: mozsystemmonitor 21:28:44 INFO - Running setup.py install for mozsystemmonitor 21:28:44 INFO - Successfully installed mozsystemmonitor 21:28:44 INFO - Cleaning up... 21:28:44 INFO - Return code: 0 21:28:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:44 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 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:44 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 21:28:44 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 21:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:44 INFO - 'HOME': '/Users/cltbld', 21:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:44 INFO - 'LOGNAME': 'cltbld', 21:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:44 INFO - 'MOZ_NO_REMOTE': '1', 21:28:44 INFO - 'NO_EM_RESTART': '1', 21:28:44 INFO - 'PAGER': '/bin/cat', 21:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:44 INFO - 'PWD': '/builds/slave/test', 21:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:44 INFO - 'SHELL': '/bin/bash', 21:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:44 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:44 INFO - 'USER': 'cltbld', 21:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:44 INFO - 'XPC_FLAGS': '0x0', 21:28:44 INFO - 'XPC_SERVICE_NAME': '0', 21:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:45 INFO - Downloading/unpacking jsonschema==2.5.1 21:28:45 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 21:28:45 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 21:28:45 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 21:28:45 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 21:28:45 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 21:28:45 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 21:28:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:28:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:48 INFO - Downloading functools32-3.2.3-2.tar.gz 21:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:28:48 INFO - warning: no files found matching '*.txt' 21:28:48 INFO - no previously-included directories found matching 'build' 21:28:48 INFO - no previously-included directories found matching 'dist' 21:28:48 INFO - no previously-included directories found matching '.git*' 21:28:48 INFO - Installing collected packages: jsonschema, functools32 21:28:48 INFO - Running setup.py install for functools32 21:28:48 INFO - warning: no files found matching '*.txt' 21:28:48 INFO - no previously-included directories found matching 'build' 21:28:48 INFO - no previously-included directories found matching 'dist' 21:28:48 INFO - no previously-included directories found matching '.git*' 21:28:48 INFO - Successfully installed jsonschema functools32 21:28:48 INFO - Cleaning up... 21:28:48 INFO - Return code: 0 21:28:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:48 INFO - 'HOME': '/Users/cltbld', 21:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:48 INFO - 'LOGNAME': 'cltbld', 21:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:48 INFO - 'MOZ_NO_REMOTE': '1', 21:28:48 INFO - 'NO_EM_RESTART': '1', 21:28:48 INFO - 'PAGER': '/bin/cat', 21:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:48 INFO - 'PWD': '/builds/slave/test', 21:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:48 INFO - 'SHELL': '/bin/bash', 21:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:48 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:48 INFO - 'USER': 'cltbld', 21:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:48 INFO - 'XPC_FLAGS': '0x0', 21:28:48 INFO - 'XPC_SERVICE_NAME': '0', 21:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:28:48 INFO - Cleaning up... 21:28:48 INFO - Return code: 0 21:28:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:48 INFO - 'HOME': '/Users/cltbld', 21:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:48 INFO - 'LOGNAME': 'cltbld', 21:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:48 INFO - 'MOZ_NO_REMOTE': '1', 21:28:48 INFO - 'NO_EM_RESTART': '1', 21:28:48 INFO - 'PAGER': '/bin/cat', 21:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:48 INFO - 'PWD': '/builds/slave/test', 21:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:48 INFO - 'SHELL': '/bin/bash', 21:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:48 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:48 INFO - 'USER': 'cltbld', 21:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:48 INFO - 'XPC_FLAGS': '0x0', 21:28:48 INFO - 'XPC_SERVICE_NAME': '0', 21:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:48 INFO - Downloading/unpacking blobuploader==1.2.4 21:28:48 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 21:28:48 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 21:28:48 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 21:28:48 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 21:28:48 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 21:28:48 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 21:28:51 INFO - Downloading blobuploader-1.2.4.tar.gz 21:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:28:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:28:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:52 INFO - Downloading docopt-0.6.1.tar.gz 21:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:28:52 INFO - Installing collected packages: blobuploader, requests, docopt 21:28:52 INFO - Running setup.py install for blobuploader 21:28:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:28:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:28:52 INFO - Running setup.py install for requests 21:28:53 INFO - Running setup.py install for docopt 21:28:53 INFO - Successfully installed blobuploader requests docopt 21:28:53 INFO - Cleaning up... 21:28:53 INFO - Return code: 0 21:28:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:53 INFO - 'HOME': '/Users/cltbld', 21:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:53 INFO - 'LOGNAME': 'cltbld', 21:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:53 INFO - 'MOZ_NO_REMOTE': '1', 21:28:53 INFO - 'NO_EM_RESTART': '1', 21:28:53 INFO - 'PAGER': '/bin/cat', 21:28:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:53 INFO - 'PWD': '/builds/slave/test', 21:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:53 INFO - 'SHELL': '/bin/bash', 21:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:53 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:53 INFO - 'USER': 'cltbld', 21:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:53 INFO - 'XPC_FLAGS': '0x0', 21:28:53 INFO - 'XPC_SERVICE_NAME': '0', 21:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:53 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Pr9NEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:53 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-7EeZKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-OdPOkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-dHo0EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-qJ4wEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-stOE_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Di6h17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-brskid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-B2l5yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-_SO_vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:54 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-KdRtlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-U5mNIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-wpXiqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-9nrl6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-KC0InJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-NyT8TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:55 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-8akdPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:28:55 INFO - Running setup.py install for manifestparser 21:28:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:28:55 INFO - Running setup.py install for mozcrash 21:28:55 INFO - Running setup.py install for mozdebug 21:28:56 INFO - Running setup.py install for mozdevice 21:28:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Running setup.py install for mozfile 21:28:56 INFO - Running setup.py install for mozhttpd 21:28:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Running setup.py install for mozinfo 21:28:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Running setup.py install for mozInstall 21:28:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:28:56 INFO - Running setup.py install for mozleak 21:28:56 INFO - Running setup.py install for mozlog 21:28:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for moznetwork 21:28:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozprocess 21:28:57 INFO - Running setup.py install for mozprofile 21:28:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozrunner 21:28:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:28:57 INFO - Running setup.py install for mozscreenshot 21:28:57 INFO - Running setup.py install for moztest 21:28:58 INFO - Running setup.py install for mozversion 21:28:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:28:58 INFO - Cleaning up... 21:28:58 INFO - Return code: 0 21:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:28:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:28:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:58 INFO - 'HOME': '/Users/cltbld', 21:28:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:58 INFO - 'LOGNAME': 'cltbld', 21:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:58 INFO - 'MOZ_NO_REMOTE': '1', 21:28:58 INFO - 'NO_EM_RESTART': '1', 21:28:58 INFO - 'PAGER': '/bin/cat', 21:28:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:58 INFO - 'PWD': '/builds/slave/test', 21:28:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:58 INFO - 'SHELL': '/bin/bash', 21:28:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:28:58 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:28:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:58 INFO - 'USER': 'cltbld', 21:28:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:58 INFO - 'XPC_FLAGS': '0x0', 21:28:58 INFO - 'XPC_SERVICE_NAME': '0', 21:28:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:58 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-e69gL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:58 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-J3yYQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:58 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-mQkLow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:58 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-lL63fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:58 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)) 21:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:58 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-eEsW0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-PSLzNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-O5EqL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-c6f9yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Lu1Wpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-pmOzMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-FeZRpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-3fK232-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-0e_CWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:59 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-0OdpyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:59 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-920E6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:00 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-PZAfEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:00 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-dQYM_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:02 INFO - Downloading blessings-1.6.tar.gz 21:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:02 INFO - Installing collected packages: blessings 21:29:02 INFO - Running setup.py install for blessings 21:29:03 INFO - Successfully installed blessings 21:29:03 INFO - Cleaning up... 21:29:03 INFO - Return code: 0 21:29:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:03 INFO - Reading from file tmpfile_stdout 21:29:03 INFO - Current package versions: 21:29:03 INFO - blessings == 1.6 21:29:03 INFO - blobuploader == 1.2.4 21:29:03 INFO - docopt == 0.6.1 21:29:03 INFO - functools32 == 3.2.3-2 21:29:03 INFO - jsonschema == 2.5.1 21:29:03 INFO - manifestparser == 1.1 21:29:03 INFO - mozInstall == 1.12 21:29:03 INFO - mozcrash == 0.17 21:29:03 INFO - mozdebug == 0.1 21:29:03 INFO - mozdevice == 0.48 21:29:03 INFO - mozfile == 1.2 21:29:03 INFO - mozhttpd == 0.7 21:29:03 INFO - mozinfo == 0.9 21:29:03 INFO - mozleak == 0.1 21:29:03 INFO - mozlog == 3.4 21:29:03 INFO - moznetwork == 0.27 21:29:03 INFO - mozprocess == 0.23 21:29:03 INFO - mozprofile == 0.28 21:29:03 INFO - mozrunner == 6.12 21:29:03 INFO - mozscreenshot == 0.1 21:29:03 INFO - mozsystemmonitor == 0.3 21:29:03 INFO - moztest == 0.7 21:29:03 INFO - mozversion == 1.4 21:29:03 INFO - psutil == 3.1.1 21:29:03 INFO - requests == 1.2.3 21:29:03 INFO - wsgiref == 0.1.2 21:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:29:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:29:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:29:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:29:03 INFO - 'HOME': '/Users/cltbld', 21:29:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:29:03 INFO - 'LOGNAME': 'cltbld', 21:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:03 INFO - 'MOZ_NO_REMOTE': '1', 21:29:03 INFO - 'NO_EM_RESTART': '1', 21:29:03 INFO - 'PAGER': '/bin/cat', 21:29:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:03 INFO - 'PWD': '/builds/slave/test', 21:29:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:29:03 INFO - 'SHELL': '/bin/bash', 21:29:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:29:03 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:29:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:29:03 INFO - 'USER': 'cltbld', 21:29:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:29:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:03 INFO - 'XPC_FLAGS': '0x0', 21:29:03 INFO - 'XPC_SERVICE_NAME': '0', 21:29:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:29:03 INFO - Cleaning up... 21:29:03 INFO - Return code: 0 21:29:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103834490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa12bd649e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, '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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 21:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:29:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:29:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:29:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:29:03 INFO - 'HOME': '/Users/cltbld', 21:29:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:29:03 INFO - 'LOGNAME': 'cltbld', 21:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:03 INFO - 'MOZ_NO_REMOTE': '1', 21:29:03 INFO - 'NO_EM_RESTART': '1', 21:29:03 INFO - 'PAGER': '/bin/cat', 21:29:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:03 INFO - 'PWD': '/builds/slave/test', 21:29:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:29:03 INFO - 'SHELL': '/bin/bash', 21:29:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:29:03 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:29:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:29:03 INFO - 'USER': 'cltbld', 21:29:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:29:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:03 INFO - 'XPC_FLAGS': '0x0', 21:29:03 INFO - 'XPC_SERVICE_NAME': '0', 21:29:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:04 INFO - Cleaning up... 21:29:04 INFO - Return code: 0 21:29:04 INFO - Running post-action listener: _resource_record_post_action 21:29:04 INFO - Running post-action listener: _start_resource_monitoring 21:29:04 INFO - Starting resource monitoring. 21:29:04 INFO - [mozharness: 2016-10-09 04:29:04.052444Z] Finished create-virtualenv step (success) 21:29:04 INFO - [mozharness: 2016-10-09 04:29:04.053477Z] Running install step. 21:29:04 INFO - Running pre-action listener: _resource_record_pre_action 21:29:04 INFO - Running main action method: install 21:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:04 INFO - Reading from file tmpfile_stdout 21:29:04 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:04 INFO - Reading from file tmpfile_stdout 21:29:04 INFO - Output received: 21:29:04 INFO - Usage: mozinstall [options] installer 21:29:04 INFO - Options: 21:29:04 INFO - -h, --help show this help message and exit 21:29:04 INFO - -d DEST, --destination=DEST 21:29:04 INFO - Directory to install application into. [default: 21:29:04 INFO - "/builds/slave/test"] 21:29:04 INFO - --app=APP Application being installed. [default: firefox] 21:29:04 INFO - mkdir: /builds/slave/test/build/application 21:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:29:39 INFO - Reading from file tmpfile_stdout 21:29:39 INFO - Output received: 21:29:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:29:39 INFO - Running post-action listener: _resource_record_post_action 21:29:39 INFO - [mozharness: 2016-10-09 04:29:39.273998Z] Finished install step (success) 21:29:39 INFO - [mozharness: 2016-10-09 04:29:39.274123Z] Running run-tests step. 21:29:39 INFO - Running pre-action listener: _resource_record_pre_action 21:29:39 INFO - Running main action method: run_tests 21:29:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:29:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:29:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:29:39 INFO - 2016-10-08 21:29:39.288 screenresolution[1993:14099] starting screenresolution argv=screenresolution get 21:29:39 INFO - 2016-10-08 21:29:39.291 screenresolution[1993:14099] Display 0: 1600x1200x32@60 21:29:39 INFO - 2016-10-08 21:29:39.297 screenresolution[1994:14101] starting screenresolution argv=screenresolution list 21:29:39 INFO - Available Modes on Display 0 21:29:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:29:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:29:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:29:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:29:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:29:39 INFO - Intel Iris: 21:29:39 INFO - Chipset Model: Intel Iris 21:29:39 INFO - Type: GPU 21:29:39 INFO - Bus: Built-In 21:29:39 INFO - VRAM (Dynamic, Max): 1536 MB 21:29:39 INFO - Vendor: Intel (0x8086) 21:29:39 INFO - Device ID: 0x0a2e 21:29:39 INFO - Revision ID: 0x0009 21:29:39 INFO - Displays: 21:29:39 INFO - Display: 21:29:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:29:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:29:39 INFO - Display Serial Number: 1600x1200 60 21:29:39 INFO - Main Display: Yes 21:29:39 INFO - Mirror: Off 21:29:39 INFO - Online: Yes 21:29:39 INFO - Rotation: Supported 21:29:39 INFO - Return code: 0 21:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:39 INFO - Python 2.7.3 21:29:39 INFO - Return code: 0 21:29:39 INFO - grabbing minidump binary from tooltool 21:29: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')]} 21:29:39 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 0x103648d30>, '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 0x10346edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103640b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:39 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 21:29:39 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 21:29:39 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 21:29:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:39 INFO - Return code: 0 21:29:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:29:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:29:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0358', '--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 21:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0358 --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 21:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KW5JXuzBoz/Render', 21:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:29:39 INFO - 'HOME': '/Users/cltbld', 21:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:29:39 INFO - 'LOGNAME': 'cltbld', 21:29:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:39 INFO - 'MOZ_NO_REMOTE': '1', 21:29:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:39 INFO - 'NO_EM_RESTART': '1', 21:29:39 INFO - 'PAGER': '/bin/cat', 21:29:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:39 INFO - 'PWD': '/builds/slave/test', 21:29:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:29:39 INFO - 'SHELL': '/bin/bash', 21:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PGN8kKXfVf/Listeners', 21:29:39 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 21:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:29:39 INFO - 'USER': 'cltbld', 21:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:39 INFO - 'XPC_FLAGS': '0x0', 21:29:39 INFO - 'XPC_SERVICE_NAME': '0', 21:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:29:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0358', '--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 21:29:39 INFO - mozversion application_buildid: 20161008164819 21:29:39 INFO - mozversion application_changeset: 313a2d049350c88515b0b900aaf279a0ae61c7fa 21:29:39 INFO - mozversion application_display_name: Nightly 21:29:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:39 INFO - mozversion application_name: Firefox 21:29:39 INFO - mozversion application_remotingname: firefox 21:29:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:29:39 INFO - mozversion application_vendor: Mozilla 21:29:39 INFO - mozversion application_version: 52.0a1 21:29:39 INFO - mozversion platform_buildid: 20161008164819 21:29:39 INFO - mozversion platform_changeset: 313a2d049350c88515b0b900aaf279a0ae61c7fa 21:29:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:29:39 INFO - mozversion platform_version: 52.0a1 21:29:39 INFO - using testdate: 1475987379 21:29:39 INFO - actual date: 1475987379 21:29:39 INFO - starting webserver on 'localhost:49404' 21:29:39 INFO - SUITE-START | Running 2 tests 21:29:39 INFO - TEST-START | dromaeo_css 21:29:39 INFO - operating with platform_type : mac_ 21:29:39 INFO - Initialising browser for dromaeo_css test... 21:29:39 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmppWqPvX/profile http://localhost:49404/getInfo.html) 21:29:42 INFO - PROCESS | 2004 | 2016-10-08 21:29:42.580 plugin-container[2006:14261] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a43, name = 'com.apple.tsm.portname' 21:29:42 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:29:42 INFO - PROCESS | 2004 | 2016-10-08 21:29:42.582 plugin-container[2006:14261] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9407, name = 'com.apple.CFPasteboardClient' 21:29:42 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:29:42 INFO - PROCESS | 2004 | 2016-10-08 21:29:42.582 plugin-container[2006:14261] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:29:42 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 21:29:42 INFO - PROCESS | 2004 | colorDepth:24 21:29:42 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 21:29:42 INFO - PROCESS | 2004 | __metrics 21:29:42 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:29:43 INFO - TEST-INFO | 2004: exit 0 21:29:43 INFO - Browser initialized. 21:29:43 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:43 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmppWqPvX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:46 INFO - PROCESS | 2007 | 2016-10-08 21:29:46.124 plugin-container[2008:14378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d27, name = 'com.apple.tsm.portname' 21:29:46 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:29:46 INFO - PROCESS | 2007 | 2016-10-08 21:29:46.131 plugin-container[2008:14378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 21:29:46 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:29:46 INFO - PROCESS | 2007 | 2016-10-08 21:29:46.131 plugin-container[2008:14378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:29:55 INFO - PROCESS | 2007 | RSS: Main: 239284224 21:29:55 INFO - PROCESS | 2007 | 21:30:45 INFO - PROCESS | 2007 | 1475987445365 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:32:58 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49404/tests/dromaeo/cssquery-ext.html) 21:32:59 INFO - PROCESS | 2007 | RSS: Main: 250896384 21:32:59 INFO - PROCESS | 2007 | 21:36:01 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-ext.html (next: http://localhost:49404/tests/dromaeo/cssquery-jquery.html) 21:36:02 INFO - PROCESS | 2007 | RSS: Main: 265846784 21:36:02 INFO - PROCESS | 2007 | 21:39:04 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49404/tests/dromaeo/cssquery-mootools.html) 21:39:05 INFO - PROCESS | 2007 | RSS: Main: 269705216 21:39:05 INFO - PROCESS | 2007 | 21:42:07 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49404/tests/dromaeo/cssquery-prototype.html) 21:42:07 INFO - PROCESS | 2007 | RSS: Main: 270270464 21:42:07 INFO - PROCESS | 2007 | 21:45:10 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49404/tests/dromaeo/cssquery-yui.html) 21:45:11 INFO - PROCESS | 2007 | RSS: Main: 275652608 21:45:11 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-yui.html (next: http://localhost:49404/tests/dromaeo/cssquery-dojo.html) 21:48:14 INFO - PROCESS | 2007 | RSS: Main: 278265856 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | __start_tp_report 21:48:14 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 21:48:14 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 21:48:14 INFO - PROCESS | 2007 | |i|pagename|runs| 21:48:14 INFO - PROCESS | 2007 | |0;dojo.html;3261.6575259597744;3384.8646054157834;3421.914452138696;3426.4175090234667;3440.397930362189;5601.019821531226;5718.9428105718935;5792.102224155252;5830.562707796917;5866.560007999396;5641.971790141054;5758.42415758424;5835.387284335147;5851.4148585141465;5888.852778680546;5201.0378080055125;5278.604104692145;5296.17909224069;5298.576113910878;5341.919871201935;5240.502152295526;5361.5978801589845;5375.22059301403;5397.514223719864;5495.890082198353;5152.072626927152;5284.550813180885;5293.153095504701;5312.681239125664;5320.680759154444;5177.48225177483;5190.091733946544;5192.1173400522;5256.684598924076;5285.86785330366;5100.821471248489;5151.2273159026445;5173.663711858717;5191.506806853381;5282.2340760589495;5620.4660557247;5825.213596164506;5825.359210486843;5826.126081087871;5856.4143585641095;6146.555559443527;6179.752809887599;6242.781502647431;6247.094171345175;6280.089387038899;6214.782482613087;6254.374562543755;6261.686915654199;6284.497240220771;6296.905546416808;5747.827565172968;5845.503132233808;5919.911201331984;5930.377310382434;5934.37689042653;6224.937750622526;6242.15730876335;6244.313125556185;6354.205724284465;6367.4906007519285;6200.534959878028;6206.968965155145;6212.1303017577575;6219.657918814418;6225.657588832658;6102.216595924226;6260.561760676709;6270.811875643738;6272.247330320391;6275.6862156891975;6135.987562052301;6162.753489860445;6166.105914642351;6185;6191.071339299141;6209.59637623553;6234.096056071844;6235.625862448268;6245.281792593819;6246.531510136758;4968.701877887338;4970.8757281068265;4989.850304490871;5008.749562521933;5017.54842064216;3544.929101417957;3573.7855728656364;3698.389765688685;4000.739951903175;4320.049589090395;4445.777711114496;4875.926861097087;5857.20927674767;5879.265091863517;5887;6260.029695397221;6265.091561723524;6266.279377871512;6273.215848018997;6273.905891411632;5687.544996400278;5783.392743761929;5869.148973398833;5899.380565040695;5910.054391297372;5486.561075113981;5511.889762204813;5517.36550296713;5520.420355862657;5548.167774833726;6368.172137622079;6376.489880809524;6447.580907241015;6460.3862633049785;6469.805905822833;6143.72682107623;6202;6238.064290356301;6241.625502469867;6254.468370188585;5261.947380526146;6460.515461340512;6465.579737317059;6470.773522926675;6497.220333560003;5279.627296902756;5651;6226.813195604139;6267.467265282502;6274.498040156685;6099.037411928083;6210.472109870711;6223.408776166257;6279.843003924939;6298.685065746786;5041;6129.785457508966;6166.784162554289;6184.350643182401;6217.285012223471;5949.6681360891225;6117.388261173847;6182;6201.689915504297;6207.534434917309;5757.453041961007;5913.70431478433;5993.490553303018;6034.456898879122;6089.147519347383;5066.316047333563;6129.053167990421;6132.47873930703;6158.630482171084;6185.350538193425;5996.950533656505;6041.78853740117;6048.455638992512;6075.210222671201;6080.361562035922 21:48:14 INFO - PROCESS | 2007 | |1;ext.html;458.9013362127142;479.66663169097467;508.42293996314174;520.4665218151397;544.8610604295907;40004.59995400045;41583.58416415835;41608.583914160925;41641;41665.791671041676;41353;43060.13879722403;43243.78378108113;43340.56659433405;43546.56453435465;9900.009999000096;10018.649347272847;10043.69868903934;10083.394996300209;10083.848742268872;8383.874241886377;9843.409395436262;9864.506774661239;9921.751956201117;9952.800943981116;9903.059209375098;9937.304388692794;9955.900440995605;9961.302708810386;9981.101700846923;9877.604895804196;9921.900780992242;9929.156021738161;9958.950205248928;9990.9500452498;9806.705798826046;9842.50787460624;9927.602895884156;9938.850917236176;9947;41056.76829695084;41064.79467602673;41156.38265426021;41273.58726412727;41277.380839287434;3316.585426821647;3370.25854312051;3397.3545026445145;3490.336836001152;3556.875509357186;30661.540076898866;30912.690873091207;31066.68933310683;31784.523232151536;31801.8409907949;2747.6840163381066;3236.0938937097417;3236.255661197914;3271.084096452997;3396.8980930572125;471013;472750;473855.99999999657;474694;475974;56779;57099;57199;57215.427845721846;57266.71366643223;58377.83244335175;59920.801583968074;60326.69836650876;60374.69812650997;60654;15885.920570397075;15955.042697437959;16101.597460063593;16121.27454264561;16145.434909778101;12318.630441086782;12467.438965246585;12562.309073001074;12567.622971310875;12573.434195461226;14857.628559286104;15174.393024278905;15812.446564370191;15814;15815.288312025987;6260.342664020303;6357.300696923335;6372.426481616677;6466.579672321284;6494.123293355431;822.333909533268;883.0948278015086;921.7280153388281;954.5656726189567;1035.0477560644226;24954.251372458857;28687.856560717064;29533.523323833724;29738.553921691193;30446.84776576147;922.391221793613;1027.6557353286582;1119.9384033878052;1127.8251870960014;1133.1727838677812;14609.196494192922;15146.242687865783;15157.393704251926;15224.391024358902;15600.92199538995;620679;622234;626446;631211;632879;54801;55929.04248351288;56070.43929560652;56261.718691406284;56300;1164.8136298192248;1292.9288889111;1331.1746717035307;1365.3241645385597;1366.72665466907;25508.489830203664;28409.43181136407;28659;28686.856565717037;29440.675169617847;47041.35355262549;47471;47511;47522.28716569323;47563.762181188875;564205;575503;579069;579313;579372;37377.43933841049;37804.2439151221;38743.2251354977;39014.219715606094;39172.41241381325;44944.77527612472;46216.537834621224;46433.76783116063;47080.7645961768;47087;38346.04134896538;38438.6156138435;38469.8459046229;39263.60736392599;39828.20343593054;38239;38738;39493.81518554448;39508.01229969274;39551.80224098861;36800.07999800026;37225;37898;38001.61998380091;38950.80524597359;29891.850540747157;31491;34156.658433415345;34216.14459638529;34218.82890585631;25008.749912500643;25044.749552504243;25218;25456.872715636302;25912.481750365263 21:48:14 INFO - PROCESS | 2007 | |2;jquery.html;320.2889585121032;377.97380112993216;380.45594799436805;382.81433504750174;399.686246296657;19493.02534873256;20117.094730737117;20825.479363015933;20984.68522972155;21116.788832111673;11830.881691183085;11968;17749.846259993123;19935.202591896308;20889.582208355823;4383.298672212454;5465.72671366432;5466.9179962300595;5472.315960504937;5480.588955828329;5097.617678674096;5397.379301380332;5448.7548060337185;5453.727313634322;5470.987867244553;5448.264484294609;5459.454054594548;5461.15352120422;5461.453854614527;5476.151196564519;5199.324087868591;5406.189071639266;5445;5445.754941027663;5474.452554744514;5065.46812584677;5271.262023316739;5316.468353164652;5320.388155362144;5320.467953204648;12896.80654790179;13141;13187.736245275137;13218.86781132186;13235.404406801621;2083.5312054787705;2219.1345375303645;2330.5222429401933;2335.3927978725656;2403.134871446278;10017;10159.796804063952;10381.84427233592;12695.365231738468;14785.482508112273;1838.5771272607242;1893.2237782509244;1895.1945423195086;1896.6775648139849;1928.161249856317;118635;122467;125597;126043;126236;11260.43697815106;11336.546538138382;11876.88123118775;11902;12093.87906120945;14117.78823317651;14498.130112193303;14499.782503262459;14504.492342767953;14513.709725805636;8208.179182081743;8465.492070475791;8500.872486912702;8580.442271252348;8590.355723320776;8373.246407823324;8389.622466989;8402.957985210034;8480.067192608809;8613.181747734081;4455.799489023002;4516.712736869977;4544.977380089454;4547.636189104864;4555.2256116460285;1867.7291792690255;1871.0831692470863;1936.2738972885168;1937.5543624966338;1953.4627977306354;816.5998660656236;837.5644664774405;856.8971723393232;880.5861245214738;963.3834346018554;20081.393488520884;20390.59218815645;21414.357569272634;21510.677339839604;22114.447138821335;705.6612825843521;891.4383938119073;905.3662436294488;909.4088842252589;918.9954050229707;10851.565937362417;11363.886361136283;11372;11372.658820235407;11401.574803149606;468928;510177;522142;525097;561783;109973;114716;122718;129134.70865291415;131770;948.5494390164616;972.3582435592334;988.9270141895979;989.0455710239653;989.5052473763119;19282.13230404607;19617.80382196217;19749.70375444398;19756.901215493832;19837.00814959275;55416.72291638516;55760.44239557553;55778.72110639421;57099.14351284817;57352.71323643355;57915;60851.695741521005;76513.61743191248;76630.2336976623;77143;8008.959955200186;8072.39457040736;8286.751397458085;8393.496390216607;8501.404901656824;11081.179686836253;11601.01391381742;11927.343996080299;12000.939995299968;13585.796213056614;9502.572384242587;11532.077433805443;11592.246503977214;11683.707907302385;11686.590969316034;11025.503852326825;11328;11349.48927298257;11722.531098755955;11732.002779763474;11349.659510214708;11414.143939204427;11824.881751182722;11880.524779008743;11925.880741192477;6466.288708242184;7377.668004939898;8013.278804907586;8293.963254593176;8444;9602.279829012712;10596.576136954744;11453.083753299883;11594.94202528982;11658.300501969909 21:48:14 INFO - PROCESS | 2007 | |3;mootools.html;1323.2788130468894;1444.8844092472602;1504.1351223046747;1822.8450581700554;1825.187791432813;7845.176256493064;8070.233327833861;8317.916820831804;8510.659573617055;9080.091990800916;7388.519746216505;7441.255874412556;8850.91149088509;8971.192592666659;8996.550172491381;2002.489365211869;2358.1157066100213;2377.5482658294954;2384.892679829412;2385.427497400629;2352.141468364052;2380.9642855357183;2382.845115067515;2401.2916189724074;2408.963865542018;2189.551142015891;2231.776822317763;2375.4536456614987;2377.215518878766;2386.379541319252;1987.1852540458415;2353.729321128058;2356.352003199117;2359;2364.4088977755473;2364.101641376283;2366.077229880348;2366.1363602285214;2374.3945293950105;2374.655674927126;8844.027157012724;8971.775705607346;9016;9018.774530636721;9018.909810901872;5251.10731175701;5393.541548968343;5430.185472179165;5435.266239057755;5437.456254374571;3527.9647203527893;3598.748087633867;3719.20037192005;3726.31063253299;3738.2523495300775;1006.079437314856;1085.1318944844172;1090.9127269818396;1091.8744344400416;1114.6823155400673;11592.304461732407;11765.352905590189;11816.409179540988;11896.286222826659;11916.761664766744;4550.635949124062;4637.466691330473;4841.636877234221;4846.660733748604;4847.175980083394;9834.704958851245;9903.306768526134;10006.949965250127;10032.197424206046;10054;5373.704446255493;5394.730263486888;5402.918956215582;5407.215953686693;5419.430959749169;4377.102693947733;4533.795979180879;4767.833125840648;4924.901501970012;4975.278584605212;3878.5151856017997;3916.6279203475624;3974.105826189142;4043.7775922324554;4062.2484840304637;1267.9792766822795;1273.1342686972762;1279.353926267229;1284.6467221513972;1285.7235694325766;728.7194430144433;835.3985130705883;896.6368620708623;901.6348378906554;923.8013827027087;5376.516113549799;5653.604247702704;5853.882922341614;5907.261592300963;6055.212822333068;882.7905769096251;909.5952301225891;937.4328531238639;939.9483028433502;950.078423928788;3864.942025869614;3882.2623701496627;3883.650471457582;3961.504811898513;4001.7398869073418;9489.810203795885;10939.945300273448;10955.287906286067;10982.286151400293;11006.559737610405;10815.67552973412;10919.235653504338;10959.342439453658;10979.341239525655;11020.063294620048;7092.9290707093305;8097.392695547857;8257.504549727035;8370.162983701703;8382.329413646894;5541.778328866962;5706.657600543981;5715.713964358152;5836.941630583639;5896.14505896634;9278.675246366345;10191.490425478845;10226;10262;10302.536385862804;8481.618327175169;9635.277354198603;10087.092161705481;10094.293399462262;10230.744231394274;6147.139400484025;6223.688815559294;6875.7937261882225;7452.739154129579;7604.581748003913;6637.568558043712;7088.645567721696;8052.315553178046;8421.789455263668;8447.704330348408;7393.963030184815;7494;7568.735094271674;7595.658195381332;7698.153203147761;6625.138731964814;6878.8993760998;7427.554346739213;7478.439117066133;7551.697932082655;6964.721411143498;7009.859802803813;7024.192217895007;7089;7093.290670932865;4411.669124815716;5041.823536176216;5066.9746651266505;5108.10608143566;5139.794408223779;4779.1636463619425;4974.577160941216;4985.750712464434;5110.207917772751;5139.306193663957 21:48:14 INFO - PROCESS | 2007 | |4;prototype.html;296.5699735383694;308.1326067121054;311.6867548114145;313.7568384502011;316.439901374567;4557.886052848677;4614.861554153373;5278.762455689493;5408.675479471234;5464.508194262516;4369.3614894414595;4893.678706749176;5332.653377530458;5422.698552347438;5475.479829416209;4137.482814648177;4149.7095203335775;4152.750834949898;4163.417121602978;4167.833006758097;3703.9627505445546;3810.9237815243678;4153.736213763506;4155.771432571208;4181.163767246548;3943.7577163193646;4002.4996875390575;4017.9799101004455;4029.536603290615;4069.308217603;3824.1204522959874;4025.5169379674626;4045.7774822384904;4057.5942405759483;4070.7557546547155;2918.2120827376702;3038.8176709397508;3477.565304336958;3519.3137338219058;3541.698955588778;5066.0374528839775;5116.334876466073;5144.6655967362;5286.568178637831;5314.661548918463;3721.5162028936334;3944.5069366329208;4068.5931406859077;4171.895702607429;4589.655775816827;4875.466345697623;5206.9846379955925;5253.55344795689;5717.028105222123;5717.599768016241;2931.369755502556;3102.4105419970133;3300.7524435667183;3407.71034462071;3639.818009099561;4721.834735784266;5550.7510810067815;5712.685802280873;5954.404559544054;6086.573939824214;3928.175083232496;3930.8034598269974;3936.9212615747524;3937.17319362937;4094.0992981544014;3520.419130843382;3681.834317455721;3973.5231772186944;3988.880333589997;3993.900152496211;4601.72389656615;4602.859670253349;4625.32932724753;4670.719756814534;4685.5782979532005;5234.816781412632;5272.05103081449;5849.970750146222;5866.823995280149;5868.354481007086;1091.2524920429373;1165.3648761425043;1262.696952731338;1342.7381660576093;1361.8433880103717;880.7974165941869;892.2103938014903;912.7535565397438;913.8035322405715;916.7112359606703;5385.1496180231325;5413.350397952271;5420.6177424757225;5440.510354068074;5441.83674489766;5372.737406709421;5614.203454894395;5855.419036860024;5882.3529411764675;5906.468417842415;4993.825216117419;5370.785168593291;5398.568114550826;5404.784038544178;5432.837014889559;2919.7518210952308;3083.8766449341774;3099.3491366812773;3137.623485181747;3164.168069577715;5493.505584497414;5919.395465994949;6126;6222.319973607101;6238.908191066545;5053.418856831438;5140.943622550934;5517.944820551743;5809.680467574324;6079.331273559905;5152.742362881841;5216.695826043489;5996.550258730613;6163.291221509584;6210.9068363974575;5579.1503862336485;5957.523398128226;5960.791372301948;5967.76128954837;5973.820785376446;4847.80608775645;5715.257016587817;5857.707114644166;5884.440978107073;5897.852553686193;5645.745941432563;6005.429484198994;6169.81490555284;6210.068489726577;6265.248170219603;3302.488114342281;3789.1285004448578;3875.779129574175;3906.824192911383;3929.5088113985753;5685.516731077904;5932.64404135736;5935.762569497345;5943.632964418121;5997.610155339889;4614.769261536842;4736.242201247784;5729.598928074995;5762.567807414544;5778.959787238337;4620.5148459411275;4858.809591650069;5760.971195144165;5803.680797556175;5840.707964601668;4820.758962051954;4968.677035992649;5588.692621905834;5685.4415513018475;5725.6850873202375;4996.725180115129;5747.97126014384;5775.1914731938405;5817.738201781015;5825.533957283492;5596.41237670055;5644.463775941279;5650.208970744181;5688.402717714746;5721.5136713379825 21:48:14 INFO - PROCESS | 2007 | |5;yui.html;670.580886945659;684.3054299885617;709.5246185056012;738.7377480994244;820.8850760893474;14944.402223911044;15508.844911550881;15929.123898185595;15947.84052159478;15964;13999.790003149961;14298.285085745723;14421.062630928982;14468.421263149488;14474.927625361885;656.1732217406079;682.5699809120272;814.4787336104897;817.2277198047861;842.7261140129483;829.9460535065201;853.7865533616596;854.0477367734993;855.1363123245504;856.9785755356104;886.4061079077002;892.7589550821307;893.3657103456553;893.3880292000001;894.6332003878412;863.1799790199273;887.8401887660218;891.2468963725673;891.7725979875155;892.2103938014839;636.4049613611288;656.5010591950153;660.131926516629;660.3033799341692;662.4137638190189;15296.847031529653;15363.308651110727;15416;15421.15183664898;15423.922880385526;14568.271586420742;14575;14589.927050364786;14719.116852988855;14970.550883473514;9985.80028399428;11664.416779161009;11818.552680019515;12179.878201217964;12203.938980305042;3753.2681127180213;3838.5777564467885;3838.9232215355537;3980.422838688403;3980.5223373195113;89782.55108724479;101822.49088754583;102496.48751756268;116816;125567.37216313952;11089.611863584736;11366.318020918772;11367.488463019185;11383.268015676178;11684.415779211175;19900.70645408073;22239.999200036036;22821.543569128855;22840.88579557125;22912.08351665948;7745.891050738346;7823.2567906048835;7984.40116991228;8173.060098088677;8174.223448772357;3652.7625704329134;4320.512948555317;4349.3041113421705;4397.274449715825;4526.936170000047;3036.9240768980953;3532.8410221540094;3575.76757510761;3628.600853906068;3641.708663306982;538.9407165211824;576.2479963647396;612.4579746924004;651.84681599824;658.6410406328563;506.6149726208108;556.0963434419069;558.4973523828505;665.7303791964263;683.3951952521954;8354.28988535969;9029.458232506071;9176.220021298132;9580.520973951414;9767.51162441875;538.6471860931097;578.9473684210526;631.0313668518802;656.2780940964996;678.35217367414;3811.8284677189595;4298.5241268623095;4411.492678341968;4456.977715111404;4769.379980602499;125385;129427;138005;146417.26791365974;151673;125874;130521.89562087621;136876.31561842127;138871.61128388587;141575;116131.41934290275;117394;118084.22873656901;119087.8091219094;120723.39638301928;9949.801003979735;10083.394996299952;10091.44497052669;10094.444805535766;10191.592336306761;47192.52807472018;54149.72925135349;59035.704821475614;59949;64534.67732661307;75842;79982.6000869992;96897.54653680342;97319;98410.52384214099;13784;13929.930350348184;14104.929475352557;14112.36494357777;14326.928365358106;14978;14985.325660345528;15098.169600672069;15134.318955647243;15143.394264229748;12034.699132521408;13981.93009034989;14167.787483187554;14357.784633230718;14592;13603.931980340036;13810.65473363174;13818.37817298244;13969.511067112602;14590.270486475845;13568.457261709422;13610.979176561996;13635.300033356101;13762.931185344009;13801;10849.776896380763;11220.270682405944;11253.662390127982;11377.829332559853;11431.657050288504;9636.614535418785;11340.432978350884;11579.478923448296;11580.594679186188;11618.244814087395 21:48:14 INFO - PROCESS | 2007 | __end_tp_report 21:48:14 INFO - PROCESS | 2007 | __start_cc_report 21:48:14 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,350 21:48:14 INFO - PROCESS | 2007 | __end_cc_report 21:48:14 INFO - PROCESS | 2007 | __startTimestamp1475988494441__endTimestamp 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | ------- Summary: start ------- 21:48:14 INFO - PROCESS | 2007 | Number of tests: 6 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#0] dojo.html Cycles:165 Average:5740.51 Median:5949.67 stddev:698.96 (11.7%) stddev-sans-first:673.51 21:48:14 INFO - PROCESS | 2007 | Values: 3261.7 3384.9 3421.9 3426.4 3440.4 5601.0 5718.9 5792.1 5830.6 5866.6 5642.0 5758.4 5835.4 5851.4 5888.9 5201.0 5278.6 5296.2 5298.6 5341.9 5240.5 5361.6 5375.2 5397.5 5495.9 5152.1 5284.6 5293.2 5312.7 5320.7 5177.5 5190.1 5192.1 5256.7 5285.9 5100.8 5151.2 5173.7 5191.5 5282.2 5620.5 5825.2 5825.4 5826.1 5856.4 6146.6 6179.8 6242.8 6247.1 6280.1 6214.8 6254.4 6261.7 6284.5 6296.9 5747.8 5845.5 5919.9 5930.4 5934.4 6224.9 6242.2 6244.3 6354.2 6367.5 6200.5 6207.0 6212.1 6219.7 6225.7 6102.2 6260.6 6270.8 6272.2 6275.7 6136.0 6162.8 6166.1 6185.0 6191.1 6209.6 6234.1 6235.6 6245.3 6246.5 4968.7 4970.9 4989.9 5008.7 5017.5 3544.9 3573.8 3698.4 4000.7 4320.0 4445.8 4875.9 5857.2 5879.3 5887.0 6260.0 6265.1 6266.3 6273.2 6273.9 5687.5 5783.4 5869.1 5899.4 5910.1 5486.6 5511.9 5517.4 5520.4 5548.2 6368.2 6376.5 6447.6 6460.4 6469.8 6143.7 6202.0 6238.1 6241.6 6254.5 5261.9 6460.5 6465.6 6470.8 6497.2 5279.6 5651.0 6226.8 6267.5 6274.5 6099.0 6210.5 6223.4 6279.8 6298.7 5041.0 6129.8 6166.8 6184.4 6217.3 5949.7 6117.4 6182.0 6201.7 6207.5 5757.5 5913.7 5993.5 6034.5 6089.1 5066.3 6129.1 6132.5 6158.6 6185.4 5997.0 6041.8 6048.5 6075.2 6080.4 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#1] ext.html Cycles:180 Average:69267.40 Median:41060.78 stddev:150133.32 (365.6%) stddev-sans-first:150465.60 21:48:14 INFO - PROCESS | 2007 | Values: 458.9 479.7 508.4 520.5 544.9 40004.6 41583.6 41608.6 41641.0 41665.8 41353.0 43060.1 43243.8 43340.6 43546.6 9900.0 10018.6 10043.7 10083.4 10083.8 8383.9 9843.4 9864.5 9921.8 9952.8 9903.1 9937.3 9955.9 9961.3 9981.1 9877.6 9921.9 9929.2 9959.0 9991.0 9806.7 9842.5 9927.6 9938.9 9947.0 41056.8 41064.8 41156.4 41273.6 41277.4 3316.6 3370.3 3397.4 3490.3 3556.9 30661.5 30912.7 31066.7 31784.5 31801.8 2747.7 3236.1 3236.3 3271.1 3396.9 471013.0 472750.0 473856.0 474694.0 475974.0 56779.0 57099.0 57199.0 57215.4 57266.7 58377.8 59920.8 60326.7 60374.7 60654.0 15885.9 15955.0 16101.6 16121.3 16145.4 12318.6 12467.4 12562.3 12567.6 12573.4 14857.6 15174.4 15812.4 15814.0 15815.3 6260.3 6357.3 6372.4 6466.6 6494.1 822.3 883.1 921.7 954.6 1035.0 24954.3 28687.9 29533.5 29738.6 30446.8 922.4 1027.7 1119.9 1127.8 1133.2 14609.2 15146.2 15157.4 15224.4 15600.9 620679.0 622234.0 626446.0 631211.0 632879.0 54801.0 55929.0 56070.4 56261.7 56300.0 1164.8 1292.9 1331.2 1365.3 1366.7 25508.5 28409.4 28659.0 28686.9 29440.7 47041.4 47471.0 47511.0 47522.3 47563.8 564205.0 575503.0 579069.0 579313.0 579372.0 37377.4 37804.2 38743.2 39014.2 39172.4 44944.8 46216.5 46433.8 47080.8 47087.0 38346.0 38438.6 38469.8 39263.6 39828.2 38239.0 38738.0 39493.8 39508.0 39551.8 36800.1 37225.0 37898.0 38001.6 38950.8 29891.9 31491.0 34156.7 34216.1 34218.8 25008.7 25044.7 25218.0 25456.9 25912.5 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#2] jquery.html Cycles:180 Average:32213.87 Median:2332.96 stddev:87360.50 (3744.6%) stddev-sans-first:87572.75 21:48:14 INFO - PROCESS | 2007 | Values: 320.3 378.0 380.5 382.8 399.7 19493.0 20117.1 20825.5 20984.7 21116.8 11830.9 11968.0 17749.8 19935.2 20889.6 4383.3 5465.7 5466.9 5472.3 5480.6 5097.6 5397.4 5448.8 5453.7 5471.0 5448.3 5459.5 5461.2 5461.5 5476.2 5199.3 5406.2 5445.0 5445.8 5474.5 5065.5 5271.3 5316.5 5320.4 5320.5 12896.8 13141.0 13187.7 13218.9 13235.4 2083.5 2219.1 2330.5 2335.4 2403.1 10017.0 10159.8 10381.8 12695.4 14785.5 1838.6 1893.2 1895.2 1896.7 1928.2 118635.0 122467.0 125597.0 126043.0 126236.0 11260.4 11336.5 11876.9 11902.0 12093.9 14117.8 14498.1 14499.8 14504.5 14513.7 8208.2 8465.5 8500.9 8580.4 8590.4 8373.2 8389.6 8403.0 8480.1 8613.2 4455.8 4516.7 4545.0 4547.6 4555.2 1867.7 1871.1 1936.3 1937.6 1953.5 816.6 837.6 856.9 880.6 963.4 20081.4 20390.6 21414.4 21510.7 22114.4 705.7 891.4 905.4 909.4 919.0 10851.6 11363.9 11372.0 11372.7 11401.6 468928.0 510177.0 522142.0 525097.0 561783.0 109973.0 114716.0 122718.0 129134.7 131770.0 948.5 972.4 988.9 989.0 989.5 19282.1 19617.8 19749.7 19756.9 19837.0 55416.7 55760.4 55778.7 57099.1 57352.7 57915.0 60851.7 76513.6 76630.2 77143.0 8009.0 8072.4 8286.8 8393.5 8501.4 11081.2 11601.0 11927.3 12000.9 13585.8 9502.6 11532.1 11592.2 11683.7 11686.6 11025.5 11328.0 11349.5 11722.5 11732.0 11349.7 11414.1 11824.9 11880.5 11925.9 6466.3 7377.7 8013.3 8294.0 8444.0 9602.3 10596.6 11453.1 11594.9 11658.3 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#3] mootools.html Cycles:180 Average:5662.55 Median:4974.93 stddev:3185.48 (64.0%) stddev-sans-first:3177.72 21:48:14 INFO - PROCESS | 2007 | Values: 1323.3 1444.9 1504.1 1822.8 1825.2 7845.2 8070.2 8317.9 8510.7 9080.1 7388.5 7441.3 8850.9 8971.2 8996.6 2002.5 2358.1 2377.5 2384.9 2385.4 2352.1 2381.0 2382.8 2401.3 2409.0 2189.6 2231.8 2375.5 2377.2 2386.4 1987.2 2353.7 2356.4 2359.0 2364.4 2364.1 2366.1 2366.1 2374.4 2374.7 8844.0 8971.8 9016.0 9018.8 9018.9 5251.1 5393.5 5430.2 5435.3 5437.5 3528.0 3598.7 3719.2 3726.3 3738.3 1006.1 1085.1 1090.9 1091.9 1114.7 11592.3 11765.4 11816.4 11896.3 11916.8 4550.6 4637.5 4841.6 4846.7 4847.2 9834.7 9903.3 10006.9 10032.2 10054.0 5373.7 5394.7 5402.9 5407.2 5419.4 4377.1 4533.8 4767.8 4924.9 4975.3 3878.5 3916.6 3974.1 4043.8 4062.2 1268.0 1273.1 1279.4 1284.6 1285.7 728.7 835.4 896.6 901.6 923.8 5376.5 5653.6 5853.9 5907.3 6055.2 882.8 909.6 937.4 939.9 950.1 3864.9 3882.3 3883.7 3961.5 4001.7 9489.8 10939.9 10955.3 10982.3 11006.6 10815.7 10919.2 10959.3 10979.3 11020.1 7092.9 8097.4 8257.5 8370.2 8382.3 5541.8 5706.7 5715.7 5836.9 5896.1 9278.7 10191.5 10226.0 10262.0 10302.5 8481.6 9635.3 10087.1 10094.3 10230.7 6147.1 6223.7 6875.8 7452.7 7604.6 6637.6 7088.6 8052.3 8421.8 8447.7 7394.0 7494.0 7568.7 7595.7 7698.2 6625.1 6878.9 7427.6 7478.4 7551.7 6964.7 7009.9 7024.2 7089.0 7093.3 4411.7 5041.8 5067.0 5108.1 5139.8 4779.2 4974.6 4985.8 5110.2 5139.3 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#4] prototype.html Cycles:180 Average:4585.61 Median:5179.86 stddev:1451.86 (28.0%) stddev-sans-first:1419.79 21:48:14 INFO - PROCESS | 2007 | Values: 296.6 308.1 311.7 313.8 316.4 4557.9 4614.9 5278.8 5408.7 5464.5 4369.4 4893.7 5332.7 5422.7 5475.5 4137.5 4149.7 4152.8 4163.4 4167.8 3704.0 3810.9 4153.7 4155.8 4181.2 3943.8 4002.5 4018.0 4029.5 4069.3 3824.1 4025.5 4045.8 4057.6 4070.8 2918.2 3038.8 3477.6 3519.3 3541.7 5066.0 5116.3 5144.7 5286.6 5314.7 3721.5 3944.5 4068.6 4171.9 4589.7 4875.5 5207.0 5253.6 5717.0 5717.6 2931.4 3102.4 3300.8 3407.7 3639.8 4721.8 5550.8 5712.7 5954.4 6086.6 3928.2 3930.8 3936.9 3937.2 4094.1 3520.4 3681.8 3973.5 3988.9 3993.9 4601.7 4602.9 4625.3 4670.7 4685.6 5234.8 5272.1 5850.0 5866.8 5868.4 1091.3 1165.4 1262.7 1342.7 1361.8 880.8 892.2 912.8 913.8 916.7 5385.1 5413.4 5420.6 5440.5 5441.8 5372.7 5614.2 5855.4 5882.4 5906.5 4993.8 5370.8 5398.6 5404.8 5432.8 2919.8 3083.9 3099.3 3137.6 3164.2 5493.5 5919.4 6126.0 6222.3 6238.9 5053.4 5140.9 5517.9 5809.7 6079.3 5152.7 5216.7 5996.6 6163.3 6210.9 5579.2 5957.5 5960.8 5967.8 5973.8 4847.8 5715.3 5857.7 5884.4 5897.9 5645.7 6005.4 6169.8 6210.1 6265.2 3302.5 3789.1 3875.8 3906.8 3929.5 5685.5 5932.6 5935.8 5943.6 5997.6 4614.8 4736.2 5729.6 5762.6 5779.0 4620.5 4858.8 5761.0 5803.7 5840.7 4820.8 4968.7 5588.7 5685.4 5725.7 4996.7 5748.0 5775.2 5817.7 5825.5 5596.4 5644.5 5650.2 5688.4 5721.5 21:48:14 INFO - PROCESS | 2007 | 21:48:14 INFO - PROCESS | 2007 | [#5] yui.html Cycles:180 Average:24807.55 Median:12974.50 stddev:39386.42 (303.6%) stddev-sans-first:39455.21 21:48:14 INFO - PROCESS | 2007 | Values: 670.6 684.3 709.5 738.7 820.9 14944.4 15508.8 15929.1 15947.8 15964.0 13999.8 14298.3 14421.1 14468.4 14474.9 656.2 682.6 814.5 817.2 842.7 829.9 853.8 854.0 855.1 857.0 886.4 892.8 893.4 893.4 894.6 863.2 887.8 891.2 891.8 892.2 636.4 656.5 660.1 660.3 662.4 15296.8 15363.3 15416.0 15421.2 15423.9 14568.3 14575.0 14589.9 14719.1 14970.6 9985.8 11664.4 11818.6 12179.9 12203.9 3753.3 3838.6 3838.9 3980.4 3980.5 89782.6 101822.5 102496.5 116816.0 125567.4 11089.6 11366.3 11367.5 11383.3 11684.4 19900.7 22240.0 22821.5 22840.9 22912.1 7745.9 7823.3 7984.4 8173.1 8174.2 3652.8 4320.5 4349.3 4397.3 4526.9 3036.9 3532.8 3575.8 3628.6 3641.7 538.9 576.2 612.5 651.8 658.6 506.6 556.1 558.5 665.7 683.4 8354.3 9029.5 9176.2 9580.5 9767.5 538.6 578.9 631.0 656.3 678.4 3811.8 4298.5 4411.5 4457.0 4769.4 125385.0 129427.0 138005.0 146417.3 151673.0 125874.0 130521.9 136876.3 138871.6 141575.0 116131.4 117394.0 118084.2 119087.8 120723.4 9949.8 10083.4 10091.4 10094.4 10191.6 47192.5 54149.7 59035.7 59949.0 64534.7 75842.0 79982.6 96897.5 97319.0 98410.5 13784.0 13929.9 14104.9 14112.4 14326.9 14978.0 14985.3 15098.2 15134.3 15143.4 12034.7 13981.9 14167.8 14357.8 14592.0 13603.9 13810.7 13818.4 13969.5 14590.3 13568.5 13611.0 13635.3 13762.9 13801.0 10849.8 11220.3 11253.7 11377.8 11431.7 9636.6 11340.4 11579.5 11580.6 11618.2 21:48:14 INFO - PROCESS | 2007 | -------- Summary: end -------- 21:48:14 INFO - PROCESS | 2007 | 21:48:15 INFO - TEST-INFO | 2007: exit 0 21:48:15 INFO - TEST-OK | dromaeo_css | took 1115208ms 21:48:15 INFO - TEST-START | kraken 21:48:15 INFO - operating with platform_type : mac_ 21:48:15 INFO - Initialising browser for kraken test... 21:48:15 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpI4h0k5/profile http://localhost:49404/getInfo.html) 21:48:17 INFO - PROCESS | 2012 | 2016-10-08 21:48:17.758 plugin-container[2013:16436] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.tsm.portname' 21:48:17 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:48:17 INFO - PROCESS | 2012 | 2016-10-08 21:48:17.761 plugin-container[2013:16436] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 21:48:17 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:48:17 INFO - PROCESS | 2012 | 2016-10-08 21:48:17.761 plugin-container[2013:16436] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:48:17 INFO - PROCESS | 2012 | __metrics Screen width/height:1600/1200 21:48:17 INFO - PROCESS | 2012 | colorDepth:24 21:48:17 INFO - PROCESS | 2012 | Browser inner width/height: 1024/689 21:48:17 INFO - PROCESS | 2012 | __metrics 21:48:17 ERROR - PROCESS | 2012 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:48:18 INFO - TEST-INFO | 2012: exit 0 21:48:18 INFO - Browser initialized. 21:48:18 INFO - Running cycle 1/1 for kraken test... 21:48:18 INFO - TEST-INFO | started process 2014 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpI4h0k5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:21 INFO - PROCESS | 2014 | 2016-10-08 21:48:21.009 plugin-container[2015:16550] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e23, name = 'com.apple.tsm.portname' 21:48:21 INFO - PROCESS | 2014 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:48:21 INFO - PROCESS | 2014 | 2016-10-08 21:48:21.012 plugin-container[2015:16550] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 21:48:21 INFO - PROCESS | 2014 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:48:21 INFO - PROCESS | 2014 | 2016-10-08 21:48:21.012 plugin-container[2015:16550] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:48:30 INFO - PROCESS | 2014 | RSS: Main: 239386624 21:48:30 INFO - PROCESS | 2014 | 21:48:33 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:34 INFO - PROCESS | 2014 | RSS: Main: 252981248 21:48:34 INFO - PROCESS | 2014 | 21:48:37 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-dft) 21:48:37 INFO - PROCESS | 2014 | RSS: Main: 260481024 21:48:37 INFO - PROCESS | 2014 | 21:48:41 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-fft) 21:48:42 INFO - PROCESS | 2014 | RSS: Main: 261394432 21:48:42 INFO - PROCESS | 2014 | 21:48:43 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-oscillator) 21:48:44 INFO - PROCESS | 2014 | RSS: Main: 263602176 21:48:44 INFO - PROCESS | 2014 | 21:48:46 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:47 INFO - PROCESS | 2014 | RSS: Main: 264122368 21:48:47 INFO - PROCESS | 2014 | 21:48:50 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:50 INFO - PROCESS | 2014 | RSS: Main: 264736768 21:48:50 INFO - PROCESS | 2014 | 21:48:53 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:54 INFO - PROCESS | 2014 | RSS: Main: 265043968 21:48:54 INFO - PROCESS | 2014 | 21:48:57 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49404/tests/kraken/driver.html?testName=json-parse-financial) 21:48:58 INFO - PROCESS | 2014 | RSS: Main: 265175040 21:48:58 INFO - PROCESS | 2014 | 21:48:59 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:00 INFO - PROCESS | 2014 | RSS: Main: 264851456 21:49:00 INFO - PROCESS | 2014 | 21:49:02 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:02 INFO - PROCESS | 2014 | RSS: Main: 264863744 21:49:02 INFO - PROCESS | 2014 | 21:49:05 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:49:05 INFO - PROCESS | 2014 | RSS: Main: 264962048 21:49:05 INFO - PROCESS | 2014 | 21:49:08 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:09 INFO - PROCESS | 2014 | RSS: Main: 265334784 21:49:09 INFO - PROCESS | 2014 | 21:49:12 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:13 INFO - PROCESS | 2014 | RSS: Main: 265105408 21:49:13 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49404/tests/kraken/driver.html?testName=ai-astar) 21:49:15 INFO - PROCESS | 2014 | RSS: Main: 266956800 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | __start_tp_report 21:49:15 INFO - PROCESS | 2014 | _x_x_mozilla_page_load 21:49:15 INFO - PROCESS | 2014 | _x_x_mozilla_page_load_details 21:49:15 INFO - PROCESS | 2014 | |i|pagename|runs| 21:49:15 INFO - PROCESS | 2014 | |0;ai-astar;115;116;119;117;116;117;116;116;118;118 21:49:15 INFO - PROCESS | 2014 | |1;audio-beat-detection;151;115;116;152;118;133;104;132;175;142 21:49:15 INFO - PROCESS | 2014 | |2;audio-dft;266;273;204;204;198;205;200;194;195;198 21:49:15 INFO - PROCESS | 2014 | |3;audio-fft;83;58;59;89;58;61;61;57;82;62 21:49:15 INFO - PROCESS | 2014 | |4;audio-oscillator;88;73;88;71;69;70;86;71;71;92 21:49:15 INFO - PROCESS | 2014 | |5;imaging-gaussian-blur;96;81;132;123;91;107;93;122;92;132 21:49:15 INFO - PROCESS | 2014 | |6;imaging-darkroom;113;152;123;97;96;96;99;97;96;95 21:49:15 INFO - PROCESS | 2014 | |7;imaging-desaturate;92;135;146;146;91;90;92;93;91;95 21:49:15 INFO - PROCESS | 2014 | |8;json-parse-financial;58;57;57;55;59;57;58;58;56;57 21:49:15 INFO - PROCESS | 2014 | |9;json-stringify-tinderbox;72;79;77;86;77;91;99;99;94;73 21:49:15 INFO - PROCESS | 2014 | |10;stanford-crypto-aes;87;80;103;78;111;106;111;110;83;85 21:49:15 INFO - PROCESS | 2014 | |11;stanford-crypto-ccm;149;145;140;160;166;159;158;150;193;172 21:49:15 INFO - PROCESS | 2014 | |12;stanford-crypto-pbkdf2;176;188;157;233;234;174;188;239;208;177 21:49:15 INFO - PROCESS | 2014 | |13;stanford-crypto-sha256-iterative;71;69;72;72;75;71;82;62;70;79 21:49:15 INFO - PROCESS | 2014 | __end_tp_report 21:49:15 INFO - PROCESS | 2014 | __start_cc_report 21:49:15 INFO - PROCESS | 2014 | _x_x_mozilla_cycle_collect,953 21:49:15 INFO - PROCESS | 2014 | __end_cc_report 21:49:15 INFO - PROCESS | 2014 | __startTimestamp1475988555433__endTimestamp 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | ------- Summary: start ------- 21:49:15 INFO - PROCESS | 2014 | Number of tests: 14 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 21:49:15 INFO - PROCESS | 2014 | Values: 115.0 116.0 119.0 117.0 116.0 117.0 116.0 116.0 118.0 118.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:137.50 stddev:21.61 (15.7%) stddev-sans-first:22.01 21:49:15 INFO - PROCESS | 2014 | Values: 151.0 115.0 116.0 152.0 118.0 133.0 104.0 132.0 175.0 142.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#2] audio-dft Cycles:10 Average:213.70 Median:204.00 stddev:29.69 (14.6%) stddev-sans-first:24.74 21:49:15 INFO - PROCESS | 2014 | Values: 266.0 273.0 204.0 204.0 198.0 205.0 200.0 194.0 195.0 198.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:12.42 (20.2%) stddev-sans-first:11.74 21:49:15 INFO - PROCESS | 2014 | Values: 83.0 58.0 59.0 89.0 58.0 61.0 61.0 57.0 82.0 62.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:9.29 (11.7%) stddev-sans-first:9.11 21:49:15 INFO - PROCESS | 2014 | Values: 88.0 73.0 88.0 71.0 69.0 70.0 86.0 71.0 71.0 92.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#5] imaging-gaussian-blur Cycles:10 Average:106.90 Median:86.00 stddev:18.87 (21.9%) stddev-sans-first:19.60 21:49:15 INFO - PROCESS | 2014 | Values: 96.0 81.0 132.0 123.0 91.0 107.0 93.0 122.0 92.0 132.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:96.00 stddev:18.51 (19.3%) stddev-sans-first:19.48 21:49:15 INFO - PROCESS | 2014 | Values: 113.0 152.0 123.0 97.0 96.0 96.0 99.0 97.0 96.0 95.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#7] imaging-desaturate Cycles:10 Average:107.10 Median:91.50 stddev:24.53 (26.8%) stddev-sans-first:25.41 21:49:15 INFO - PROCESS | 2014 | Values: 92.0 135.0 146.0 146.0 91.0 90.0 92.0 93.0 91.0 95.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.14 (2.0%) stddev-sans-first:1.17 21:49:15 INFO - PROCESS | 2014 | Values: 58.0 57.0 57.0 55.0 59.0 57.0 58.0 58.0 56.0 57.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#9] json-stringify-tinderbox Cycles:10 Average:84.70 Median:88.50 stddev:10.47 (11.8%) stddev-sans-first:10.04 21:49:15 INFO - PROCESS | 2014 | Values: 72.0 79.0 77.0 86.0 77.0 91.0 99.0 99.0 94.0 73.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:79.00 stddev:13.91 (17.6%) stddev-sans-first:14.42 21:49:15 INFO - PROCESS | 2014 | Values: 87.0 80.0 103.0 78.0 111.0 106.0 111.0 110.0 83.0 85.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:159.50 stddev:15.32 (9.6%) stddev-sans-first:15.80 21:49:15 INFO - PROCESS | 2014 | Values: 149.0 145.0 140.0 160.0 166.0 159.0 158.0 150.0 193.0 172.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.40 Median:198.00 stddev:29.21 (14.8%) stddev-sans-first:29.94 21:49:15 INFO - PROCESS | 2014 | Values: 176.0 188.0 157.0 233.0 234.0 174.0 188.0 239.0 208.0 177.0 21:49:15 INFO - PROCESS | 2014 | 21:49:15 INFO - PROCESS | 2014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:5.50 (7.6%) stddev-sans-first:5.81 21:49:15 INFO - PROCESS | 2014 | Values: 71.0 69.0 72.0 72.0 75.0 71.0 82.0 62.0 70.0 79.0 21:49:15 INFO - PROCESS | 2014 | -------- Summary: end -------- 21:49:15 INFO - PROCESS | 2014 | 21:49:16 INFO - TEST-INFO | 2014: exit 0 21:49:16 INFO - TEST-OK | kraken | took 61207ms 21:49:16 INFO - SUITE-END | took 1176s 21:49:16 INFO - Completed test suite (00:19:36) 21:49:16 INFO - javascript benchmark 21:49:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.2270940300195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.6575259597744, 3384.8646054157834, 3421.914452138696, 3426.4175090234667, 3440.397930362189, 5601.019821531226, 5718.9428105718935, 5792.102224155252, 5830.562707796917, 5866.560007999396, 5641.971790141054, 5758.42415758424, 5835.387284335147, 5851.4148585141465, 5888.852778680546, 5201.0378080055125, 5278.604104692145, 5296.17909224069, 5298.576113910878, 5341.919871201935, 5240.502152295526, 5361.5978801589845, 5375.22059301403, 5397.514223719864, 5495.890082198353, 5152.072626927152, 5284.550813180885, 5293.153095504701, 5312.681239125664, 5320.680759154444, 5177.48225177483, 5190.091733946544, 5192.1173400522, 5256.684598924076, 5285.86785330366, 5100.821471248489, 5151.2273159026445, 5173.663711858717, 5191.506806853381, 5282.2340760589495, 5620.4660557247, 5825.213596164506, 5825.359210486843, 5826.126081087871, 5856.4143585641095, 6146.555559443527, 6179.752809887599, 6242.781502647431, 6247.094171345175, 6280.089387038899, 6214.782482613087, 6254.374562543755, 6261.686915654199, 6284.497240220771, 6296.905546416808, 5747.827565172968, 5845.503132233808, 5919.911201331984, 5930.377310382434, 5934.37689042653, 6224.937750622526, 6242.15730876335, 6244.313125556185, 6354.205724284465, 6367.4906007519285, 6200.534959878028, 6206.968965155145, 6212.1303017577575, 6219.657918814418, 6225.657588832658, 6102.216595924226, 6260.561760676709, 6270.811875643738, 6272.247330320391, 6275.6862156891975, 6135.987562052301, 6162.753489860445, 6166.105914642351, 6185.0, 6191.071339299141, 6209.59637623553, 6234.096056071844, 6235.625862448268, 6245.281792593819, 6246.531510136758, 4968.701877887338, 4970.8757281068265, 4989.850304490871, 5008.749562521933, 5017.54842064216, 3544.929101417957, 3573.7855728656364, 3698.389765688685, 4000.739951903175, 4320.049589090395, 4445.777711114496, 4875.926861097087, 5857.20927674767, 5879.265091863517, 5887.0, 6260.029695397221, 6265.091561723524, 6266.279377871512, 6273.215848018997, 6273.905891411632, 5687.544996400278, 5783.392743761929, 5869.148973398833, 5899.380565040695, 5910.054391297372, 5486.561075113981, 5511.889762204813, 5517.36550296713, 5520.420355862657, 5548.167774833726, 6368.172137622079, 6376.489880809524, 6447.580907241015, 6460.3862633049785, 6469.805905822833, 6143.72682107623, 6202.0, 6238.064290356301, 6241.625502469867, 6254.468370188585, 5261.947380526146, 6460.515461340512, 6465.579737317059, 6470.773522926675, 6497.220333560003, 5279.627296902756, 5651.0, 6226.813195604139, 6267.467265282502, 6274.498040156685, 6099.037411928083, 6210.472109870711, 6223.408776166257, 6279.843003924939, 6298.685065746786, 5041.0, 6129.785457508966, 6166.784162554289, 6184.350643182401, 6217.285012223471, 5949.6681360891225, 6117.388261173847, 6182.0, 6201.689915504297, 6207.534434917309, 5757.453041961007, 5913.70431478433, 5993.490553303018, 6034.456898879122, 6089.147519347383, 5066.316047333563, 6129.053167990421, 6132.47873930703, 6158.630482171084, 6185.350538193425, 5996.950533656505, 6041.78853740117, 6048.455638992512, 6075.210222671201, 6080.361562035922], "value": 5693.446069044387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.9013362127142, 479.66663169097467, 508.42293996314174, 520.4665218151397, 544.8610604295907, 40004.59995400045, 41583.58416415835, 41608.583914160925, 41641.0, 41665.791671041676, 41353.0, 43060.13879722403, 43243.78378108113, 43340.56659433405, 43546.56453435465, 9900.009999000096, 10018.649347272847, 10043.69868903934, 10083.394996300209, 10083.848742268872, 8383.874241886377, 9843.409395436262, 9864.506774661239, 9921.751956201117, 9952.800943981116, 9903.059209375098, 9937.304388692794, 9955.900440995605, 9961.302708810386, 9981.101700846923, 9877.604895804196, 9921.900780992242, 9929.156021738161, 9958.950205248928, 9990.9500452498, 9806.705798826046, 9842.50787460624, 9927.602895884156, 9938.850917236176, 9947.0, 41056.76829695084, 41064.79467602673, 41156.38265426021, 41273.58726412727, 41277.380839287434, 3316.585426821647, 3370.25854312051, 3397.3545026445145, 3490.336836001152, 3556.875509357186, 30661.540076898866, 30912.690873091207, 31066.68933310683, 31784.523232151536, 31801.8409907949, 2747.6840163381066, 3236.0938937097417, 3236.255661197914, 3271.084096452997, 3396.8980930572125, 471013.0, 472750.0, 473855.99999999657, 474694.0, 475974.0, 56779.0, 57099.0, 57199.0, 57215.427845721846, 57266.71366643223, 58377.83244335175, 59920.801583968074, 60326.69836650876, 60374.69812650997, 60654.0, 15885.920570397075, 15955.042697437959, 16101.597460063593, 16121.27454264561, 16145.434909778101, 12318.630441086782, 12467.438965246585, 12562.309073001074, 12567.622971310875, 12573.434195461226, 14857.628559286104, 15174.393024278905, 15812.446564370191, 15814.0, 15815.288312025987, 6260.342664020303, 6357.300696923335, 6372.426481616677, 6466.579672321284, 6494.123293355431, 822.333909533268, 883.0948278015086, 921.7280153388281, 954.5656726189567, 1035.0477560644226, 24954.251372458857, 28687.856560717064, 29533.523323833724, 29738.553921691193, 30446.84776576147, 922.391221793613, 1027.6557353286582, 1119.9384033878052, 1127.8251870960014, 1133.1727838677812, 14609.196494192922, 15146.242687865783, 15157.393704251926, 15224.391024358902, 15600.92199538995, 620679.0, 622234.0, 626446.0, 631211.0, 632879.0, 54801.0, 55929.04248351288, 56070.43929560652, 56261.718691406284, 56300.0, 1164.8136298192248, 1292.9288889111, 1331.1746717035307, 1365.3241645385597, 1366.72665466907, 25508.489830203664, 28409.43181136407, 28659.0, 28686.856565717037, 29440.675169617847, 47041.35355262549, 47471.0, 47511.0, 47522.28716569323, 47563.762181188875, 564205.0, 575503.0, 579069.0, 579313.0, 579372.0, 37377.43933841049, 37804.2439151221, 38743.2251354977, 39014.219715606094, 39172.41241381325, 44944.77527612472, 46216.537834621224, 46433.76783116063, 47080.7645961768, 47087.0, 38346.04134896538, 38438.6156138435, 38469.8459046229, 39263.60736392599, 39828.20343593054, 38239.0, 38738.0, 39493.81518554448, 39508.01229969274, 39551.80224098861, 36800.07999800026, 37225.0, 37898.0, 38001.61998380091, 38950.80524597359, 29891.850540747157, 31491.0, 34156.658433415345, 34216.14459638529, 34218.82890585631, 25008.749912500643, 25044.749552504243, 25218.0, 25456.872715636302, 25912.481750365263], "value": 19805.179817885048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2889585121032, 377.97380112993216, 380.45594799436805, 382.81433504750174, 399.686246296657, 19493.02534873256, 20117.094730737117, 20825.479363015933, 20984.68522972155, 21116.788832111673, 11830.881691183085, 11968.0, 17749.846259993123, 19935.202591896308, 20889.582208355823, 4383.298672212454, 5465.72671366432, 5466.9179962300595, 5472.315960504937, 5480.588955828329, 5097.617678674096, 5397.379301380332, 5448.7548060337185, 5453.727313634322, 5470.987867244553, 5448.264484294609, 5459.454054594548, 5461.15352120422, 5461.453854614527, 5476.151196564519, 5199.324087868591, 5406.189071639266, 5445.0, 5445.754941027663, 5474.452554744514, 5065.46812584677, 5271.262023316739, 5316.468353164652, 5320.388155362144, 5320.467953204648, 12896.80654790179, 13141.0, 13187.736245275137, 13218.86781132186, 13235.404406801621, 2083.5312054787705, 2219.1345375303645, 2330.5222429401933, 2335.3927978725656, 2403.134871446278, 10017.0, 10159.796804063952, 10381.84427233592, 12695.365231738468, 14785.482508112273, 1838.5771272607242, 1893.2237782509244, 1895.1945423195086, 1896.6775648139849, 1928.161249856317, 118635.0, 122467.0, 125597.0, 126043.0, 126236.0, 11260.43697815106, 11336.546538138382, 11876.88123118775, 11902.0, 12093.87906120945, 14117.78823317651, 14498.130112193303, 14499.782503262459, 14504.492342767953, 14513.709725805636, 8208.179182081743, 8465.492070475791, 8500.872486912702, 8580.442271252348, 8590.355723320776, 8373.246407823324, 8389.622466989, 8402.957985210034, 8480.067192608809, 8613.181747734081, 4455.799489023002, 4516.712736869977, 4544.977380089454, 4547.636189104864, 4555.2256116460285, 1867.7291792690255, 1871.0831692470863, 1936.2738972885168, 1937.5543624966338, 1953.4627977306354, 816.5998660656236, 837.5644664774405, 856.8971723393232, 880.5861245214738, 963.3834346018554, 20081.393488520884, 20390.59218815645, 21414.357569272634, 21510.677339839604, 22114.447138821335, 705.6612825843521, 891.4383938119073, 905.3662436294488, 909.4088842252589, 918.9954050229707, 10851.565937362417, 11363.886361136283, 11372.0, 11372.658820235407, 11401.574803149606, 468928.0, 510177.0, 522142.0, 525097.0, 561783.0, 109973.0, 114716.0, 122718.0, 129134.70865291415, 131770.0, 948.5494390164616, 972.3582435592334, 988.9270141895979, 989.0455710239653, 989.5052473763119, 19282.13230404607, 19617.80382196217, 19749.70375444398, 19756.901215493832, 19837.00814959275, 55416.72291638516, 55760.44239557553, 55778.72110639421, 57099.14351284817, 57352.71323643355, 57915.0, 60851.695741521005, 76513.61743191248, 76630.2336976623, 77143.0, 8008.959955200186, 8072.39457040736, 8286.751397458085, 8393.496390216607, 8501.404901656824, 11081.179686836253, 11601.01391381742, 11927.343996080299, 12000.939995299968, 13585.796213056614, 9502.572384242587, 11532.077433805443, 11592.246503977214, 11683.707907302385, 11686.590969316034, 11025.503852326825, 11328.0, 11349.48927298257, 11722.531098755955, 11732.002779763474, 11349.659510214708, 11414.143939204427, 11824.881751182722, 11880.524779008743, 11925.880741192477, 6466.288708242184, 7377.668004939898, 8013.278804907586, 8293.963254593176, 8444.0, 9602.279829012712, 10596.576136954744, 11453.083753299883, 11594.94202528982, 11658.300501969909], "value": 9203.76016720461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.2788130468894, 1444.8844092472602, 1504.1351223046747, 1822.8450581700554, 1825.187791432813, 7845.176256493064, 8070.233327833861, 8317.916820831804, 8510.659573617055, 9080.091990800916, 7388.519746216505, 7441.255874412556, 8850.91149088509, 8971.192592666659, 8996.550172491381, 2002.489365211869, 2358.1157066100213, 2377.5482658294954, 2384.892679829412, 2385.427497400629, 2352.141468364052, 2380.9642855357183, 2382.845115067515, 2401.2916189724074, 2408.963865542018, 2189.551142015891, 2231.776822317763, 2375.4536456614987, 2377.215518878766, 2386.379541319252, 1987.1852540458415, 2353.729321128058, 2356.352003199117, 2359.0, 2364.4088977755473, 2364.101641376283, 2366.077229880348, 2366.1363602285214, 2374.3945293950105, 2374.655674927126, 8844.027157012724, 8971.775705607346, 9016.0, 9018.774530636721, 9018.909810901872, 5251.10731175701, 5393.541548968343, 5430.185472179165, 5435.266239057755, 5437.456254374571, 3527.9647203527893, 3598.748087633867, 3719.20037192005, 3726.31063253299, 3738.2523495300775, 1006.079437314856, 1085.1318944844172, 1090.9127269818396, 1091.8744344400416, 1114.6823155400673, 11592.304461732407, 11765.352905590189, 11816.409179540988, 11896.286222826659, 11916.761664766744, 4550.635949124062, 4637.466691330473, 4841.636877234221, 4846.660733748604, 4847.175980083394, 9834.704958851245, 9903.306768526134, 10006.949965250127, 10032.197424206046, 10054.0, 5373.704446255493, 5394.730263486888, 5402.918956215582, 5407.215953686693, 5419.430959749169, 4377.102693947733, 4533.795979180879, 4767.833125840648, 4924.901501970012, 4975.278584605212, 3878.5151856017997, 3916.6279203475624, 3974.105826189142, 4043.7775922324554, 4062.2484840304637, 1267.9792766822795, 1273.1342686972762, 1279.353926267229, 1284.6467221513972, 1285.7235694325766, 728.7194430144433, 835.3985130705883, 896.6368620708623, 901.6348378906554, 923.8013827027087, 5376.516113549799, 5653.604247702704, 5853.882922341614, 5907.261592300963, 6055.212822333068, 882.7905769096251, 909.5952301225891, 937.4328531238639, 939.9483028433502, 950.078423928788, 3864.942025869614, 3882.2623701496627, 3883.650471457582, 3961.504811898513, 4001.7398869073418, 9489.810203795885, 10939.945300273448, 10955.287906286067, 10982.286151400293, 11006.559737610405, 10815.67552973412, 10919.235653504338, 10959.342439453658, 10979.341239525655, 11020.063294620048, 7092.9290707093305, 8097.392695547857, 8257.504549727035, 8370.162983701703, 8382.329413646894, 5541.778328866962, 5706.657600543981, 5715.713964358152, 5836.941630583639, 5896.14505896634, 9278.675246366345, 10191.490425478845, 10226.0, 10262.0, 10302.536385862804, 8481.618327175169, 9635.277354198603, 10087.092161705481, 10094.293399462262, 10230.744231394274, 6147.139400484025, 6223.688815559294, 6875.7937261882225, 7452.739154129579, 7604.581748003913, 6637.568558043712, 7088.645567721696, 8052.315553178046, 8421.789455263668, 8447.704330348408, 7393.963030184815, 7494.0, 7568.735094271674, 7595.658195381332, 7698.153203147761, 6625.138731964814, 6878.8993760998, 7427.554346739213, 7478.439117066133, 7551.697932082655, 6964.721411143498, 7009.859802803813, 7024.192217895007, 7089.0, 7093.290670932865, 4411.669124815716, 5041.823536176216, 5066.9746651266505, 5108.10608143566, 5139.794408223779, 4779.1636463619425, 4974.577160941216, 4985.750712464434, 5110.207917772751, 5139.306193663957], "value": 4551.721124714315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5699735383694, 308.1326067121054, 311.6867548114145, 313.7568384502011, 316.439901374567, 4557.886052848677, 4614.861554153373, 5278.762455689493, 5408.675479471234, 5464.508194262516, 4369.3614894414595, 4893.678706749176, 5332.653377530458, 5422.698552347438, 5475.479829416209, 4137.482814648177, 4149.7095203335775, 4152.750834949898, 4163.417121602978, 4167.833006758097, 3703.9627505445546, 3810.9237815243678, 4153.736213763506, 4155.771432571208, 4181.163767246548, 3943.7577163193646, 4002.4996875390575, 4017.9799101004455, 4029.536603290615, 4069.308217603, 3824.1204522959874, 4025.5169379674626, 4045.7774822384904, 4057.5942405759483, 4070.7557546547155, 2918.2120827376702, 3038.8176709397508, 3477.565304336958, 3519.3137338219058, 3541.698955588778, 5066.0374528839775, 5116.334876466073, 5144.6655967362, 5286.568178637831, 5314.661548918463, 3721.5162028936334, 3944.5069366329208, 4068.5931406859077, 4171.895702607429, 4589.655775816827, 4875.466345697623, 5206.9846379955925, 5253.55344795689, 5717.028105222123, 5717.599768016241, 2931.369755502556, 3102.4105419970133, 3300.7524435667183, 3407.71034462071, 3639.818009099561, 4721.834735784266, 5550.7510810067815, 5712.685802280873, 5954.404559544054, 6086.573939824214, 3928.175083232496, 3930.8034598269974, 3936.9212615747524, 3937.17319362937, 4094.0992981544014, 3520.419130843382, 3681.834317455721, 3973.5231772186944, 3988.880333589997, 3993.900152496211, 4601.72389656615, 4602.859670253349, 4625.32932724753, 4670.719756814534, 4685.5782979532005, 5234.816781412632, 5272.05103081449, 5849.970750146222, 5866.823995280149, 5868.354481007086, 1091.2524920429373, 1165.3648761425043, 1262.696952731338, 1342.7381660576093, 1361.8433880103717, 880.7974165941869, 892.2103938014903, 912.7535565397438, 913.8035322405715, 916.7112359606703, 5385.1496180231325, 5413.350397952271, 5420.6177424757225, 5440.510354068074, 5441.83674489766, 5372.737406709421, 5614.203454894395, 5855.419036860024, 5882.3529411764675, 5906.468417842415, 4993.825216117419, 5370.785168593291, 5398.568114550826, 5404.784038544178, 5432.837014889559, 2919.7518210952308, 3083.8766449341774, 3099.3491366812773, 3137.623485181747, 3164.168069577715, 5493.505584497414, 5919.395465994949, 6126.0, 6222.319973607101, 6238.908191066545, 5053.418856831438, 5140.943622550934, 5517.944820551743, 5809.680467574324, 6079.331273559905, 5152.742362881841, 5216.695826043489, 5996.550258730613, 6163.291221509584, 6210.9068363974575, 5579.1503862336485, 5957.523398128226, 5960.791372301948, 5967.76128954837, 5973.820785376446, 4847.80608775645, 5715.257016587817, 5857.707114644166, 5884.440978107073, 5897.852553686193, 5645.745941432563, 6005.429484198994, 6169.81490555284, 6210.068489726577, 6265.248170219603, 3302.488114342281, 3789.1285004448578, 3875.779129574175, 3906.824192911383, 3929.5088113985753, 5685.516731077904, 5932.64404135736, 5935.762569497345, 5943.632964418121, 5997.610155339889, 4614.769261536842, 4736.242201247784, 5729.598928074995, 5762.567807414544, 5778.959787238337, 4620.5148459411275, 4858.809591650069, 5760.971195144165, 5803.680797556175, 5840.707964601668, 4820.758962051954, 4968.677035992649, 5588.692621905834, 5685.4415513018475, 5725.6850873202375, 4996.725180115129, 5747.97126014384, 5775.1914731938405, 5817.738201781015, 5825.533957283492, 5596.41237670055, 5644.463775941279, 5650.208970744181, 5688.402717714746, 5721.5136713379825], "value": 4121.7277306862925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.580886945659, 684.3054299885617, 709.5246185056012, 738.7377480994244, 820.8850760893474, 14944.402223911044, 15508.844911550881, 15929.123898185595, 15947.84052159478, 15964.0, 13999.790003149961, 14298.285085745723, 14421.062630928982, 14468.421263149488, 14474.927625361885, 656.1732217406079, 682.5699809120272, 814.4787336104897, 817.2277198047861, 842.7261140129483, 829.9460535065201, 853.7865533616596, 854.0477367734993, 855.1363123245504, 856.9785755356104, 886.4061079077002, 892.7589550821307, 893.3657103456553, 893.3880292000001, 894.6332003878412, 863.1799790199273, 887.8401887660218, 891.2468963725673, 891.7725979875155, 892.2103938014839, 636.4049613611288, 656.5010591950153, 660.131926516629, 660.3033799341692, 662.4137638190189, 15296.847031529653, 15363.308651110727, 15416.0, 15421.15183664898, 15423.922880385526, 14568.271586420742, 14575.0, 14589.927050364786, 14719.116852988855, 14970.550883473514, 9985.80028399428, 11664.416779161009, 11818.552680019515, 12179.878201217964, 12203.938980305042, 3753.2681127180213, 3838.5777564467885, 3838.9232215355537, 3980.422838688403, 3980.5223373195113, 89782.55108724479, 101822.49088754583, 102496.48751756268, 116816.0, 125567.37216313952, 11089.611863584736, 11366.318020918772, 11367.488463019185, 11383.268015676178, 11684.415779211175, 19900.70645408073, 22239.999200036036, 22821.543569128855, 22840.88579557125, 22912.08351665948, 7745.891050738346, 7823.2567906048835, 7984.40116991228, 8173.060098088677, 8174.223448772357, 3652.7625704329134, 4320.512948555317, 4349.3041113421705, 4397.274449715825, 4526.936170000047, 3036.9240768980953, 3532.8410221540094, 3575.76757510761, 3628.600853906068, 3641.708663306982, 538.9407165211824, 576.2479963647396, 612.4579746924004, 651.84681599824, 658.6410406328563, 506.6149726208108, 556.0963434419069, 558.4973523828505, 665.7303791964263, 683.3951952521954, 8354.28988535969, 9029.458232506071, 9176.220021298132, 9580.520973951414, 9767.51162441875, 538.6471860931097, 578.9473684210526, 631.0313668518802, 656.2780940964996, 678.35217367414, 3811.8284677189595, 4298.5241268623095, 4411.492678341968, 4456.977715111404, 4769.379980602499, 125385.0, 129427.0, 138005.0, 146417.26791365974, 151673.0, 125874.0, 130521.89562087621, 136876.31561842127, 138871.61128388587, 141575.0, 116131.41934290275, 117394.0, 118084.22873656901, 119087.8091219094, 120723.39638301928, 9949.801003979735, 10083.394996299952, 10091.44497052669, 10094.444805535766, 10191.592336306761, 47192.52807472018, 54149.72925135349, 59035.704821475614, 59949.0, 64534.67732661307, 75842.0, 79982.6000869992, 96897.54653680342, 97319.0, 98410.52384214099, 13784.0, 13929.930350348184, 14104.929475352557, 14112.36494357777, 14326.928365358106, 14978.0, 14985.325660345528, 15098.169600672069, 15134.318955647243, 15143.394264229748, 12034.699132521408, 13981.93009034989, 14167.787483187554, 14357.784633230718, 14592.0, 13603.931980340036, 13810.65473363174, 13818.37817298244, 13969.511067112602, 14590.270486475845, 13568.457261709422, 13610.979176561996, 13635.300033356101, 13762.931185344009, 13801.0, 10849.776896380763, 11220.270682405944, 11253.662390127982, 11377.829332559853, 11431.657050288504, 9636.614535418785, 11340.432978350884, 11579.478923448296, 11580.594679186188, 11618.244814087395], "value": 7792.368674106546, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 119.0, 117.0, 116.0, 117.0, 116.0, 116.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 115.0, 116.0, 152.0, 118.0, 133.0, 104.0, 132.0, 175.0, 142.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [266.0, 273.0, 204.0, 204.0, 198.0, 205.0, 200.0, 194.0, 195.0, 198.0], "value": 213.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 89.0, 58.0, 61.0, 61.0, 57.0, 82.0, 62.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 73.0, 88.0, 71.0, 69.0, 70.0, 86.0, 71.0, 71.0, 92.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 81.0, 132.0, 123.0, 91.0, 107.0, 93.0, 122.0, 92.0, 132.0], "value": 106.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 152.0, 123.0, 97.0, 96.0, 96.0, 99.0, 97.0, 96.0, 95.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 135.0, 146.0, 146.0, 91.0, 90.0, 92.0, 93.0, 91.0, 95.0], "value": 107.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 55.0, 59.0, 57.0, 58.0, 58.0, 56.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 77.0, 86.0, 77.0, 91.0, 99.0, 99.0, 94.0, 73.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 103.0, 78.0, 111.0, 106.0, 111.0, 110.0, 83.0, 85.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 140.0, 160.0, 166.0, 159.0, 158.0, 150.0, 193.0, 172.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 188.0, 157.0, 233.0, 234.0, 174.0, 188.0, 239.0, 208.0, 177.0], "value": 197.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 72.0, 72.0, 75.0, 71.0, 82.0, 62.0, 70.0, 79.0], "value": 72.3, "unit": "score"}]}]} 21:49:16 INFO - Return code: 0 21:49:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:16 ERROR - # TBPL SUCCESS # 21:49:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:49:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:49:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:49:16 INFO - 2016-10-08 21:49:16.753 screenresolution[2019:16943] starting screenresolution argv=screenresolution get 21:49:16 INFO - 2016-10-08 21:49:16.755 screenresolution[2019:16943] Display 0: 1600x1200x32@60 21:49:16 INFO - 2016-10-08 21:49:16.761 screenresolution[2020:16946] starting screenresolution argv=screenresolution list 21:49:16 INFO - Available Modes on Display 0 21:49:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:49:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:49:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:49:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:49:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:49:16 INFO - Intel Iris: 21:49:16 INFO - Chipset Model: Intel Iris 21:49:16 INFO - Type: GPU 21:49:16 INFO - Bus: Built-In 21:49:16 INFO - VRAM (Dynamic, Max): 1536 MB 21:49:16 INFO - Vendor: Intel (0x8086) 21:49:16 INFO - Device ID: 0x0a2e 21:49:16 INFO - Revision ID: 0x0009 21:49:16 INFO - Displays: 21:49:16 INFO - Display: 21:49:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:49:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:49:16 INFO - Display Serial Number: 1600x1200 60 21:49:16 INFO - Main Display: Yes 21:49:16 INFO - Mirror: Off 21:49:16 INFO - Online: Yes 21:49:16 INFO - Rotation: Supported 21:49:16 INFO - Return code: 0 21:49:16 INFO - Running post-action listener: _resource_record_post_action 21:49:16 INFO - [mozharness: 2016-10-09 04:49:16.995360Z] Finished run-tests step (success) 21:49:16 INFO - Running post-run listener: _resource_record_post_run 21:49:17 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 847872; Write bytes: 711370752; Read time: 6; Write time: 2000 21:49:17 INFO - TinderboxPrint: CPU usage
54.4% 21:49:17 INFO - TinderboxPrint: I/O read bytes / time
847,872 / 6 21:49:17 INFO - TinderboxPrint: I/O write bytes / time
711,370,752 / 2,000 21:49:17 INFO - TinderboxPrint: CPU idle
2,213.2 (45.6%) 21:49:17 INFO - TinderboxPrint: CPU system
984.8 (20.3%) 21:49:17 INFO - TinderboxPrint: CPU user
1,651.8 (34.1%) 21:49:17 INFO - TinderboxPrint: Swap in / out
407,793,664 / 0 21:49:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 406188544; Write bytes: 402120704; Read time: 30725; Write time: 813 21:49:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 151552; Write bytes: 298326016; Read time: 2; Write time: 1147 21:49:17 INFO - Running post-run listener: _upload_blobber_files 21:49:17 INFO - Blob upload gear active. 21:49:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:49:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:19 INFO - (blobuploader) - INFO - Done attempting. 21:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:20 INFO - (blobuploader) - INFO - Done attempting. 21:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:22 INFO - (blobuploader) - INFO - Done attempting. 21:49:22 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:22 INFO - Return code: 0 21:49:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3568bace18254eb119ed5cca8b2d4084b1eeb41e320d2d815ed80f259d1929e423bf061dce593839861e787d8fae5cdaf2f81d1c463731be273d8eb7fa563431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823b6b09641db89e02d24fb7ff93db92817abfd1a2eb50f005b9af7cb10f6de82b2028e39e7938eddf1a5b06b9ba130d54f48fcd4a5f8163d5fefa362144fdcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35285fbc7f0124161e1e409b818534992884818e329c9641fa044d83dc90ba19f109a08a36437a6d40a7eea0124f6cb85fc7b85965496e2c28a5e035dbb444ed"} 21:49:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:22 INFO - Contents: 21:49:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3568bace18254eb119ed5cca8b2d4084b1eeb41e320d2d815ed80f259d1929e423bf061dce593839861e787d8fae5cdaf2f81d1c463731be273d8eb7fa563431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823b6b09641db89e02d24fb7ff93db92817abfd1a2eb50f005b9af7cb10f6de82b2028e39e7938eddf1a5b06b9ba130d54f48fcd4a5f8163d5fefa362144fdcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35285fbc7f0124161e1e409b818534992884818e329c9641fa044d83dc90ba19f109a08a36437a6d40a7eea0124f6cb85fc7b85965496e2c28a5e035dbb444ed"} 21:49:22 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:22 INFO - Copying logs to upload dir... 21:49:22 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.935517 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-08 21:49:22.411878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 21:49:22.415406) ========= 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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3568bace18254eb119ed5cca8b2d4084b1eeb41e320d2d815ed80f259d1929e423bf061dce593839861e787d8fae5cdaf2f81d1c463731be273d8eb7fa563431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823b6b09641db89e02d24fb7ff93db92817abfd1a2eb50f005b9af7cb10f6de82b2028e39e7938eddf1a5b06b9ba130d54f48fcd4a5f8163d5fefa362144fdcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35285fbc7f0124161e1e409b818534992884818e329c9641fa044d83dc90ba19f109a08a36437a6d40a7eea0124f6cb85fc7b85965496e2c28a5e035dbb444ed"} build_url:https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/YrRa8OTST2uniXB6AF5cwQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3568bace18254eb119ed5cca8b2d4084b1eeb41e320d2d815ed80f259d1929e423bf061dce593839861e787d8fae5cdaf2f81d1c463731be273d8eb7fa563431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823b6b09641db89e02d24fb7ff93db92817abfd1a2eb50f005b9af7cb10f6de82b2028e39e7938eddf1a5b06b9ba130d54f48fcd4a5f8163d5fefa362144fdcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35285fbc7f0124161e1e409b818534992884818e329c9641fa044d83dc90ba19f109a08a36437a6d40a7eea0124f6cb85fc7b85965496e2c28a5e035dbb444ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 21:49:22.449515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:49:22.449913) ========= 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.KW5JXuzBoz/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.PGN8kKXfVf/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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.005081 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 21:49:22.499357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 21:49:22.499773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 21:49:22.500280) ========= ========= Total master_lag: 0.18 =========