builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1485795542.86 results: success (0) buildid: 20170130064142 builduid: 6b20b6eb55be48aba6e71a54f7346498 revision: 0f54c5ef73d6fd308bc450835bf8c83840c33548 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:02.861108) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:02.861735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:02.862162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:02.888868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:02.889270) ========= 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.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-30 08:59:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-01-30 08:59:03 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:03.078415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:03.078724) ========= 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.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.026017 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:03.128004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 08:59:03.128388) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f54c5ef73d6fd308bc450835bf8c83840c33548 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f54c5ef73d6fd308bc450835bf8c83840c33548 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-30 08:59:03,235 truncating revision to first 12 chars 2017-01-30 08:59:03,235 Setting DEBUG logging. 2017-01-30 08:59:03,236 attempt 1/10 2017-01-30 08:59:03,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f54c5ef73d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 08:59:04,211 unpacking tar archive at: mozilla-beta-0f54c5ef73d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 08:59:04.379793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:04.380153) ========= script_repo_revision: 0f54c5ef73d6fd308bc450835bf8c83840c33548 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:04.380535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:04.380840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 08:59:04.400768) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 08:59:04.401195) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:04 INFO - MultiFileLogger online at 20170130 08:59:04 in /builds/slave/test 08:59:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:59:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:04 INFO - {'append_to_log': False, 08:59:04 INFO - 'base_work_dir': '/builds/slave/test', 08:59:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:59:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:04 INFO - 'branch': 'Mozilla-Beta', 08:59:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:04 INFO - 'config_files': ('talos/mac_config.py',), 08:59:04 INFO - 'default_actions': ('clobber', 08:59:04 INFO - 'read-buildbot-config', 08:59:04 INFO - 'download-and-extract', 08:59:04 INFO - 'populate-webroot', 08:59:04 INFO - 'create-virtualenv', 08:59:04 INFO - 'install', 08:59:04 INFO - 'run-tests'), 08:59:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:04 INFO - 'download_minidump_stackwalk': True, 08:59:04 INFO - 'download_symbols': 'ondemand', 08:59:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:04 INFO - 'installer_path': 'installer.exe', 08:59:04 INFO - 'log_level': 'info', 08:59:04 INFO - 'log_name': 'talos', 08:59:04 INFO - 'log_to_console': True, 08:59:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:59:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:59:04 INFO - 'opt_config_files': (), 08:59:04 INFO - 'pip_index': False, 08:59:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:04 INFO - 'cmd': ('bash', 08:59:04 INFO - '-c', 08:59:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:04 INFO - 'enabled': True, 08:59:04 INFO - 'halt_on_failure': False, 08:59:04 INFO - 'name': 'check_screen_resolution'},), 08:59:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:04 INFO - 'cmd': ('bash', 08:59:04 INFO - '-c', 08:59:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:04 INFO - 'enabled': True, 08:59:04 INFO - 'halt_on_failure': False, 08:59:04 INFO - 'name': 'check_screen_resolution'},), 08:59:04 INFO - 'run_cmd_checks_enabled': True, 08:59:04 INFO - 'sps_profile': False, 08:59:04 INFO - 'sps_profile_interval': 0, 08:59:04 INFO - 'suite': 'dromaeojs', 08:59:04 INFO - 'system_bits': '32', 08:59:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:04 INFO - 'title': 't-yosemite-r7-0370', 08:59:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:04 INFO - 'use_talos_json': True, 08:59:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:04 INFO - 'work_dir': 'build'} 08:59:04 INFO - [mozharness: 2017-01-30 16:59:04.614448Z] Running clobber step. 08:59:04 INFO - Running pre-action listener: _resource_record_pre_action 08:59:04 INFO - Running main action method: clobber 08:59:04 INFO - rmtree: /builds/slave/test/build 08:59:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:06 INFO - Running post-action listener: _resource_record_post_action 08:59:06 INFO - [mozharness: 2017-01-30 16:59:06.952154Z] Finished clobber step (success) 08:59:06 INFO - [mozharness: 2017-01-30 16:59:06.952335Z] Running read-buildbot-config step. 08:59:06 INFO - Running pre-action listener: _resource_record_pre_action 08:59:06 INFO - Running main action method: read_buildbot_config 08:59:06 INFO - Using buildbot properties: 08:59:06 INFO - { 08:59:06 INFO - "project": "", 08:59:06 INFO - "product": "firefox", 08:59:06 INFO - "script_repo_revision": "production", 08:59:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:59:06 INFO - "repository": "", 08:59:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:59:06 INFO - "buildid": "20170130064142", 08:59:06 INFO - "pgo_build": "False", 08:59:06 INFO - "basedir": "/builds/slave/test", 08:59:06 INFO - "buildnumber": 0, 08:59:06 INFO - "slavename": "t-yosemite-r7-0370", 08:59:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:59:06 INFO - "platform": "yosemite_r7", 08:59:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:59:06 INFO - "branch": "mozilla-beta", 08:59:06 INFO - "repo_path": "releases/mozilla-beta", 08:59:06 INFO - "revision": "0f54c5ef73d6fd308bc450835bf8c83840c33548", 08:59:06 INFO - "stage_platform": "macosx64", 08:59:06 INFO - "builduid": "6b20b6eb55be48aba6e71a54f7346498", 08:59:06 INFO - "slavebuilddir": "test" 08:59:06 INFO - } 08:59:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:59:06 INFO - Running post-action listener: _resource_record_post_action 08:59:06 INFO - [mozharness: 2017-01-30 16:59:06.956311Z] Finished read-buildbot-config step (success) 08:59:06 INFO - [mozharness: 2017-01-30 16:59:06.956451Z] Running download-and-extract step. 08:59:06 INFO - Running pre-action listener: _resource_record_pre_action 08:59:06 INFO - Running main action method: download_and_extract 08:59:06 INFO - mkdir: /builds/slave/test/build/tests 08:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:06 INFO - trying https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:59:06 INFO - Downloading https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:59:08 INFO - Downloaded 1165 bytes. 08:59:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:59:08 INFO - Using the following test package requirements: 08:59:08 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:59:08 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:59:08 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:59:08 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:59:08 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:59:08 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:59:08 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:59:08 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:59:08 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:59:08 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:59:08 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:59:08 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:59:08 INFO - Http code: 200 08:59:08 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 08:59:08 INFO - x-amz-cf-id: MVkCx2MhprIidZ5_MOGQ0UAfT_-ahiN7Fbc8O_NAExCVXJ_mLHFzTA== 08:59:08 INFO - x-amz-version-id: sgtYsShJGi8h65hK6stPsxG.1wkaS.fC 08:59:08 INFO - Expected file size: 16087630 08:59:08 INFO - Obtained file size: 16087630 08:59:15 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:59:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:59:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:59:15 INFO - Fetch https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:59:16 INFO - Http code: 200 08:59:16 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 08:59:16 INFO - x-amz-cf-id: 8nslGsjd0rFM2YWhZQYsbSsSERVkVf03THznM3ChQfFUAV1TOzmw4Q== 08:59:16 INFO - x-amz-version-id: sgtYsShJGi8h65hK6stPsxG.1wkaS.fC 08:59:16 INFO - Expected file size: 16087630 08:59:16 INFO - Obtained file size: 16087630 08:59:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:59:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:59:22 INFO - Fetch https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:59:23 INFO - Http code: 200 08:59:23 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:59:23 INFO - x-amz-cf-id: jL-SYSkkPqfMH7Mxc6_4Xe96beCgG9xbqVGmUaDMFOhmsHWd8jDftg== 08:59:23 INFO - x-amz-version-id: 1uQiebVteE1dEh2Vlgog1yfmp8u9SiOb 08:59:24 INFO - Expected file size: 14402992 08:59:24 INFO - Obtained file size: 14402992 08:59:24 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')]} 08:59:24 INFO - trying https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:59:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:59:26 INFO - Downloaded 82147184 bytes. 08:59:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:59:26 INFO - mkdir: /builds/slave/test/properties 08:59:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:26 INFO - Contents: 08:59:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:59:27 INFO - Running post-action listener: _resource_record_post_action 08:59:27 INFO - Running post-action listener: set_extra_try_arguments 08:59:27 INFO - [mozharness: 2017-01-30 16:59:27.448828Z] Finished download-and-extract step (success) 08:59:27 INFO - [mozharness: 2017-01-30 16:59:27.448986Z] Running populate-webroot step. 08:59:27 INFO - Running pre-action listener: _resource_record_pre_action 08:59:27 INFO - Running main action method: populate_webroot 08:59:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:27 INFO - '--tppagecycles', 08:59:27 INFO - '7'], 08:59:27 INFO - 'tests': ['tsvgm']}}, 08:59:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['damp', 'tps']}, 08:59:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'tests': ['damp', 'tps']}, 08:59:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['dromaeo_dom']}, 08:59:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['basic_compositor_video']}, 08:59:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['a11yr', 08:59:27 INFO - 'ts_paint', 08:59:27 INFO - 'tpaint', 08:59:27 INFO - 'sessionrestore', 08:59:27 INFO - 'sessionrestore_no_auto_restore', 08:59:27 INFO - 'tabpaint']}, 08:59:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['tsvgx', 08:59:27 INFO - 'tsvgr_opacity', 08:59:27 INFO - 'tart', 08:59:27 INFO - 'tscrollx', 08:59:27 INFO - 'cart']}, 08:59:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:27 INFO - 'tsvgr_opacity', 08:59:27 INFO - 'tart', 08:59:27 INFO - 'tscrollx', 08:59:27 INFO - 'cart']}, 08:59:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'talos_options': ['--disable-e10s'], 08:59:27 INFO - 'tests': ['tp5o']}, 08:59:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'tests': ['tp5o']}, 08:59:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'talos_options': ['--disable-e10s', 08:59:27 INFO - '--xperf_path', 08:59:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:27 INFO - 'tests': ['tp5n']}, 08:59:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:27 INFO - 'talos_options': ['--xperf_path', 08:59:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:27 INFO - 'tests': ['tp5n']}}, 08:59:27 INFO - 'talos.zip': {'path': '', 08:59:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:27 INFO - Running post-action listener: _resource_record_post_action 08:59:27 INFO - [mozharness: 2017-01-30 16:59:27.467808Z] Finished populate-webroot step (success) 08:59:27 INFO - [mozharness: 2017-01-30 16:59:27.467948Z] Running create-virtualenv step. 08:59:27 INFO - Running pre-action listener: _resource_record_pre_action 08:59:27 INFO - Running main action method: create_virtualenv 08:59:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:27 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 08:59:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:27 INFO - Using real prefix '/tools/python27' 08:59:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:31 INFO - Installing pip.................done. 08:59:31 INFO - Return code: 0 08:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:31 INFO - Reading from file tmpfile_stdout 08:59:31 INFO - Output received: 08:59:31 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) 08:59:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:31 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:31 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 08:59:31 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 08:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:31 INFO - 'HOME': '/Users/cltbld', 08:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:31 INFO - 'LOGNAME': 'cltbld', 08:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:31 INFO - 'MOZ_NO_REMOTE': '1', 08:59:31 INFO - 'NO_EM_RESTART': '1', 08:59:31 INFO - 'PAGER': '/bin/cat', 08:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:31 INFO - 'PWD': '/builds/slave/test', 08:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:31 INFO - 'SHELL': '/bin/bash', 08:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:31 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:31 INFO - 'USER': 'cltbld', 08:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:31 INFO - 'XPC_FLAGS': '0x0', 08:59:31 INFO - 'XPC_SERVICE_NAME': '0', 08:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:31 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 08:59:31 INFO - Cleaning up... 08:59:31 INFO - Return code: 0 08:59:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:31 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:31 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 08:59:31 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 08:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:31 INFO - 'HOME': '/Users/cltbld', 08:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:31 INFO - 'LOGNAME': 'cltbld', 08:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:31 INFO - 'MOZ_NO_REMOTE': '1', 08:59:31 INFO - 'NO_EM_RESTART': '1', 08:59:31 INFO - 'PAGER': '/bin/cat', 08:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:31 INFO - 'PWD': '/builds/slave/test', 08:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:31 INFO - 'SHELL': '/bin/bash', 08:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:31 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:31 INFO - 'USER': 'cltbld', 08:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:31 INFO - 'XPC_FLAGS': '0x0', 08:59:31 INFO - 'XPC_SERVICE_NAME': '0', 08:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:32 INFO - Downloading/unpacking psutil>=3.1.1 08:59:32 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 08:59:32 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 08:59:32 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 08:59:32 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 08:59:32 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 08:59:32 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 08:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:35 INFO - Installing collected packages: psutil 08:59:35 INFO - Running setup.py install for psutil 08:59:35 INFO - building 'psutil._psutil_osx' extension 08:59:35 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 08:59:36 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 08:59:36 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 08:59:36 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 08:59:36 INFO - building 'psutil._psutil_posix' extension 08:59:36 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 08:59:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:59:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:59:36 INFO - ^ 08:59:36 INFO - 1 warning generated. 08:59:36 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 08:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:36 INFO - Successfully installed psutil 08:59:36 INFO - Cleaning up... 08:59:36 INFO - Return code: 0 08:59:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:59: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 mozsystemmonitor==0.3 08:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:36 INFO - 'HOME': '/Users/cltbld', 08:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:36 INFO - 'LOGNAME': 'cltbld', 08:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:36 INFO - 'MOZ_NO_REMOTE': '1', 08:59:36 INFO - 'NO_EM_RESTART': '1', 08:59:36 INFO - 'PAGER': '/bin/cat', 08:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:36 INFO - 'PWD': '/builds/slave/test', 08:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:36 INFO - 'SHELL': '/bin/bash', 08:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:36 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:36 INFO - 'USER': 'cltbld', 08:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:36 INFO - 'XPC_FLAGS': '0x0', 08:59:36 INFO - 'XPC_SERVICE_NAME': '0', 08:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:36 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 08:59:36 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 08:59:36 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 08:59:36 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 08:59:36 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 08:59:36 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 08:59:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:39 INFO - Installing collected packages: mozsystemmonitor 08:59:39 INFO - Running setup.py install for mozsystemmonitor 08:59:39 INFO - Successfully installed mozsystemmonitor 08:59:39 INFO - Cleaning up... 08:59:39 INFO - Return code: 0 08:59:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:39 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:39 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 08:59:39 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 08:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:39 INFO - 'HOME': '/Users/cltbld', 08:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:39 INFO - 'LOGNAME': 'cltbld', 08:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:39 INFO - 'MOZ_NO_REMOTE': '1', 08:59:39 INFO - 'NO_EM_RESTART': '1', 08:59:39 INFO - 'PAGER': '/bin/cat', 08:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:39 INFO - 'PWD': '/builds/slave/test', 08:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:39 INFO - 'SHELL': '/bin/bash', 08:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:39 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:39 INFO - 'USER': 'cltbld', 08:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:39 INFO - 'XPC_FLAGS': '0x0', 08:59:39 INFO - 'XPC_SERVICE_NAME': '0', 08:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:39 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 08:59:39 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 08:59:39 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 08:59:39 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 08:59:39 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 08:59:39 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 08:59:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:42 INFO - warning: no files found matching '*.txt' 08:59:42 INFO - no previously-included directories found matching 'build' 08:59:42 INFO - no previously-included directories found matching 'dist' 08:59:42 INFO - no previously-included directories found matching '.git*' 08:59:42 INFO - Installing collected packages: jsonschema, functools32 08:59:43 INFO - Running setup.py install for functools32 08:59:43 INFO - warning: no files found matching '*.txt' 08:59:43 INFO - no previously-included directories found matching 'build' 08:59:43 INFO - no previously-included directories found matching 'dist' 08:59:43 INFO - no previously-included directories found matching '.git*' 08:59:43 INFO - Successfully installed jsonschema functools32 08:59:43 INFO - Cleaning up... 08:59:43 INFO - Return code: 0 08:59:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:43 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 08:59:43 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 08:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:43 INFO - 'HOME': '/Users/cltbld', 08:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:43 INFO - 'LOGNAME': 'cltbld', 08:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:43 INFO - 'MOZ_NO_REMOTE': '1', 08:59:43 INFO - 'NO_EM_RESTART': '1', 08:59:43 INFO - 'PAGER': '/bin/cat', 08:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:43 INFO - 'PWD': '/builds/slave/test', 08:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:43 INFO - 'SHELL': '/bin/bash', 08:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:43 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:43 INFO - 'USER': 'cltbld', 08:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:43 INFO - 'XPC_FLAGS': '0x0', 08:59:43 INFO - 'XPC_SERVICE_NAME': '0', 08:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:43 INFO - Cleaning up... 08:59:43 INFO - Return code: 0 08:59:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:43 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 08:59:43 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 08:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:43 INFO - 'HOME': '/Users/cltbld', 08:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:43 INFO - 'LOGNAME': 'cltbld', 08:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:43 INFO - 'MOZ_NO_REMOTE': '1', 08:59:43 INFO - 'NO_EM_RESTART': '1', 08:59:43 INFO - 'PAGER': '/bin/cat', 08:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:43 INFO - 'PWD': '/builds/slave/test', 08:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:43 INFO - 'SHELL': '/bin/bash', 08:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:43 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:43 INFO - 'USER': 'cltbld', 08:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:43 INFO - 'XPC_FLAGS': '0x0', 08:59:43 INFO - 'XPC_SERVICE_NAME': '0', 08:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:43 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 08:59:43 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 08:59:43 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 08:59:43 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 08:59:43 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 08:59:43 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 08:59:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:47 INFO - Downloading docopt-0.6.1.tar.gz 08:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:47 INFO - Running setup.py install for blobuploader 08:59:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:47 INFO - Running setup.py install for requests 08:59:48 INFO - Running setup.py install for docopt 08:59:48 INFO - Successfully installed blobuploader requests docopt 08:59:48 INFO - Cleaning up... 08:59:48 INFO - Return code: 0 08:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:48 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:48 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 08:59:48 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 08:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:48 INFO - 'HOME': '/Users/cltbld', 08:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:48 INFO - 'LOGNAME': 'cltbld', 08:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:48 INFO - 'MOZ_NO_REMOTE': '1', 08:59:48 INFO - 'NO_EM_RESTART': '1', 08:59:48 INFO - 'PAGER': '/bin/cat', 08:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:48 INFO - 'PWD': '/builds/slave/test', 08:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:48 INFO - 'SHELL': '/bin/bash', 08:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:48 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:48 INFO - 'USER': 'cltbld', 08:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:48 INFO - 'XPC_FLAGS': '0x0', 08:59:48 INFO - 'XPC_SERVICE_NAME': '0', 08:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:48 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-_1rWCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-_86m3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-LU_DJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-HJPLPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3b7VVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-zEfgAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-VFTlEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-j3ijsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-5fwnLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-A2VE86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:49 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-JzRjCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-QV3pxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-uRPWOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-v_gei9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-nMzWtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ixHuE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:50 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ntvT4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:50 INFO - Running setup.py install for manifestparser 08:59:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:50 INFO - Running setup.py install for mozcrash 08:59:50 INFO - Running setup.py install for mozdebug 08:59:51 INFO - Running setup.py install for mozdevice 08:59:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Running setup.py install for mozfile 08:59:51 INFO - Running setup.py install for mozhttpd 08:59:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Running setup.py install for mozinfo 08:59:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Running setup.py install for mozInstall 08:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:51 INFO - Running setup.py install for mozleak 08:59:51 INFO - Running setup.py install for mozlog 08:59:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Running setup.py install for moznetwork 08:59:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Running setup.py install for mozprocess 08:59:52 INFO - Running setup.py install for mozprofile 08:59:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Running setup.py install for mozrunner 08:59:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:52 INFO - Running setup.py install for mozscreenshot 08:59:52 INFO - Running setup.py install for moztest 08:59:53 INFO - Running setup.py install for mozversion 08:59:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:53 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 08:59:53 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 08:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:53 INFO - 'HOME': '/Users/cltbld', 08:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:53 INFO - 'LOGNAME': 'cltbld', 08:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:53 INFO - 'MOZ_NO_REMOTE': '1', 08:59:53 INFO - 'NO_EM_RESTART': '1', 08:59:53 INFO - 'PAGER': '/bin/cat', 08:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:53 INFO - 'PWD': '/builds/slave/test', 08:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:53 INFO - 'SHELL': '/bin/bash', 08:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:53 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:53 INFO - 'USER': 'cltbld', 08:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:53 INFO - 'XPC_FLAGS': '0x0', 08:59:53 INFO - 'XPC_SERVICE_NAME': '0', 08:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:53 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ALa3bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:53 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)) 08:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:53 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-1AnyD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:53 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wg_e3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:53 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)) 08:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:53 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iqEWWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:53 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)) 08:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:53 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-dc7_wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-vBZORw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-1Tkq6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-umPBoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-HNiGpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-4ZgRie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-q50fgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-037hBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-fWHmog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:54 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)) 08:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:54 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-v0804q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-aAfLZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:55 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)) 08:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-9E7661-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:55 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-cO4XA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:55 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)) 08:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:55 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)) 08:59:55 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)) 08:59:55 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)) 08:59:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:55 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 08:59:55 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 08:59:55 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 08:59:55 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 08:59:55 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 08:59:55 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 08:59:57 INFO - Downloading blessings-1.6.tar.gz 08:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:58 INFO - Installing collected packages: blessings 08:59:58 INFO - Running setup.py install for blessings 08:59:58 INFO - Successfully installed blessings 08:59:58 INFO - Cleaning up... 08:59:58 INFO - Return code: 0 08:59:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:58 INFO - Reading from file tmpfile_stdout 08:59:58 INFO - Current package versions: 08:59:58 INFO - blessings == 1.6 08:59:58 INFO - blobuploader == 1.2.4 08:59:58 INFO - docopt == 0.6.1 08:59:58 INFO - functools32 == 3.2.3-2 08:59:58 INFO - jsonschema == 2.5.1 08:59:58 INFO - manifestparser == 1.1 08:59:58 INFO - mozInstall == 1.12 08:59:58 INFO - mozcrash == 1.0 08:59:58 INFO - mozdebug == 0.1 08:59:58 INFO - mozdevice == 0.48 08:59:58 INFO - mozfile == 1.2 08:59:58 INFO - mozhttpd == 0.7 08:59:58 INFO - mozinfo == 0.9 08:59:58 INFO - mozleak == 0.1 08:59:58 INFO - mozlog == 3.4 08:59:58 INFO - moznetwork == 0.27 08:59:58 INFO - mozprocess == 0.23 08:59:58 INFO - mozprofile == 0.28 08:59:58 INFO - mozrunner == 6.13 08:59:58 INFO - mozscreenshot == 0.1 08:59:58 INFO - mozsystemmonitor == 0.3 08:59:58 INFO - moztest == 0.8 08:59:58 INFO - mozversion == 1.4 08:59:58 INFO - psutil == 3.1.1 08:59:58 INFO - requests == 1.2.3 08:59:58 INFO - wsgiref == 0.1.2 08:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:59:59 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 08:59:59 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 08:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 08:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:59 INFO - 'HOME': '/Users/cltbld', 08:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PAGER': '/bin/cat', 08:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 08:59:59 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - 'XPC_FLAGS': '0x0', 08:59:59 INFO - 'XPC_SERVICE_NAME': '0', 08:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 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)) 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:59 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')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:00 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 0x104df4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb35246d750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, '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.uaOInx9uN4/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.p4zFYo0wkT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 09:00:00 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 09:00:00 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 09:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 09:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:00 INFO - 'HOME': '/Users/cltbld', 09:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:00 INFO - 'LOGNAME': 'cltbld', 09:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:00 INFO - 'MOZ_NO_REMOTE': '1', 09:00:00 INFO - 'NO_EM_RESTART': '1', 09:00:00 INFO - 'PAGER': '/bin/cat', 09:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:00 INFO - 'PWD': '/builds/slave/test', 09:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:00 INFO - 'SHELL': '/bin/bash', 09:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 09:00:00 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 09:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:00 INFO - 'USER': 'cltbld', 09:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:00 INFO - 'XPC_FLAGS': '0x0', 09:00:00 INFO - 'XPC_SERVICE_NAME': '0', 09:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:00 INFO - Cleaning up... 09:00:00 INFO - Return code: 0 09:00:00 INFO - Running post-action listener: _resource_record_post_action 09:00:00 INFO - Running post-action listener: _start_resource_monitoring 09:00:00 INFO - Starting resource monitoring. 09:00:00 INFO - [mozharness: 2017-01-30 17:00:00.352551Z] Finished create-virtualenv step (success) 09:00:00 INFO - [mozharness: 2017-01-30 17:00:00.353512Z] Running install step. 09:00:00 INFO - Running pre-action listener: _resource_record_pre_action 09:00:00 INFO - Running main action method: install 09:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:00 INFO - Reading from file tmpfile_stdout 09:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:00 INFO - Reading from file tmpfile_stdout 09:00:00 INFO - Output received: 09:00:00 INFO - Usage: mozinstall [options] installer 09:00:00 INFO - Options: 09:00:00 INFO - -h, --help show this help message and exit 09:00:00 INFO - -d DEST, --destination=DEST 09:00:00 INFO - Directory to install application into. [default: 09:00:00 INFO - "/builds/slave/test"] 09:00:00 INFO - --app=APP Application being installed. [default: firefox] 09:00:00 INFO - mkdir: /builds/slave/test/build/application 09:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:00:21 INFO - Reading from file tmpfile_stdout 09:00:21 INFO - Output received: 09:00:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:00:21 INFO - Running post-action listener: _resource_record_post_action 09:00:21 INFO - [mozharness: 2017-01-30 17:00:21.858954Z] Finished install step (success) 09:00:21 INFO - [mozharness: 2017-01-30 17:00:21.859139Z] Running run-tests step. 09:00:21 INFO - Running pre-action listener: _resource_record_pre_action 09:00:21 INFO - Running main action method: run_tests 09:00:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:00:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:00:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:00:21 INFO - 2017-01-30 09:00:21.873 screenresolution[1638:7553] starting screenresolution argv=screenresolution get 09:00:21 INFO - 2017-01-30 09:00:21.876 screenresolution[1638:7553] Display 0: 1600x1200x32@60 09:00:21 INFO - 2017-01-30 09:00:21.882 screenresolution[1639:7556] starting screenresolution argv=screenresolution list 09:00:21 INFO - Available Modes on Display 0 09:00:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:00:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:00:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:00:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:00:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:00:22 INFO - Intel Iris: 09:00:22 INFO - Chipset Model: Intel Iris 09:00:22 INFO - Type: GPU 09:00:22 INFO - Bus: Built-In 09:00:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:00:22 INFO - Vendor: Intel (0x8086) 09:00:22 INFO - Device ID: 0x0a2e 09:00:22 INFO - Revision ID: 0x0009 09:00:22 INFO - Displays: 09:00:22 INFO - Display: 09:00:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:00:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:00:22 INFO - Display Serial Number: 1600x1200 60 09:00:22 INFO - Main Display: Yes 09:00:22 INFO - Mirror: Off 09:00:22 INFO - Online: Yes 09:00:22 INFO - Rotation: Supported 09:00:22 INFO - Return code: 0 09:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:22 INFO - Python 2.7.3 09:00:22 INFO - Return code: 0 09:00:22 INFO - grabbing minidump binary from tooltool 09:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:22 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 0x104c08d30>, '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 0x104a6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c00b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:22 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 09:00:22 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 09:00:22 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 09:00:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:22 INFO - Return code: 0 09:00:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uaOInx9uN4/Render', 09:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:22 INFO - 'HOME': '/Users/cltbld', 09:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:22 INFO - 'LOGNAME': 'cltbld', 09:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:22 INFO - 'MOZ_NO_REMOTE': '1', 09:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:22 INFO - 'NO_EM_RESTART': '1', 09:00:22 INFO - 'PAGER': '/bin/cat', 09:00:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:22 INFO - 'PWD': '/builds/slave/test', 09:00:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:22 INFO - 'SHELL': '/bin/bash', 09:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4zFYo0wkT/Listeners', 09:00:22 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 09:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:22 INFO - 'USER': 'cltbld', 09:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:22 INFO - 'XPC_FLAGS': '0x0', 09:00:22 INFO - 'XPC_SERVICE_NAME': '0', 09:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:00:22 INFO - mozversion application_buildid: 20170130064142 09:00:22 INFO - mozversion application_changeset: 0f54c5ef73d6fd308bc450835bf8c83840c33548 09:00:22 INFO - mozversion application_display_name: Firefox 09:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:22 INFO - mozversion application_name: Firefox 09:00:22 INFO - mozversion application_remotingname: firefox 09:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:00:22 INFO - mozversion application_vendor: Mozilla 09:00:22 INFO - mozversion application_version: 52.0 09:00:22 INFO - mozversion platform_buildid: 20170130064142 09:00:22 INFO - mozversion platform_changeset: 0f54c5ef73d6fd308bc450835bf8c83840c33548 09:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:00:22 INFO - mozversion platform_version: 52.0 09:00:22 INFO - using testdate: 1485795622 09:00:22 INFO - actual date: 1485795622 09:00:22 INFO - starting webserver on 'localhost:49236' 09:00:22 INFO - SUITE-START | Running 2 tests 09:00:22 INFO - TEST-START | dromaeo_css 09:00:22 INFO - operating with platform_type : mac_ 09:00:22 INFO - Initialising browser for dromaeo_css test... 09:00:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmplrOnWp/profile http://localhost:49236/getInfo.html) 09:00:25 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:00:25 INFO - PROCESS | 1649 | colorDepth:24 09:00:25 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:00:25 INFO - PROCESS | 1649 | __metrics 09:00:25 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:25 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:26 INFO - TEST-INFO | 1649: exit 0 09:00:26 INFO - Browser initialized. 09:00:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmplrOnWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:38 INFO - PROCESS | 1652 | RSS: Main: 171745280 09:00:38 INFO - PROCESS | 1652 | 09:03:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 09:03:43 INFO - PROCESS | 1652 | RSS: Main: 291487744 09:03:43 INFO - PROCESS | 1652 | 09:06:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 09:06:46 INFO - PROCESS | 1652 | RSS: Main: 297345024 09:06:46 INFO - PROCESS | 1652 | 09:09:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 09:09:49 INFO - PROCESS | 1652 | RSS: Main: 271896576 09:09:49 INFO - PROCESS | 1652 | 09:12:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 09:12:52 INFO - PROCESS | 1652 | RSS: Main: 281341952 09:12:52 INFO - PROCESS | 1652 | 09:15:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 09:15:56 INFO - PROCESS | 1652 | RSS: Main: 258957312 09:15:56 INFO - PROCESS | 1652 | 09:18:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 09:18:59 INFO - PROCESS | 1652 | RSS: Main: 315363328 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | __start_tp_report 09:18:59 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:18:59 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:18:59 INFO - PROCESS | 1652 | |i|pagename|runs| 09:18:59 INFO - PROCESS | 1652 | |0;dojo.html;3493.1616412061103;3504;3505.4566542185953;3531.7704349217297;3573.249617580308;5762.250907382039;5828.2423284973;5830.82507524775;5870.501007414369;5932.28812542495;5773.82678519644;5859.472647461727;5860.091685788699;5876.853078673024;5894.17481552583;4665.74025013248;5244.659097158673;5278.155495120782;5291.788328466857;5341.572674186075;5214.087534681435;5244.423113457536;5244.737763111848;5253.527182553569;5377.247185394048;5283.920741188866;5316.867078323035;5316.893662126755;5321.015612111772;5331.866703332428;5312.442193569696;5370.2750128732905;5384.946150538483;5386.569074474032;5410.83767486976;5155.072087024334;5205.24523944026;5259.0796610593;5318.12250978592;5344.91982620261;5719.14212868069;5736.8852622947725;5750.223719797816;5756.769729210827;5821.18503409523;6291.43377096059;6298.716557754912;6298.87402251957;6344.429001389851;6347.904781428282;6210.347913469066;6273;6292.2134733158355;6308.116863639094;6311.747530098791;5800.593958422912;5870.530357571384;5893.5579831512805;5925.585209035326;5974.820755377345;6339.22162851905;6352.904706429407;6365.936340636627;6371.713272902731;6379.617222966544;6103.6948152592195;6265.248170219603;6269.68651567429;6273.560850740496;6295;6224.221972253468;6241.344658810759;6279.717412716439;6287;6289.056641503811;6275.215598050244;6327.936720632735;6332.715027823759;6338.271098823602;6346.4605508532295;6249.468795152463;6292.779752708633;6312.43188113072;6316.4315211630255;6331.27190373113;4391.297392417198;4904.288878112654;4931.087748766489;5002.59979201663;5044.0920634286185;3936.3701807710627;4491.73049617024;4508.684392092522;4565.132624801277;4581.358609794632;6059.606125601822;6060.727247278121;6067.302260240041;6068.544859135494;6078.817635470943;6239.906401403982;6249.875002499924;6258.624482531062;6274.341194174637;6309.968450157719;5840.707964601753;5916.349201587822;5923.378045305181;5986.551008674367;5987.79042733511;5482.259894914216;5493.670379777226;5498.780048798003;5502.972485137549;5504.972475137679;6312.684365781784;6317.5893566918;6318.210223722035;6325.304216536178;6336.239651241973;6169.753209871555;6296.748130074929;6299.370062993664;6306.590071645328;6308.211473565804;6223.813285601439;6274.529410294155;6404.967975160094;6418.550701450854;6427.839304017437;5733.8566535836935;6134.865219626364;6326.778562750282;6336.9049464259;6342.429181373698;6157.9692101540995;6222.751089956351;6266.248050234001;6272.560920735505;6285.120083188449;6219.782307619212;6243.562950593597;6247.5001999839;6249.656268905072;6276.623402595859;6207.96896015517;6216.844578885564;6232.283287421823;6239.1577137087725;6247.250329960434;5673.716314184357;5950.672713000827;6006.909896351471;6058.666773327509;6105.450509453993;5361.410244873139;5531.059719847716;6239.563230573998;6257.4681152102585;6267.435930766253;6098.75604975796;6101.542384321105;6102.023676211785;6133.457080270946;6138.508919286535 09:18:59 INFO - PROCESS | 1652 | |1;ext.html;494.8292838970555;512.5079923273657;514.3750343332849;525.7029778175332;541.4828838459272;26395.868020659895;41802;42652.786736066315;42658.360124598075;43008;44176.558234417724;44494;44519.33221001687;44570.108597828024;44828.77585612075;9052.683156089539;9715.659951901685;9877.407355558653;9907.752306192368;9917.157041651468;9027.684031058914;11721.062315014779;11960.70098247542;11962.700932476715;12193.45129469176;12075.215111017756;12116.394180290994;12127.818082728767;12152.149349545536;12162.391880405989;11647.417629118552;11653;11694.94152529236;11740.354280514568;11764.058875289957;11868.287902725864;11918.880811191864;11923.926846583849;11942.820857687142;11955.282683038959;41681.79159104215;41995.58004419947;42046;42050.78974605138;42068;3470.4794280857823;3492.7904325740283;3645.726570507196;3653.3971894637352;4290.356446533014;31066.689333106606;31077;31280.843595782102;31655.36689266225;31665.683343166733;3233.7413006959387;3267.297531030816;3301.950470742941;3377.915552111217;3408.6761757632985;526062;527739;530710;531504.342478289;538016;35104.47343289853;62664.68667656633;62937;63096.36903630905;63412;35752;36785.448218276746;36835.815820920725;36871.26257474889;36873.44689829655;13642.522511712043;14993.250337483083;15265.236738163047;15280.465183718516;15282.159481228417;11171.888281117084;11282.097432205404;11313.547458101748;12814.80777788334;12974.545890893773;7757.68969241224;7797;8041.3968952328805;8236.752897413087;8267.421280510307;3288.145082278577;3347.7489188310974;3359.6976272135626;3364.3944090063533;3381.7801842880626;941.2093841173447;991.5092029445326;1000.3897622450445;1032.4682788363998;1076.9299995500267;28852.855735721187;29366;30261;31011.379772404878;31067.84466077655;940.7930255343813;981.4085285783382;1012.731626119079;1052.3738375666467;1068.7755571330108;14533.34599943005;15481.5355539334;15570.9221453892;15775.605609859846;15844.76232856508;682239;686931;687978;692064;693419;59035.40964590385;59280.40719592749;59440;59490;59540;1269.752398282326;1308.6466654003557;1388.3821699343696;1403.7052219033912;1430.9141451512942;24334.51330973406;29958.400831983676;31295.374092517566;31371.843140785062;31621.36757264888;51180.232296514834;51705.44883653496;51710.48289517207;51754.74122629363;51828;618454;623579;624020;625985;630302;22075.55848882981;24323.39191520226;24850.751492484844;26605.334866628487;26942;46364.53635463737;46443;46510.302345464166;46578.06843863036;46901.29648055213;31563.52654710135;35147;38737;38824.611753883226;38948.6105138945;38453.576440379795;38649.2270154601;38829.41755873607;39172.6082739169;39448.802755986035;36468.27063458769;37329.4400583986;37915.241695165394;38198.427023594115;38549.6145038546;32075.83962080268;33678.66321336755;34265.65734342724;34404.65595344115;34682;25901.611475828253;25918.092866749572;25977.610335844598;26175.476490470464;26436.735632643427 09:18:59 INFO - PROCESS | 1652 | |2;jquery.html;329.27887925443287;372.6087608011588;393.9684825213983;396.45883369201016;397.5667717877053;19327.710084348746;20468.590628187445;20873.791262087394;20910.163593456244;21075.894620526877;20242.493937651565;20535.794642053574;20795.376138715863;21046.89476552619;21143.682844757343;5305.814296499633;5723.942760572403;5965.164876917235;6116.235470566179;6130.233720784902;6008.218931538916;6048.364921683204;6055.697215139226;6055.818325450244;6062.060380641008;5278.524932756051;5857.589968702193;6044.576879618407;6262.749490020394;6269.780557680482;5951.988162012468;6244.531660125486;6297;6297.370262973712;6304.936950630481;4926.3595732554895;5822.155787410802;5824.504917082053;5834.27071616048;5838.124281357788;13391.397387117602;13614.659633509142;20035.298764543317;21121.78878211229;24912.626310605356;2298.988505057464;2301.8849057547222;2355.869182792252;2358.9410264743346;2440.1703420836825;10107.444090575016;10616.097631701237;10746.892531074667;13180.802287965687;15023.399064037425;1936.7579052618423;1954.595847108065;1984.28565716342;2000.1799262302532;2027.5843452092286;80303.59848200722;118311.4084429581;118593.99999999914;119936.40031799785;120094.19858702127;9688.757781055388;11567.074634029257;11618.186726929203;11712.531498740125;11889.405529723479;15000.69998600022;15034.624134396727;15045.548633541011;15050.473233436776;15057.774133388008;8309.709160179365;8405.621747021398;8445.239928406472;8457.154284571616;8556.401051926305;6806.863862722717;8259.703571269865;8259.710910118118;8379.664813407517;8384.287335576422;4590.839320623762;4595.448546174481;4599.402077729874;4601.700889442175;4696.60078893291;1668.883178177516;1910.6083252933115;1955.8435325173953;1963.0957970768332;1965.1058768260407;857.4598003258033;966.2415004221652;997.5012493753123;1017.9536343036372;1024.1192574386023;21127.788722112582;21474.355769326947;21535.89232053861;21556.137754489646;21584.784152158278;881.8060026794095;952.2619969523674;987.160913223754;995.3579940938055;1056.0073530880948;10384.948075259575;10813.141500597305;10814.456579302263;10820.134389248999;10830.31774160723;602024;612671;621677;623540;631089;127945.36027319804;129666;133743;137094;137255;988.6984469736656;990.5641517732175;996.9551370188359;1011.4032720694826;1013.2653825976108;18002.909985449987;18683.90658046701;18836.811631883505;18938.52653683614;18978.335758248395;51983.48016519786;53930;54094.729526352115;55104.62238444071;55154;72015;76458.61770691111;80174;81315;83152;5498.642588231752;7361.558306501627;7998.760037198894;8182.836343272982;8261.38039647041;10694.946525267324;12498;12564;12627.368631568568;12693.873061269269;10803.891961080602;10820.458977051274;10994.890051099386;11318;11358.09135269193;9451.243900488082;9527.857082143912;10720.142388608736;10873.619423320146;10914.781704366027;11295.830562541732;11336.206465547333;11457.140714446616;11555.653330399766;11717.765644686888;7932.6033698313695;7950.801229969297;8156.592170391338;8181.954511372157;8258.504489730636;8129.065157506962;10637;10838.620648277272;11081.722956926142;11244.437778111225 09:18:59 INFO - PROCESS | 1652 | |3;mootools.html;1372.8489866114733;1382.4124746982532;1504.6840163565655;1517.975366627527;1844.2715127524627;7586.810329741759;7976.162502937188;8314.127016663255;8502.744917652464;8518.488890666564;8409.159084091587;8477.78805529862;8514.148585141484;8518.616662250199;8523.360747943898;2386.260259319612;2420.455397535558;2424.3939015246187;2427.7208121066037;2427.817913656474;2395.7484464131276;2434.8295619306655;2448.8897999590063;2455.5702752018415;2462.8029757619347;2393.210240620591;2404.6393041043807;2424.6847909771705;2426.8301218914594;2429.5626787178303;2314.2825724025606;2351.0595761695286;2379.916702915407;2384.6423036544397;2400.9159679411136;2341.040173528845;2370.561446132471;2399.208261273793;2407.2417188585714;2410.6625072489865;8412.11672774356;8429.95785021077;8503.659853605848;8504.27713644341;8518.616662250213;5080.263361812516;5255.211718242294;5256.159014557652;5271.42014378418;5272.446393128743;3457.3431048101033;3555.5377800885976;3586.8027258500774;3612.8735494257576;3617.493550902849;1112.06586467367;1114.9832752508719;1127.971800704989;1131.4512461456188;1137.2891942535914;11005.944970275177;11033.393163376011;11073.446327683583;11118.666440006893;11119.444027798658;3882.6699730522655;4383.3424986251675;4485.932711009337;4550.97724511382;4570.200214962435;8794.120587941155;8813.383063185516;8824.470531768115;8831.867521987175;8861.512616806009;5099.949000509948;5195.350581177353;5197;5201.895962080737;5203;4183.979080104641;4441.866743997685;4460.464744230648;4512.810366999729;4915.139850526144;3213;3736.645018723217;3852.6725228355904;3854.8843534694006;3861.517310336208;1159.431878379588;1169.5497233564968;1170.6136974798296;1178.5639313454076;1182.4737991593659;778.6457161991281;865.35098675993;899.5682072605056;923.6720964057797;926.1016813690709;4969.652124351261;5711.143328500758;5840.182374467578;5992.280926288786;6103.786367477117;747.8242612985944;951.8286708392417;956.3926906414338;973.2966064126068;995.955182016811;3560.661737134968;3735.215604722984;3815.4276858471453;3857.7106716995777;3914.119323152268;10051.447170405552;10298.845517317246;10319.380837149794;10340.741481462874;10412.739681507872;9716.514174291398;10197.94901025505;10201.897981020244;10280.228982826318;10282.742931426625;7917.683292668229;8105.837883242302;8121.350291976628;8154.469959452616;8160.143184965612;5694.1458781183155;5705.7432415542235;5735.655860648374;5813.215215945793;6062.42406971337;9488.003759605142;9591.568379423083;9594.616215351307;9595.760105997406;9608.039196080335;9011.864822027545;9315.953420232856;9690.51547422612;9712.951435242778;9821.017898210122;7138.393236574741;7269.527480713737;7276.345128938421;7308.926910730825;7404.370628496638;8098.51408915467;8114.350851931949;8180.345572354078;8188.344932405513;8188.50868947865;7204.423646108404;7324.414046876131;7364.889526657212;7389.963050184715;7463.2163622818825;6784.2876497967;7027.61348125858;7142.714291428285;7181.210066892742;7191;6742.292059333699;6812.420944219797;6917.619530925646;6917.861642767217;6925.515213934977;4962.280469331999;4965.106280869478;4996.2505624156665;5015.122353588181;5022.598192144693;4920.458749537476;4923.236898280772;4961.330220420197;5073;5075.492450754895 09:18:59 INFO - PROCESS | 1652 | |4;prototype.html;304.90700336397396;309.1529209964696;314.4748270388451;319.9744020478362;323.89797213877614;5094.930064686416;5125.641704948182;5146.558963490224;5149.356330458692;5159.638825282227;4251.511076226235;4510.639148868091;4910.803567857281;4986.576141028008;5032.948476476435;3344.799312041273;3873.571888878335;3925.685945124383;3965.8017099145072;3982.8406863725418;3357.4292370297107;3498.7900725956524;3614.0484138565143;3981.362981922893;3989.780562069085;3098.032749204249;3808.7143464240153;3907.745996510232;3908.2183563287313;3937.448757173998;3528.3648943190215;3890.961090389088;3903;3923.2153569286115;3944.7633142011427;2685.476332115238;2976.3600825822336;3302.5211344355175;3355.39602871483;3371.0392538126516;4377.233984052778;4810.567048965575;4977.328060711794;5061.645684802065;5087.898242035176;4086.9591304086875;4229.513605935326;4508.368828364031;4520.570545798144;4539.4779600346055;4497.842575509874;4806.894414284699;5432;5485.286912701324;5498.5876059295715;3781.4327850822324;3781.6029316921604;3782.9432558511644;3792.848286068554;3801.068738159141;4190.580941905816;5362.624616276862;5642.830715078513;5719.399463056361;5770.163326317703;3157.500187410961;3754.530683664542;3760.4206233382047;3766.1902690921584;3791;3822.808859557011;3822.9426558601645;3824.388097904322;3845.577136459528;3846.807659617008;3650.653187947141;4438.533953934855;4470.284754439274;4484.192845287879;4495.57292057254;4356.978215108904;4511.458624965026;5141.665791723526;5432.91850622241;5492.752826122834;1159.9014083802972;1239.4630657984214;1252.7807633664072;1257.7107265329025;1264.8608653048157;765.1010063175746;800.9038915330198;819.5943008210974;904.7785489589133;918.0910898210723;4048.9392659110135;4563.106310880948;4739.668223224341;4856.329019039585;4890.535399137077;4360.010590309831;4737.549932756451;4796.640251981115;4993.629300222336;5183.352080989876;3858.3826587745825;4161.521425036099;4180.895477613084;4439.135563063521;5003.649744517848;2374.5607062693457;2512.9748702512743;2782.095818858879;2811.5642075478336;2840.67332256789;5131.5638170755155;5554.139872788454;5559.944400555943;5647.745851436695;5693;5181.81863634771;5371.221172929903;5393.406725260218;5408.7566059526625;5437.864053398696;4875.926861097158;5244.895102097937;5469;5472.6741135017455;5496.945030549643;4452.1763473757455;4479.395281636937;5077.0399088710865;5184.274201611853;5360.62475626718;4359.583135481044;4813.95186048135;4979.253112033224;5151.742412879266;5154.381474223117;5566.832995010156;5641.943580564306;5652.519535839499;5658.575606829422;5670.574706896917;3583.8208089594896;3594.2631760488516;3602.873899413508;3620.31214069326;3668.321360548307;5258.527612268571;5320.388155362183;5592.245046918614;5607.981126794432;5688.744006519633;5255.553277971415;5423.538999185113;5424.484673955968;5435.483629055233;5468.867141814616;4409.3606427068535;4609.539046095364;4735.952640473689;5339.279197308314;5529.170624406372;4766.428028636586;5100.770465329143;5152.201408781645;5335.546478549367;5446.373667028342;4736.57902629203;5233.842984710464;5352.732363381893;5416.647917885325;5484.862878428071;4616.561426664462;5281.735913204401;5297.337832770903;5323.361196656426;5337.626366154487 09:18:59 INFO - PROCESS | 1652 | |5;yui.html;707.2609123465975;744.3821628048719;764.094547960667;765.9272369124934;837.7151768398743;14632.414703411863;15673.373065077383;15701.136437495934;15703.92148039261;15726.449574264903;13875.098118622282;14059.437622495114;14061.437542498288;14089.225092619901;14105.294735263222;721.8051126195924;745.9891846547931;881.8721285413611;908.1554154636186;910.0217266438572;901.9503927283997;906.9093090690911;910.6630546697731;916.7891384981458;918.1323649151554;972.863799068131;978.6476868327396;979.686500319898;982.2878413150445;987.1757082835841;969.8011907558933;970.752458123174;971.3103696375582;971.961121555137;973.265184785486;732.6190381001902;732.9157146928064;733.3216774483635;733.4572416411817;736.1975446763054;14569.70860582793;14577.562673119823;14589.635259118608;14609.48866789668;15050.247487625575;14013.789793153112;14100.224487653175;14443.566692999122;14478.92760536201;14486.927565362106;11781.528738850435;11797.29216247028;12196.695082622917;12795.360231988363;12933.288669123194;3920.7843568603716;3989.6409323161056;4003.719739618228;4048.291548978917;4064.410660454247;96862;98651;99575.50636740455;100175;100453.49319760136;11027.44862756859;11060.834087488694;11319.151063670257;11464.197506174487;11720.296782193096;22316.214702823734;22391.888040559694;22637;22702.205422810122;23028.884855575616;8059.758207253792;8080.4343695940715;8110.148434414419;8180.713675021346;8236.876446853303;4460.799264033127;4506.188886000486;4564.703294285927;4674.392328997209;4717.033008233304;3559.519464872261;3672.467492213614;3703.2408356286896;3716.7955762433326;3900.9219815604097;738.3613174603929;739.6264886232526;753.6985205917567;754.4304050441881;762.92752188542;656.2682608891052;659.1957811469999;666.9899951500731;683.3815397065664;687.6492988575762;9323.860142097874;9858.556364963593;9862.901370986197;9914.652987145415;9990.900090999143;615.2186722861941;665.0197628458498;682.1064405628543;684.226823689228;695.2421860172436;4594.563516465931;4759.976200118977;4771.5467030632035;4775.235962246094;4786.593139583105;81118.59440702877;81727.18272817196;98222.5088874551;125177;128367;80531.59734201408;101622.47566286512;108108.91891081145;109068;111460.44269778761;98171;98598.5070074645;99001.50499247458;99519;101511;8851.424657397249;9217.124373184537;9393.497040473492;9860.408375497493;10090.394576325443;49894;50034.49965500298;50847.74576127244;51868.740656296475;52657.73671131773;73579.63210183915;75244.62377688076;76310;76914.846277307;78611;12755.234685918875;13028.61597817044;13212.339383030618;13302.600921972356;13452.192868427926;14702.338394772047;14745;14810.481633142788;14906.627334316296;14972.176530290939;13382;13650.93174534121;13988.020838541204;14361.994660373673;14647.26763661834;11549.6535103947;14072.085314454527;14460.927695361455;14659;14664.853351466349;13372.531961381304;13423.127496712683;13586.184828910296;13786.379612917643;13820.23988680592;11229.887701122883;11476.885231147582;11490.482928268415;11978.940105299418;12027.037836972846;10915.617953371593;11457;11481.827772583585;11655.708607284885;11662.241954272946 09:18:59 INFO - PROCESS | 1652 | __end_tp_report 09:18:59 INFO - PROCESS | 1652 | __start_cc_report 09:18:59 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1214 09:18:59 INFO - PROCESS | 1652 | __end_cc_report 09:18:59 INFO - PROCESS | 1652 | __startTimestamp1485796739155__endTimestamp 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:18:59 INFO - PROCESS | 1652 | Number of tests: 6 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5824.52 Median:6098.76 stddev:645.47 (10.6%) stddev-sans-first:621.00 09:18:59 INFO - PROCESS | 1652 | Values: 3493.2 3504.0 3505.5 3531.8 3573.2 5762.3 5828.2 5830.8 5870.5 5932.3 5773.8 5859.5 5860.1 5876.9 5894.2 4665.7 5244.7 5278.2 5291.8 5341.6 5214.1 5244.4 5244.7 5253.5 5377.2 5283.9 5316.9 5316.9 5321.0 5331.9 5312.4 5370.3 5384.9 5386.6 5410.8 5155.1 5205.2 5259.1 5318.1 5344.9 5719.1 5736.9 5750.2 5756.8 5821.2 6291.4 6298.7 6298.9 6344.4 6347.9 6210.3 6273.0 6292.2 6308.1 6311.7 5800.6 5870.5 5893.6 5925.6 5974.8 6339.2 6352.9 6365.9 6371.7 6379.6 6103.7 6265.2 6269.7 6273.6 6295.0 6224.2 6241.3 6279.7 6287.0 6289.1 6275.2 6327.9 6332.7 6338.3 6346.5 6249.5 6292.8 6312.4 6316.4 6331.3 4391.3 4904.3 4931.1 5002.6 5044.1 3936.4 4491.7 4508.7 4565.1 4581.4 6059.6 6060.7 6067.3 6068.5 6078.8 6239.9 6249.9 6258.6 6274.3 6310.0 5840.7 5916.3 5923.4 5986.6 5987.8 5482.3 5493.7 5498.8 5503.0 5505.0 6312.7 6317.6 6318.2 6325.3 6336.2 6169.8 6296.7 6299.4 6306.6 6308.2 6223.8 6274.5 6405.0 6418.6 6427.8 5733.9 6134.9 6326.8 6336.9 6342.4 6158.0 6222.8 6266.2 6272.6 6285.1 6219.8 6243.6 6247.5 6249.7 6276.6 6208.0 6216.8 6232.3 6239.2 6247.3 5673.7 5950.7 6006.9 6058.7 6105.5 5361.4 5531.1 6239.6 6257.5 6267.4 6098.8 6101.5 6102.0 6133.5 6138.5 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:73106.99 Median:35449.50 stddev:165684.24 (467.4%) stddev-sans-first:166059.33 09:18:59 INFO - PROCESS | 1652 | Values: 494.8 512.5 514.4 525.7 541.5 26395.9 41802.0 42652.8 42658.4 43008.0 44176.6 44494.0 44519.3 44570.1 44828.8 9052.7 9715.7 9877.4 9907.8 9917.2 9027.7 11721.1 11960.7 11962.7 12193.5 12075.2 12116.4 12127.8 12152.1 12162.4 11647.4 11653.0 11694.9 11740.4 11764.1 11868.3 11918.9 11923.9 11942.8 11955.3 41681.8 41995.6 42046.0 42050.8 42068.0 3470.5 3492.8 3645.7 3653.4 4290.4 31066.7 31077.0 31280.8 31655.4 31665.7 3233.7 3267.3 3302.0 3377.9 3408.7 526062.0 527739.0 530710.0 531504.3 538016.0 35104.5 62664.7 62937.0 63096.4 63412.0 35752.0 36785.4 36835.8 36871.3 36873.4 13642.5 14993.3 15265.2 15280.5 15282.2 11171.9 11282.1 11313.5 12814.8 12974.5 7757.7 7797.0 8041.4 8236.8 8267.4 3288.1 3347.7 3359.7 3364.4 3381.8 941.2 991.5 1000.4 1032.5 1076.9 28852.9 29366.0 30261.0 31011.4 31067.8 940.8 981.4 1012.7 1052.4 1068.8 14533.3 15481.5 15570.9 15775.6 15844.8 682239.0 686931.0 687978.0 692064.0 693419.0 59035.4 59280.4 59440.0 59490.0 59540.0 1269.8 1308.6 1388.4 1403.7 1430.9 24334.5 29958.4 31295.4 31371.8 31621.4 51180.2 51705.4 51710.5 51754.7 51828.0 618454.0 623579.0 624020.0 625985.0 630302.0 22075.6 24323.4 24850.8 26605.3 26942.0 46364.5 46443.0 46510.3 46578.1 46901.3 31563.5 35147.0 38737.0 38824.6 38948.6 38453.6 38649.2 38829.4 39172.6 39448.8 36468.3 37329.4 37915.2 38198.4 38549.6 32075.8 33678.7 34265.7 34404.7 34682.0 25901.6 25918.1 25977.6 26175.5 26436.7 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35439.48 Median:2328.88 stddev:103069.96 (4425.7%) stddev-sans-first:103325.38 09:18:59 INFO - PROCESS | 1652 | Values: 329.3 372.6 394.0 396.5 397.6 19327.7 20468.6 20873.8 20910.2 21075.9 20242.5 20535.8 20795.4 21046.9 21143.7 5305.8 5723.9 5965.2 6116.2 6130.2 6008.2 6048.4 6055.7 6055.8 6062.1 5278.5 5857.6 6044.6 6262.7 6269.8 5952.0 6244.5 6297.0 6297.4 6304.9 4926.4 5822.2 5824.5 5834.3 5838.1 13391.4 13614.7 20035.3 21121.8 24912.6 2299.0 2301.9 2355.9 2358.9 2440.2 10107.4 10616.1 10746.9 13180.8 15023.4 1936.8 1954.6 1984.3 2000.2 2027.6 80303.6 118311.4 118594.0 119936.4 120094.2 9688.8 11567.1 11618.2 11712.5 11889.4 15000.7 15034.6 15045.5 15050.5 15057.8 8309.7 8405.6 8445.2 8457.2 8556.4 6806.9 8259.7 8259.7 8379.7 8384.3 4590.8 4595.4 4599.4 4601.7 4696.6 1668.9 1910.6 1955.8 1963.1 1965.1 857.5 966.2 997.5 1018.0 1024.1 21127.8 21474.4 21535.9 21556.1 21584.8 881.8 952.3 987.2 995.4 1056.0 10384.9 10813.1 10814.5 10820.1 10830.3 602024.0 612671.0 621677.0 623540.0 631089.0 127945.4 129666.0 133743.0 137094.0 137255.0 988.7 990.6 997.0 1011.4 1013.3 18002.9 18683.9 18836.8 18938.5 18978.3 51983.5 53930.0 54094.7 55104.6 55154.0 72015.0 76458.6 80174.0 81315.0 83152.0 5498.6 7361.6 7998.8 8182.8 8261.4 10694.9 12498.0 12564.0 12627.4 12693.9 10803.9 10820.5 10994.9 11318.0 11358.1 9451.2 9527.9 10720.1 10873.6 10914.8 11295.8 11336.2 11457.1 11555.7 11717.8 7932.6 7950.8 8156.6 8182.0 8258.5 8129.1 10637.0 10838.6 11081.7 11244.4 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5523.22 Median:5090.11 stddev:3019.62 (59.3%) stddev-sans-first:3011.98 09:18:59 INFO - PROCESS | 1652 | Values: 1372.8 1382.4 1504.7 1518.0 1844.3 7586.8 7976.2 8314.1 8502.7 8518.5 8409.2 8477.8 8514.1 8518.6 8523.4 2386.3 2420.5 2424.4 2427.7 2427.8 2395.7 2434.8 2448.9 2455.6 2462.8 2393.2 2404.6 2424.7 2426.8 2429.6 2314.3 2351.1 2379.9 2384.6 2400.9 2341.0 2370.6 2399.2 2407.2 2410.7 8412.1 8430.0 8503.7 8504.3 8518.6 5080.3 5255.2 5256.2 5271.4 5272.4 3457.3 3555.5 3586.8 3612.9 3617.5 1112.1 1115.0 1128.0 1131.5 1137.3 11005.9 11033.4 11073.4 11118.7 11119.4 3882.7 4383.3 4485.9 4551.0 4570.2 8794.1 8813.4 8824.5 8831.9 8861.5 5099.9 5195.4 5197.0 5201.9 5203.0 4184.0 4441.9 4460.5 4512.8 4915.1 3213.0 3736.6 3852.7 3854.9 3861.5 1159.4 1169.5 1170.6 1178.6 1182.5 778.6 865.4 899.6 923.7 926.1 4969.7 5711.1 5840.2 5992.3 6103.8 747.8 951.8 956.4 973.3 996.0 3560.7 3735.2 3815.4 3857.7 3914.1 10051.4 10298.8 10319.4 10340.7 10412.7 9716.5 10197.9 10201.9 10280.2 10282.7 7917.7 8105.8 8121.4 8154.5 8160.1 5694.1 5705.7 5735.7 5813.2 6062.4 9488.0 9591.6 9594.6 9595.8 9608.0 9011.9 9316.0 9690.5 9713.0 9821.0 7138.4 7269.5 7276.3 7308.9 7404.4 8098.5 8114.4 8180.3 8188.3 8188.5 7204.4 7324.4 7364.9 7390.0 7463.2 6784.3 7027.6 7142.7 7181.2 7191.0 6742.3 6812.4 6917.6 6917.9 6925.5 4962.3 4965.1 4996.3 5015.1 5022.6 4920.5 4923.2 4961.3 5073.0 5075.5 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4273.00 Median:4736.27 stddev:1312.84 (27.7%) stddev-sans-first:1282.30 09:18:59 INFO - PROCESS | 1652 | Values: 304.9 309.2 314.5 320.0 323.9 5094.9 5125.6 5146.6 5149.4 5159.6 4251.5 4510.6 4910.8 4986.6 5032.9 3344.8 3873.6 3925.7 3965.8 3982.8 3357.4 3498.8 3614.0 3981.4 3989.8 3098.0 3808.7 3907.7 3908.2 3937.4 3528.4 3891.0 3903.0 3923.2 3944.8 2685.5 2976.4 3302.5 3355.4 3371.0 4377.2 4810.6 4977.3 5061.6 5087.9 4087.0 4229.5 4508.4 4520.6 4539.5 4497.8 4806.9 5432.0 5485.3 5498.6 3781.4 3781.6 3782.9 3792.8 3801.1 4190.6 5362.6 5642.8 5719.4 5770.2 3157.5 3754.5 3760.4 3766.2 3791.0 3822.8 3822.9 3824.4 3845.6 3846.8 3650.7 4438.5 4470.3 4484.2 4495.6 4357.0 4511.5 5141.7 5432.9 5492.8 1159.9 1239.5 1252.8 1257.7 1264.9 765.1 800.9 819.6 904.8 918.1 4048.9 4563.1 4739.7 4856.3 4890.5 4360.0 4737.5 4796.6 4993.6 5183.4 3858.4 4161.5 4180.9 4439.1 5003.6 2374.6 2513.0 2782.1 2811.6 2840.7 5131.6 5554.1 5559.9 5647.7 5693.0 5181.8 5371.2 5393.4 5408.8 5437.9 4875.9 5244.9 5469.0 5472.7 5496.9 4452.2 4479.4 5077.0 5184.3 5360.6 4359.6 4814.0 4979.3 5151.7 5154.4 5566.8 5641.9 5652.5 5658.6 5670.6 3583.8 3594.3 3602.9 3620.3 3668.3 5258.5 5320.4 5592.2 5608.0 5688.7 5255.6 5423.5 5424.5 5435.5 5468.9 4409.4 4609.5 4736.0 5339.3 5529.2 4766.4 5100.8 5152.2 5335.5 5446.4 4736.6 5233.8 5352.7 5416.6 5484.9 4616.6 5281.7 5297.3 5323.4 5337.6 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:21660.71 Median:4483.49 stddev:31715.78 (707.4%) stddev-sans-first:31765.73 09:18:59 INFO - PROCESS | 1652 | Values: 707.3 744.4 764.1 765.9 837.7 14632.4 15673.4 15701.1 15703.9 15726.4 13875.1 14059.4 14061.4 14089.2 14105.3 721.8 746.0 881.9 908.2 910.0 902.0 906.9 910.7 916.8 918.1 972.9 978.6 979.7 982.3 987.2 969.8 970.8 971.3 972.0 973.3 732.6 732.9 733.3 733.5 736.2 14569.7 14577.6 14589.6 14609.5 15050.2 14013.8 14100.2 14443.6 14478.9 14486.9 11781.5 11797.3 12196.7 12795.4 12933.3 3920.8 3989.6 4003.7 4048.3 4064.4 96862.0 98651.0 99575.5 100175.0 100453.5 11027.4 11060.8 11319.2 11464.2 11720.3 22316.2 22391.9 22637.0 22702.2 23028.9 8059.8 8080.4 8110.1 8180.7 8236.9 4460.8 4506.2 4564.7 4674.4 4717.0 3559.5 3672.5 3703.2 3716.8 3900.9 738.4 739.6 753.7 754.4 762.9 656.3 659.2 667.0 683.4 687.6 9323.9 9858.6 9862.9 9914.7 9990.9 615.2 665.0 682.1 684.2 695.2 4594.6 4760.0 4771.5 4775.2 4786.6 81118.6 81727.2 98222.5 125177.0 128367.0 80531.6 101622.5 108108.9 109068.0 111460.4 98171.0 98598.5 99001.5 99519.0 101511.0 8851.4 9217.1 9393.5 9860.4 10090.4 49894.0 50034.5 50847.7 51868.7 52657.7 73579.6 75244.6 76310.0 76914.8 78611.0 12755.2 13028.6 13212.3 13302.6 13452.2 14702.3 14745.0 14810.5 14906.6 14972.2 13382.0 13650.9 13988.0 14362.0 14647.3 11549.7 14072.1 14460.9 14659.0 14664.9 13372.5 13423.1 13586.2 13786.4 13820.2 11229.9 11476.9 11490.5 11978.9 12027.0 10915.6 11457.0 11481.8 11655.7 11662.2 09:18:59 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:18:59 INFO - PROCESS | 1652 | 09:18:59 INFO - TEST-INFO | 1652: exit 0 09:18:59 INFO - TEST-OK | dromaeo_css | took 1117267ms 09:18:59 INFO - TEST-START | kraken 09:18:59 INFO - operating with platform_type : mac_ 09:18:59 INFO - Initialising browser for kraken test... 09:18:59 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpxdx0K1/profile http://localhost:49236/getInfo.html) 09:19:02 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:19:02 INFO - PROCESS | 1661 | colorDepth:24 09:19:02 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:19:02 INFO - PROCESS | 1661 | __metrics 09:19:02 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:02 INFO - PROCESS | 1661 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:03 INFO - TEST-INFO | 1661: exit 0 09:19:03 INFO - Browser initialized. 09:19:03 INFO - Running cycle 1/1 for kraken test... 09:19:03 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpxdx0K1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:15 INFO - PROCESS | 1663 | RSS: Main: 171540480 09:19:15 INFO - PROCESS | 1663 | 09:19:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:18 INFO - PROCESS | 1663 | RSS: Main: 221470720 09:19:18 INFO - PROCESS | 1663 | 09:19:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 09:19:21 INFO - PROCESS | 1663 | RSS: Main: 233205760 09:19:21 INFO - PROCESS | 1663 | 09:19:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 09:19:25 INFO - PROCESS | 1663 | RSS: Main: 332120064 09:19:25 INFO - PROCESS | 1663 | 09:19:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 09:19:28 INFO - PROCESS | 1663 | RSS: Main: 233545728 09:19:28 INFO - PROCESS | 1663 | 09:19:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:31 INFO - PROCESS | 1663 | RSS: Main: 234553344 09:19:31 INFO - PROCESS | 1663 | 09:19:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:34 INFO - PROCESS | 1663 | RSS: Main: 274231296 09:19:34 INFO - PROCESS | 1663 | 09:19:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:38 INFO - PROCESS | 1663 | RSS: Main: 275943424 09:19:38 INFO - PROCESS | 1663 | 09:19:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 09:19:41 INFO - PROCESS | 1663 | RSS: Main: 275046400 09:19:41 INFO - PROCESS | 1663 | 09:19:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:43 INFO - PROCESS | 1663 | RSS: Main: 249094144 09:19:43 INFO - PROCESS | 1663 | 09:19:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:46 INFO - PROCESS | 1663 | RSS: Main: 254124032 09:19:46 INFO - PROCESS | 1663 | 09:19:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:48 INFO - PROCESS | 1663 | RSS: Main: 256933888 09:19:48 INFO - PROCESS | 1663 | 09:19:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:52 INFO - PROCESS | 1663 | RSS: Main: 272695296 09:19:52 INFO - PROCESS | 1663 | 09:19:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:55 INFO - PROCESS | 1663 | RSS: Main: 266252288 09:19:55 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 09:19:57 INFO - PROCESS | 1663 | RSS: Main: 310816768 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | __start_tp_report 09:19:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:19:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:19:57 INFO - PROCESS | 1663 | |i|pagename|runs| 09:19:57 INFO - PROCESS | 1663 | |0;ai-astar;115;114;115;113;114;114;114;117;113;114 09:19:57 INFO - PROCESS | 1663 | |1;audio-beat-detection;141;108;106;141;108;106;108;107;134;106 09:19:57 INFO - PROCESS | 1663 | |2;audio-dft;184;186;183;182;182;182;183;197;259;204 09:19:57 INFO - PROCESS | 1663 | |3;audio-fft;80;59;58;91;60;57;58;57;99;80 09:19:57 INFO - PROCESS | 1663 | |4;audio-oscillator;85;72;92;70;68;68;89;96;84;89 09:19:57 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;103;129;74;129;134;110;89;85;89;84 09:19:57 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;92;93;92;93;101;92;91;132;137 09:19:57 INFO - PROCESS | 1663 | |7;imaging-desaturate;73;115;126;129;95;81;101;136;82;83 09:19:57 INFO - PROCESS | 1663 | |8;json-parse-financial;56;56;52;52;56;57;58;57;55;57 09:19:57 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;68;75;69;63;66;67;72;68;69;70 09:19:57 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;82;82;82;81;84;80;80;83;81 09:19:57 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;140;134;135;135;132;140;147;147;195;134 09:19:57 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;162;160;164;161;162;160;169;159;162;160 09:19:57 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;65;66;67;65;64;65;65;64;65;63 09:19:57 INFO - PROCESS | 1663 | __end_tp_report 09:19:57 INFO - PROCESS | 1663 | __start_cc_report 09:19:57 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1840 09:19:57 INFO - PROCESS | 1663 | __end_cc_report 09:19:57 INFO - PROCESS | 1663 | __startTimestamp1485796797788__endTimestamp 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:19:57 INFO - PROCESS | 1663 | Number of tests: 14 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 09:19:57 INFO - PROCESS | 1663 | Values: 115.0 114.0 115.0 113.0 114.0 114.0 114.0 117.0 113.0 114.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:108.00 stddev:15.44 (14.3%) stddev-sans-first:13.59 09:19:57 INFO - PROCESS | 1663 | Values: 141.0 108.0 106.0 141.0 108.0 106.0 108.0 107.0 134.0 106.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:194.20 Median:185.00 stddev:23.97 (13.0%) stddev-sans-first:25.14 09:19:57 INFO - PROCESS | 1663 | Values: 184.0 186.0 183.0 182.0 182.0 182.0 183.0 197.0 259.0 204.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:69.90 Median:70.00 stddev:16.09 (23.0%) stddev-sans-first:16.64 09:19:57 INFO - PROCESS | 1663 | Values: 80.0 59.0 58.0 91.0 60.0 57.0 58.0 57.0 99.0 80.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:87.00 stddev:10.74 (12.3%) stddev-sans-first:11.31 09:19:57 INFO - PROCESS | 1663 | Values: 85.0 72.0 92.0 70.0 68.0 68.0 89.0 96.0 84.0 89.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:79.00 stddev:21.80 (27.6%) stddev-sans-first:23.13 09:19:57 INFO - PROCESS | 1663 | Values: 103.0 129.0 74.0 129.0 134.0 110.0 89.0 85.0 89.0 84.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:92.00 stddev:17.60 (19.1%) stddev-sans-first:18.39 09:19:57 INFO - PROCESS | 1663 | Values: 93.0 92.0 93.0 92.0 93.0 101.0 92.0 91.0 132.0 137.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:77.00 stddev:22.91 (29.8%) stddev-sans-first:21.74 09:19:57 INFO - PROCESS | 1663 | Values: 73.0 115.0 126.0 129.0 95.0 81.0 101.0 136.0 82.0 83.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:2.07 (3.7%) stddev-sans-first:2.19 09:19:57 INFO - PROCESS | 1663 | Values: 56.0 56.0 52.0 52.0 56.0 57.0 58.0 57.0 55.0 57.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:3.27 (4.7%) stddev-sans-first:3.46 09:19:57 INFO - PROCESS | 1663 | Values: 68.0 75.0 69.0 63.0 66.0 67.0 72.0 68.0 69.0 70.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.32 (1.6%) stddev-sans-first:1.32 09:19:57 INFO - PROCESS | 1663 | Values: 83.0 82.0 82.0 82.0 81.0 84.0 80.0 80.0 83.0 81.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.00 stddev:18.73 (13.4%) stddev-sans-first:19.81 09:19:57 INFO - PROCESS | 1663 | Values: 140.0 134.0 135.0 135.0 132.0 140.0 147.0 147.0 195.0 134.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:2.88 (1.8%) stddev-sans-first:3.06 09:19:57 INFO - PROCESS | 1663 | Values: 162.0 160.0 164.0 161.0 162.0 160.0 169.0 159.0 162.0 160.0 09:19:57 INFO - PROCESS | 1663 | 09:19:57 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 09:19:57 INFO - PROCESS | 1663 | Values: 65.0 66.0 67.0 65.0 64.0 65.0 65.0 64.0 65.0 63.0 09:19:57 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:19:57 INFO - PROCESS | 1663 | 09:19:58 INFO - TEST-INFO | 1663: exit 0 09:19:58 INFO - TEST-OK | kraken | took 59071ms 09:19:58 INFO - SUITE-END | took 1176s 09:19:58 INFO - Completed test suite (00:19:36) 09:19:58 INFO - javascript benchmark 09:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.1616412061103, 3504.0, 3505.4566542185953, 3531.7704349217297, 3573.249617580308, 5762.250907382039, 5828.2423284973, 5830.82507524775, 5870.501007414369, 5932.28812542495, 5773.82678519644, 5859.472647461727, 5860.091685788699, 5876.853078673024, 5894.17481552583, 4665.74025013248, 5244.659097158673, 5278.155495120782, 5291.788328466857, 5341.572674186075, 5214.087534681435, 5244.423113457536, 5244.737763111848, 5253.527182553569, 5377.247185394048, 5283.920741188866, 5316.867078323035, 5316.893662126755, 5321.015612111772, 5331.866703332428, 5312.442193569696, 5370.2750128732905, 5384.946150538483, 5386.569074474032, 5410.83767486976, 5155.072087024334, 5205.24523944026, 5259.0796610593, 5318.12250978592, 5344.91982620261, 5719.14212868069, 5736.8852622947725, 5750.223719797816, 5756.769729210827, 5821.18503409523, 6291.43377096059, 6298.716557754912, 6298.87402251957, 6344.429001389851, 6347.904781428282, 6210.347913469066, 6273.0, 6292.2134733158355, 6308.116863639094, 6311.747530098791, 5800.593958422912, 5870.530357571384, 5893.5579831512805, 5925.585209035326, 5974.820755377345, 6339.22162851905, 6352.904706429407, 6365.936340636627, 6371.713272902731, 6379.617222966544, 6103.6948152592195, 6265.248170219603, 6269.68651567429, 6273.560850740496, 6295.0, 6224.221972253468, 6241.344658810759, 6279.717412716439, 6287.0, 6289.056641503811, 6275.215598050244, 6327.936720632735, 6332.715027823759, 6338.271098823602, 6346.4605508532295, 6249.468795152463, 6292.779752708633, 6312.43188113072, 6316.4315211630255, 6331.27190373113, 4391.297392417198, 4904.288878112654, 4931.087748766489, 5002.59979201663, 5044.0920634286185, 3936.3701807710627, 4491.73049617024, 4508.684392092522, 4565.132624801277, 4581.358609794632, 6059.606125601822, 6060.727247278121, 6067.302260240041, 6068.544859135494, 6078.817635470943, 6239.906401403982, 6249.875002499924, 6258.624482531062, 6274.341194174637, 6309.968450157719, 5840.707964601753, 5916.349201587822, 5923.378045305181, 5986.551008674367, 5987.79042733511, 5482.259894914216, 5493.670379777226, 5498.780048798003, 5502.972485137549, 5504.972475137679, 6312.684365781784, 6317.5893566918, 6318.210223722035, 6325.304216536178, 6336.239651241973, 6169.753209871555, 6296.748130074929, 6299.370062993664, 6306.590071645328, 6308.211473565804, 6223.813285601439, 6274.529410294155, 6404.967975160094, 6418.550701450854, 6427.839304017437, 5733.8566535836935, 6134.865219626364, 6326.778562750282, 6336.9049464259, 6342.429181373698, 6157.9692101540995, 6222.751089956351, 6266.248050234001, 6272.560920735505, 6285.120083188449, 6219.782307619212, 6243.562950593597, 6247.5001999839, 6249.656268905072, 6276.623402595859, 6207.96896015517, 6216.844578885564, 6232.283287421823, 6239.1577137087725, 6247.250329960434, 5673.716314184357, 5950.672713000827, 6006.909896351471, 6058.666773327509, 6105.450509453993, 5361.410244873139, 5531.059719847716, 6239.563230573998, 6257.4681152102585, 6267.435930766253, 6098.75604975796, 6101.542384321105, 6102.023676211785, 6133.457080270946, 6138.508919286535], "value": 5783.9003806759365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.8292838970555, 512.5079923273657, 514.3750343332849, 525.7029778175332, 541.4828838459272, 26395.868020659895, 41802.0, 42652.786736066315, 42658.360124598075, 43008.0, 44176.558234417724, 44494.0, 44519.33221001687, 44570.108597828024, 44828.77585612075, 9052.683156089539, 9715.659951901685, 9877.407355558653, 9907.752306192368, 9917.157041651468, 9027.684031058914, 11721.062315014779, 11960.70098247542, 11962.700932476715, 12193.45129469176, 12075.215111017756, 12116.394180290994, 12127.818082728767, 12152.149349545536, 12162.391880405989, 11647.417629118552, 11653.0, 11694.94152529236, 11740.354280514568, 11764.058875289957, 11868.287902725864, 11918.880811191864, 11923.926846583849, 11942.820857687142, 11955.282683038959, 41681.79159104215, 41995.58004419947, 42046.0, 42050.78974605138, 42068.0, 3470.4794280857823, 3492.7904325740283, 3645.726570507196, 3653.3971894637352, 4290.356446533014, 31066.689333106606, 31077.0, 31280.843595782102, 31655.36689266225, 31665.683343166733, 3233.7413006959387, 3267.297531030816, 3301.950470742941, 3377.915552111217, 3408.6761757632985, 526062.0, 527739.0, 530710.0, 531504.342478289, 538016.0, 35104.47343289853, 62664.68667656633, 62937.0, 63096.36903630905, 63412.0, 35752.0, 36785.448218276746, 36835.815820920725, 36871.26257474889, 36873.44689829655, 13642.522511712043, 14993.250337483083, 15265.236738163047, 15280.465183718516, 15282.159481228417, 11171.888281117084, 11282.097432205404, 11313.547458101748, 12814.80777788334, 12974.545890893773, 7757.68969241224, 7797.0, 8041.3968952328805, 8236.752897413087, 8267.421280510307, 3288.145082278577, 3347.7489188310974, 3359.6976272135626, 3364.3944090063533, 3381.7801842880626, 941.2093841173447, 991.5092029445326, 1000.3897622450445, 1032.4682788363998, 1076.9299995500267, 28852.855735721187, 29366.0, 30261.0, 31011.379772404878, 31067.84466077655, 940.7930255343813, 981.4085285783382, 1012.731626119079, 1052.3738375666467, 1068.7755571330108, 14533.34599943005, 15481.5355539334, 15570.9221453892, 15775.605609859846, 15844.76232856508, 682239.0, 686931.0, 687978.0, 692064.0, 693419.0, 59035.40964590385, 59280.40719592749, 59440.0, 59490.0, 59540.0, 1269.752398282326, 1308.6466654003557, 1388.3821699343696, 1403.7052219033912, 1430.9141451512942, 24334.51330973406, 29958.400831983676, 31295.374092517566, 31371.843140785062, 31621.36757264888, 51180.232296514834, 51705.44883653496, 51710.48289517207, 51754.74122629363, 51828.0, 618454.0, 623579.0, 624020.0, 625985.0, 630302.0, 22075.55848882981, 24323.39191520226, 24850.751492484844, 26605.334866628487, 26942.0, 46364.53635463737, 46443.0, 46510.302345464166, 46578.06843863036, 46901.29648055213, 31563.52654710135, 35147.0, 38737.0, 38824.611753883226, 38948.6105138945, 38453.576440379795, 38649.2270154601, 38829.41755873607, 39172.6082739169, 39448.802755986035, 36468.27063458769, 37329.4400583986, 37915.241695165394, 38198.427023594115, 38549.6145038546, 32075.83962080268, 33678.66321336755, 34265.65734342724, 34404.65595344115, 34682.0, 25901.611475828253, 25918.092866749572, 25977.610335844598, 26175.476490470464, 26436.735632643427], "value": 19335.436671484425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.27887925443287, 372.6087608011588, 393.9684825213983, 396.45883369201016, 397.5667717877053, 19327.710084348746, 20468.590628187445, 20873.791262087394, 20910.163593456244, 21075.894620526877, 20242.493937651565, 20535.794642053574, 20795.376138715863, 21046.89476552619, 21143.682844757343, 5305.814296499633, 5723.942760572403, 5965.164876917235, 6116.235470566179, 6130.233720784902, 6008.218931538916, 6048.364921683204, 6055.697215139226, 6055.818325450244, 6062.060380641008, 5278.524932756051, 5857.589968702193, 6044.576879618407, 6262.749490020394, 6269.780557680482, 5951.988162012468, 6244.531660125486, 6297.0, 6297.370262973712, 6304.936950630481, 4926.3595732554895, 5822.155787410802, 5824.504917082053, 5834.27071616048, 5838.124281357788, 13391.397387117602, 13614.659633509142, 20035.298764543317, 21121.78878211229, 24912.626310605356, 2298.988505057464, 2301.8849057547222, 2355.869182792252, 2358.9410264743346, 2440.1703420836825, 10107.444090575016, 10616.097631701237, 10746.892531074667, 13180.802287965687, 15023.399064037425, 1936.7579052618423, 1954.595847108065, 1984.28565716342, 2000.1799262302532, 2027.5843452092286, 80303.59848200722, 118311.4084429581, 118593.99999999914, 119936.40031799785, 120094.19858702127, 9688.757781055388, 11567.074634029257, 11618.186726929203, 11712.531498740125, 11889.405529723479, 15000.69998600022, 15034.624134396727, 15045.548633541011, 15050.473233436776, 15057.774133388008, 8309.709160179365, 8405.621747021398, 8445.239928406472, 8457.154284571616, 8556.401051926305, 6806.863862722717, 8259.703571269865, 8259.710910118118, 8379.664813407517, 8384.287335576422, 4590.839320623762, 4595.448546174481, 4599.402077729874, 4601.700889442175, 4696.60078893291, 1668.883178177516, 1910.6083252933115, 1955.8435325173953, 1963.0957970768332, 1965.1058768260407, 857.4598003258033, 966.2415004221652, 997.5012493753123, 1017.9536343036372, 1024.1192574386023, 21127.788722112582, 21474.355769326947, 21535.89232053861, 21556.137754489646, 21584.784152158278, 881.8060026794095, 952.2619969523674, 987.160913223754, 995.3579940938055, 1056.0073530880948, 10384.948075259575, 10813.141500597305, 10814.456579302263, 10820.134389248999, 10830.31774160723, 602024.0, 612671.0, 621677.0, 623540.0, 631089.0, 127945.36027319804, 129666.0, 133743.0, 137094.0, 137255.0, 988.6984469736656, 990.5641517732175, 996.9551370188359, 1011.4032720694826, 1013.2653825976108, 18002.909985449987, 18683.90658046701, 18836.811631883505, 18938.52653683614, 18978.335758248395, 51983.48016519786, 53930.0, 54094.729526352115, 55104.62238444071, 55154.0, 72015.0, 76458.61770691111, 80174.0, 81315.0, 83152.0, 5498.642588231752, 7361.558306501627, 7998.760037198894, 8182.836343272982, 8261.38039647041, 10694.946525267324, 12498.0, 12564.0, 12627.368631568568, 12693.873061269269, 10803.891961080602, 10820.458977051274, 10994.890051099386, 11318.0, 11358.09135269193, 9451.243900488082, 9527.857082143912, 10720.142388608736, 10873.619423320146, 10914.781704366027, 11295.830562541732, 11336.206465547333, 11457.140714446616, 11555.653330399766, 11717.765644686888, 7932.6033698313695, 7950.801229969297, 8156.592170391338, 8181.954511372157, 8258.504489730636, 8129.065157506962, 10637.0, 10838.620648277272, 11081.722956926142, 11244.437778111225], "value": 9559.860140424169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.8489866114733, 1382.4124746982532, 1504.6840163565655, 1517.975366627527, 1844.2715127524627, 7586.810329741759, 7976.162502937188, 8314.127016663255, 8502.744917652464, 8518.488890666564, 8409.159084091587, 8477.78805529862, 8514.148585141484, 8518.616662250199, 8523.360747943898, 2386.260259319612, 2420.455397535558, 2424.3939015246187, 2427.7208121066037, 2427.817913656474, 2395.7484464131276, 2434.8295619306655, 2448.8897999590063, 2455.5702752018415, 2462.8029757619347, 2393.210240620591, 2404.6393041043807, 2424.6847909771705, 2426.8301218914594, 2429.5626787178303, 2314.2825724025606, 2351.0595761695286, 2379.916702915407, 2384.6423036544397, 2400.9159679411136, 2341.040173528845, 2370.561446132471, 2399.208261273793, 2407.2417188585714, 2410.6625072489865, 8412.11672774356, 8429.95785021077, 8503.659853605848, 8504.27713644341, 8518.616662250213, 5080.263361812516, 5255.211718242294, 5256.159014557652, 5271.42014378418, 5272.446393128743, 3457.3431048101033, 3555.5377800885976, 3586.8027258500774, 3612.8735494257576, 3617.493550902849, 1112.06586467367, 1114.9832752508719, 1127.971800704989, 1131.4512461456188, 1137.2891942535914, 11005.944970275177, 11033.393163376011, 11073.446327683583, 11118.666440006893, 11119.444027798658, 3882.6699730522655, 4383.3424986251675, 4485.932711009337, 4550.97724511382, 4570.200214962435, 8794.120587941155, 8813.383063185516, 8824.470531768115, 8831.867521987175, 8861.512616806009, 5099.949000509948, 5195.350581177353, 5197.0, 5201.895962080737, 5203.0, 4183.979080104641, 4441.866743997685, 4460.464744230648, 4512.810366999729, 4915.139850526144, 3213.0, 3736.645018723217, 3852.6725228355904, 3854.8843534694006, 3861.517310336208, 1159.431878379588, 1169.5497233564968, 1170.6136974798296, 1178.5639313454076, 1182.4737991593659, 778.6457161991281, 865.35098675993, 899.5682072605056, 923.6720964057797, 926.1016813690709, 4969.652124351261, 5711.143328500758, 5840.182374467578, 5992.280926288786, 6103.786367477117, 747.8242612985944, 951.8286708392417, 956.3926906414338, 973.2966064126068, 995.955182016811, 3560.661737134968, 3735.215604722984, 3815.4276858471453, 3857.7106716995777, 3914.119323152268, 10051.447170405552, 10298.845517317246, 10319.380837149794, 10340.741481462874, 10412.739681507872, 9716.514174291398, 10197.94901025505, 10201.897981020244, 10280.228982826318, 10282.742931426625, 7917.683292668229, 8105.837883242302, 8121.350291976628, 8154.469959452616, 8160.143184965612, 5694.1458781183155, 5705.7432415542235, 5735.655860648374, 5813.215215945793, 6062.42406971337, 9488.003759605142, 9591.568379423083, 9594.616215351307, 9595.760105997406, 9608.039196080335, 9011.864822027545, 9315.953420232856, 9690.51547422612, 9712.951435242778, 9821.017898210122, 7138.393236574741, 7269.527480713737, 7276.345128938421, 7308.926910730825, 7404.370628496638, 8098.51408915467, 8114.350851931949, 8180.345572354078, 8188.344932405513, 8188.50868947865, 7204.423646108404, 7324.414046876131, 7364.889526657212, 7389.963050184715, 7463.2163622818825, 6784.2876497967, 7027.61348125858, 7142.714291428285, 7181.210066892742, 7191.0, 6742.292059333699, 6812.420944219797, 6917.619530925646, 6917.861642767217, 6925.515213934977, 4962.280469331999, 4965.106280869478, 4996.2505624156665, 5015.122353588181, 5022.598192144693, 4920.458749537476, 4923.236898280772, 4961.330220420197, 5073.0, 5075.492450754895], "value": 4476.192918948759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.90700336397396, 309.1529209964696, 314.4748270388451, 319.9744020478362, 323.89797213877614, 5094.930064686416, 5125.641704948182, 5146.558963490224, 5149.356330458692, 5159.638825282227, 4251.511076226235, 4510.639148868091, 4910.803567857281, 4986.576141028008, 5032.948476476435, 3344.799312041273, 3873.571888878335, 3925.685945124383, 3965.8017099145072, 3982.8406863725418, 3357.4292370297107, 3498.7900725956524, 3614.0484138565143, 3981.362981922893, 3989.780562069085, 3098.032749204249, 3808.7143464240153, 3907.745996510232, 3908.2183563287313, 3937.448757173998, 3528.3648943190215, 3890.961090389088, 3903.0, 3923.2153569286115, 3944.7633142011427, 2685.476332115238, 2976.3600825822336, 3302.5211344355175, 3355.39602871483, 3371.0392538126516, 4377.233984052778, 4810.567048965575, 4977.328060711794, 5061.645684802065, 5087.898242035176, 4086.9591304086875, 4229.513605935326, 4508.368828364031, 4520.570545798144, 4539.4779600346055, 4497.842575509874, 4806.894414284699, 5432.0, 5485.286912701324, 5498.5876059295715, 3781.4327850822324, 3781.6029316921604, 3782.9432558511644, 3792.848286068554, 3801.068738159141, 4190.580941905816, 5362.624616276862, 5642.830715078513, 5719.399463056361, 5770.163326317703, 3157.500187410961, 3754.530683664542, 3760.4206233382047, 3766.1902690921584, 3791.0, 3822.808859557011, 3822.9426558601645, 3824.388097904322, 3845.577136459528, 3846.807659617008, 3650.653187947141, 4438.533953934855, 4470.284754439274, 4484.192845287879, 4495.57292057254, 4356.978215108904, 4511.458624965026, 5141.665791723526, 5432.91850622241, 5492.752826122834, 1159.9014083802972, 1239.4630657984214, 1252.7807633664072, 1257.7107265329025, 1264.8608653048157, 765.1010063175746, 800.9038915330198, 819.5943008210974, 904.7785489589133, 918.0910898210723, 4048.9392659110135, 4563.106310880948, 4739.668223224341, 4856.329019039585, 4890.535399137077, 4360.010590309831, 4737.549932756451, 4796.640251981115, 4993.629300222336, 5183.352080989876, 3858.3826587745825, 4161.521425036099, 4180.895477613084, 4439.135563063521, 5003.649744517848, 2374.5607062693457, 2512.9748702512743, 2782.095818858879, 2811.5642075478336, 2840.67332256789, 5131.5638170755155, 5554.139872788454, 5559.944400555943, 5647.745851436695, 5693.0, 5181.81863634771, 5371.221172929903, 5393.406725260218, 5408.7566059526625, 5437.864053398696, 4875.926861097158, 5244.895102097937, 5469.0, 5472.6741135017455, 5496.945030549643, 4452.1763473757455, 4479.395281636937, 5077.0399088710865, 5184.274201611853, 5360.62475626718, 4359.583135481044, 4813.95186048135, 4979.253112033224, 5151.742412879266, 5154.381474223117, 5566.832995010156, 5641.943580564306, 5652.519535839499, 5658.575606829422, 5670.574706896917, 3583.8208089594896, 3594.2631760488516, 3602.873899413508, 3620.31214069326, 3668.321360548307, 5258.527612268571, 5320.388155362183, 5592.245046918614, 5607.981126794432, 5688.744006519633, 5255.553277971415, 5423.538999185113, 5424.484673955968, 5435.483629055233, 5468.867141814616, 4409.3606427068535, 4609.539046095364, 4735.952640473689, 5339.279197308314, 5529.170624406372, 4766.428028636586, 5100.770465329143, 5152.201408781645, 5335.546478549367, 5446.373667028342, 4736.57902629203, 5233.842984710464, 5352.732363381893, 5416.647917885325, 5484.862878428071, 4616.561426664462, 5281.735913204401, 5297.337832770903, 5323.361196656426, 5337.626366154487], "value": 3863.5683456994484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2609123465975, 744.3821628048719, 764.094547960667, 765.9272369124934, 837.7151768398743, 14632.414703411863, 15673.373065077383, 15701.136437495934, 15703.92148039261, 15726.449574264903, 13875.098118622282, 14059.437622495114, 14061.437542498288, 14089.225092619901, 14105.294735263222, 721.8051126195924, 745.9891846547931, 881.8721285413611, 908.1554154636186, 910.0217266438572, 901.9503927283997, 906.9093090690911, 910.6630546697731, 916.7891384981458, 918.1323649151554, 972.863799068131, 978.6476868327396, 979.686500319898, 982.2878413150445, 987.1757082835841, 969.8011907558933, 970.752458123174, 971.3103696375582, 971.961121555137, 973.265184785486, 732.6190381001902, 732.9157146928064, 733.3216774483635, 733.4572416411817, 736.1975446763054, 14569.70860582793, 14577.562673119823, 14589.635259118608, 14609.48866789668, 15050.247487625575, 14013.789793153112, 14100.224487653175, 14443.566692999122, 14478.92760536201, 14486.927565362106, 11781.528738850435, 11797.29216247028, 12196.695082622917, 12795.360231988363, 12933.288669123194, 3920.7843568603716, 3989.6409323161056, 4003.719739618228, 4048.291548978917, 4064.410660454247, 96862.0, 98651.0, 99575.50636740455, 100175.0, 100453.49319760136, 11027.44862756859, 11060.834087488694, 11319.151063670257, 11464.197506174487, 11720.296782193096, 22316.214702823734, 22391.888040559694, 22637.0, 22702.205422810122, 23028.884855575616, 8059.758207253792, 8080.4343695940715, 8110.148434414419, 8180.713675021346, 8236.876446853303, 4460.799264033127, 4506.188886000486, 4564.703294285927, 4674.392328997209, 4717.033008233304, 3559.519464872261, 3672.467492213614, 3703.2408356286896, 3716.7955762433326, 3900.9219815604097, 738.3613174603929, 739.6264886232526, 753.6985205917567, 754.4304050441881, 762.92752188542, 656.2682608891052, 659.1957811469999, 666.9899951500731, 683.3815397065664, 687.6492988575762, 9323.860142097874, 9858.556364963593, 9862.901370986197, 9914.652987145415, 9990.900090999143, 615.2186722861941, 665.0197628458498, 682.1064405628543, 684.226823689228, 695.2421860172436, 4594.563516465931, 4759.976200118977, 4771.5467030632035, 4775.235962246094, 4786.593139583105, 81118.59440702877, 81727.18272817196, 98222.5088874551, 125177.0, 128367.0, 80531.59734201408, 101622.47566286512, 108108.91891081145, 109068.0, 111460.44269778761, 98171.0, 98598.5070074645, 99001.50499247458, 99519.0, 101511.0, 8851.424657397249, 9217.124373184537, 9393.497040473492, 9860.408375497493, 10090.394576325443, 49894.0, 50034.49965500298, 50847.74576127244, 51868.740656296475, 52657.73671131773, 73579.63210183915, 75244.62377688076, 76310.0, 76914.846277307, 78611.0, 12755.234685918875, 13028.61597817044, 13212.339383030618, 13302.600921972356, 13452.192868427926, 14702.338394772047, 14745.0, 14810.481633142788, 14906.627334316296, 14972.176530290939, 13382.0, 13650.93174534121, 13988.020838541204, 14361.994660373673, 14647.26763661834, 11549.6535103947, 14072.085314454527, 14460.927695361455, 14659.0, 14664.853351466349, 13372.531961381304, 13423.127496712683, 13586.184828910296, 13786.379612917643, 13820.23988680592, 11229.887701122883, 11476.885231147582, 11490.482928268415, 11978.940105299418, 12027.037836972846, 10915.617953371593, 11457.0, 11481.827772583585, 11655.708607284885, 11662.241954272946], "value": 7804.253156050721, "unit": "score"}], "name": "dromaeo_css", "value": 7242.423006236346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 117.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 106.0, 141.0, 108.0, 106.0, 108.0, 107.0, 134.0, 106.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 183.0, 182.0, 182.0, 182.0, 183.0, 197.0, 259.0, 204.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 91.0, 60.0, 57.0, 58.0, 57.0, 99.0, 80.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 92.0, 70.0, 68.0, 68.0, 89.0, 96.0, 84.0, 89.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 129.0, 74.0, 129.0, 134.0, 110.0, 89.0, 85.0, 89.0, 84.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 92.0, 93.0, 101.0, 92.0, 91.0, 132.0, 137.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 115.0, 126.0, 129.0, 95.0, 81.0, 101.0, 136.0, 82.0, 83.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 52.0, 52.0, 56.0, 57.0, 58.0, 57.0, 55.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 69.0, 63.0, 66.0, 67.0, 72.0, 68.0, 69.0, 70.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 81.0, 84.0, 80.0, 80.0, 83.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 135.0, 135.0, 132.0, 140.0, 147.0, 147.0, 195.0, 134.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 164.0, 161.0, 162.0, 160.0, 169.0, 159.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 63.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1459.3000000000004, "alertThreshold": 2.0}]} 09:19:59 INFO - Return code: 0 09:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:19:59 INFO - # TBPL SUCCESS # 09:19:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:59 INFO - 2017-01-30 09:19:59.135 screenresolution[1667:10149] starting screenresolution argv=screenresolution get 09:19:59 INFO - 2017-01-30 09:19:59.139 screenresolution[1667:10149] Display 0: 1600x1200x32@60 09:19:59 INFO - 2017-01-30 09:19:59.145 screenresolution[1668:10152] starting screenresolution argv=screenresolution list 09:19:59 INFO - Available Modes on Display 0 09:19:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:59 INFO - Intel Iris: 09:19:59 INFO - Chipset Model: Intel Iris 09:19:59 INFO - Type: GPU 09:19:59 INFO - Bus: Built-In 09:19:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:59 INFO - Vendor: Intel (0x8086) 09:19:59 INFO - Device ID: 0x0a2e 09:19:59 INFO - Revision ID: 0x0009 09:19:59 INFO - Displays: 09:19:59 INFO - Display: 09:19:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:59 INFO - Display Serial Number: 1600x1200 60 09:19:59 INFO - Main Display: Yes 09:19:59 INFO - Mirror: Off 09:19:59 INFO - Online: Yes 09:19:59 INFO - Rotation: Supported 09:19:59 INFO - Return code: 0 09:19:59 INFO - Running post-action listener: _resource_record_post_action 09:19:59 INFO - [mozharness: 2017-01-30 17:19:59.392628Z] Finished run-tests step (success) 09:19:59 INFO - Running post-run listener: _resource_record_post_run 09:19:59 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37880832; Write bytes: 502213120; Read time: 244; Write time: 1620 09:19:59 INFO - TinderboxPrint: CPU usage
53.7% 09:19:59 INFO - TinderboxPrint: I/O read bytes / time
37,880,832 / 244 09:19:59 INFO - TinderboxPrint: I/O write bytes / time
502,213,120 / 1,620 09:19:59 INFO - TinderboxPrint: CPU idle
2,219.7 (46.3%) 09:19:59 INFO - TinderboxPrint: CPU system
962.7 (20.1%) 09:19:59 INFO - TinderboxPrint: CPU user
1,611.2 (33.6%) 09:19:59 INFO - TinderboxPrint: Swap in / out
228,761,600 / 0 09:19:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187030016; Write bytes: 186245120; Read time: 16677; Write time: 415 09:19:59 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35906560; Write bytes: 307438080; Read time: 227; Write time: 1169 09:19:59 INFO - Running post-run listener: _upload_blobber_files 09:19:59 INFO - Blob upload gear active. 09:19:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:59 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 09:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:01 INFO - (blobuploader) - INFO - Done attempting. 09:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:02 INFO - (blobuploader) - INFO - Done attempting. 09:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:04 INFO - (blobuploader) - INFO - Done attempting. 09:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:04 INFO - Return code: 0 09:20:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bde1d903a3b1fd648457e086a6f888c73bd5680e5047e9132f0f32c5939703bf007b3373f7610d35c58a7860519c56e74489d830ca07d7ef902997718cde1d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec30f8403ee89103c887510e7fa02ae35485af70614219f294acf3fe39f43e6f6f666c4e7454a8f02bc9db292e043e6512f483ed47c096b845848e6f32e7e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc2c3154abe00728b029569ba0dca1316c0d8e5facdfe46a747f543c4838c783247cd6b778e43ef57eaf62e7a069e0daee94388372012fd1645b62d53205818"} 09:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:04 INFO - Contents: 09:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bde1d903a3b1fd648457e086a6f888c73bd5680e5047e9132f0f32c5939703bf007b3373f7610d35c58a7860519c56e74489d830ca07d7ef902997718cde1d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec30f8403ee89103c887510e7fa02ae35485af70614219f294acf3fe39f43e6f6f666c4e7454a8f02bc9db292e043e6512f483ed47c096b845848e6f32e7e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc2c3154abe00728b029569ba0dca1316c0d8e5facdfe46a747f543c4838c783247cd6b778e43ef57eaf62e7a069e0daee94388372012fd1645b62d53205818"} 09:20:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:04 INFO - Copying logs to upload dir... 09:20:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.354822 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 09:20:04.799035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 09:20:04.802461) ========= 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.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bde1d903a3b1fd648457e086a6f888c73bd5680e5047e9132f0f32c5939703bf007b3373f7610d35c58a7860519c56e74489d830ca07d7ef902997718cde1d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec30f8403ee89103c887510e7fa02ae35485af70614219f294acf3fe39f43e6f6f666c4e7454a8f02bc9db292e043e6512f483ed47c096b845848e6f32e7e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc2c3154abe00728b029569ba0dca1316c0d8e5facdfe46a747f543c4838c783247cd6b778e43ef57eaf62e7a069e0daee94388372012fd1645b62d53205818"} build_url:https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/BCg6FOGTTGapLnC0mGjJDg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bde1d903a3b1fd648457e086a6f888c73bd5680e5047e9132f0f32c5939703bf007b3373f7610d35c58a7860519c56e74489d830ca07d7ef902997718cde1d40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec30f8403ee89103c887510e7fa02ae35485af70614219f294acf3fe39f43e6f6f666c4e7454a8f02bc9db292e043e6512f483ed47c096b845848e6f32e7e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc2c3154abe00728b029569ba0dca1316c0d8e5facdfe46a747f543c4838c783247cd6b778e43ef57eaf62e7a069e0daee94388372012fd1645b62d53205818"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 09:20:04.837146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:20:04.837643) ========= 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.uaOInx9uN4/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.p4zFYo0wkT/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.004966 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:20:04.888327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 09:20:04.888852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 09:20:04.889410) ========= ========= Total master_lag: 0.18 =========