builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1476534473.19 results: success (0) buildid: 20161015030203 builduid: 73f2fc38174b49f3b6d06b7a75767d49 revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.194318) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.195146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.195826) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.278923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.279212) ========= 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.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-15 05:27:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.6M=0s 2016-10-15 05:27:53 (26.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.452006 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.788022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.788351) ========= 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.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.025755 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.838733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:53.839187) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a1297e90c5981dea1449019480328aafff0cbd5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2a1297e90c5981dea1449019480328aafff0cbd5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-15 05:27:53,916 truncating revision to first 12 chars 2016-10-15 05:27:53,916 Setting DEBUG logging. 2016-10-15 05:27:53,916 attempt 1/10 2016-10-15 05:27:53,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a1297e90c59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 05:27:54,579 unpacking tar archive at: mozilla-central-2a1297e90c59/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:54.782251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:54.782570) ========= script_repo_revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:54.782965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:54.783227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 05:27:54.801052) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-15 05:27:54.801351) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:27:55 INFO - MultiFileLogger online at 20161015 05:27:54 in /builds/slave/test 05:27:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:27:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:55 INFO - {'append_to_log': False, 05:27:55 INFO - 'base_work_dir': '/builds/slave/test', 05:27:55 INFO - 'blob_upload_branch': 'Firefox', 05:27:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:55 INFO - 'branch': 'Firefox', 05:27:55 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:55 INFO - 'config_files': ('talos/mac_config.py',), 05:27:55 INFO - 'default_actions': ('clobber', 05:27:55 INFO - 'read-buildbot-config', 05:27:55 INFO - 'download-and-extract', 05:27:55 INFO - 'populate-webroot', 05:27:55 INFO - 'create-virtualenv', 05:27:55 INFO - 'install', 05:27:55 INFO - 'run-tests'), 05:27:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:55 INFO - 'download_minidump_stackwalk': True, 05:27:55 INFO - 'download_symbols': 'ondemand', 05:27:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:55 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:55 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:55 INFO - 'installer_path': 'installer.exe', 05:27:55 INFO - 'log_level': 'info', 05:27:55 INFO - 'log_name': 'talos', 05:27:55 INFO - 'log_to_console': True, 05:27:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:27:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:27:55 INFO - 'opt_config_files': (), 05:27:55 INFO - 'pip_index': False, 05:27:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:55 INFO - 'cmd': ('bash', 05:27:55 INFO - '-c', 05:27:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:55 INFO - 'enabled': True, 05:27:55 INFO - 'halt_on_failure': False, 05:27:55 INFO - 'name': 'check_screen_resolution'},), 05:27:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:55 INFO - 'cmd': ('bash', 05:27:55 INFO - '-c', 05:27:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:55 INFO - 'enabled': True, 05:27:55 INFO - 'halt_on_failure': False, 05:27:55 INFO - 'name': 'check_screen_resolution'},), 05:27:55 INFO - 'run_cmd_checks_enabled': True, 05:27:55 INFO - 'sps_profile': False, 05:27:55 INFO - 'sps_profile_interval': 0, 05:27:55 INFO - 'suite': 'dromaeojs', 05:27:55 INFO - 'system_bits': '32', 05:27:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:55 INFO - 'title': 't-yosemite-r7-0088', 05:27:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:55 INFO - 'use_talos_json': True, 05:27:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:55 INFO - 'work_dir': 'build'} 05:27:55 INFO - [mozharness: 2016-10-15 12:27:55.010956Z] Running clobber step. 05:27:55 INFO - Running pre-action listener: _resource_record_pre_action 05:27:55 INFO - Running main action method: clobber 05:27:55 INFO - rmtree: /builds/slave/test/build 05:27:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:57 INFO - Running post-action listener: _resource_record_post_action 05:27:57 INFO - [mozharness: 2016-10-15 12:27:57.173372Z] Finished clobber step (success) 05:27:57 INFO - [mozharness: 2016-10-15 12:27:57.173576Z] Running read-buildbot-config step. 05:27:57 INFO - Running pre-action listener: _resource_record_pre_action 05:27:57 INFO - Running main action method: read_buildbot_config 05:27:57 INFO - Using buildbot properties: 05:27:57 INFO - { 05:27:57 INFO - "project": "", 05:27:57 INFO - "product": "firefox", 05:27:57 INFO - "script_repo_revision": "production", 05:27:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:27:57 INFO - "repository": "", 05:27:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:27:57 INFO - "buildid": "20161015030203", 05:27:57 INFO - "stage_platform": "macosx64", 05:27:57 INFO - "basedir": "/builds/slave/test", 05:27:57 INFO - "nightly_build": "True", 05:27:57 INFO - "buildnumber": 6, 05:27:57 INFO - "slavename": "t-yosemite-r7-0088", 05:27:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:27:57 INFO - "platform": "yosemite_r7", 05:27:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:27:57 INFO - "branch": "mozilla-central", 05:27:57 INFO - "repo_path": "mozilla-central", 05:27:57 INFO - "revision": "2a1297e90c5981dea1449019480328aafff0cbd5", 05:27:57 INFO - "pgo_build": "False", 05:27:57 INFO - "builduid": "73f2fc38174b49f3b6d06b7a75767d49", 05:27:57 INFO - "slavebuilddir": "test" 05:27:57 INFO - } 05:27:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:27:57 INFO - Running post-action listener: _resource_record_post_action 05:27:57 INFO - [mozharness: 2016-10-15 12:27:57.177837Z] Finished read-buildbot-config step (success) 05:27:57 INFO - [mozharness: 2016-10-15 12:27:57.177984Z] Running download-and-extract step. 05:27:57 INFO - Running pre-action listener: _resource_record_pre_action 05:27:57 INFO - Running main action method: download_and_extract 05:27:57 INFO - mkdir: /builds/slave/test/build/tests 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 INFO - trying https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:27:57 INFO - Downloading https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:27:57 INFO - Downloaded 1199 bytes. 05:27:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:27:57 INFO - Using the following test package requirements: 05:27:57 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:27:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:27:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:27:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'jsshell-mac.zip'], 05:27:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:27:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:27:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:27:57 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:27:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:27:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:27:57 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:27:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:27:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:27:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:27:57 INFO - Fetch https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:27:58 INFO - Http code: 200 05:27:58 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 05:27:58 INFO - x-amz-cf-id: Y9tsAtTw6AIKRPg7g2YAa6izcead6cG3IG2h6a-Yqd65kX5hBjXh1Q== 05:27:58 INFO - x-amz-version-id: Oh8uBV7tXFZnAgcE7okpi4MQY.cjU2vz 05:27:58 INFO - Expected file size: 16516904 05:27:58 INFO - Obtained file size: 16516904 05:28:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:28:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:28:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:28:05 INFO - Fetch https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:28:06 INFO - Http code: 200 05:28:06 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 05:28:06 INFO - x-amz-cf-id: xXE0rFpcAwna_swIcU7YnBi3Z0kUKDtYVKCy4N4bSOISE2pubrwjfA== 05:28:06 INFO - x-amz-version-id: Oh8uBV7tXFZnAgcE7okpi4MQY.cjU2vz 05:28:06 INFO - Expected file size: 16516904 05:28:06 INFO - Obtained file size: 16516904 05:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:28:13 INFO - Http code: 200 05:28:13 INFO - via: 1.1 dc553909528b8b63475c922dc07d8ba6.cloudfront.net (CloudFront) 05:28:13 INFO - x-amz-cf-id: OJVwMRDX26tS08VIEXw3-MfQA09ym5EIjEeGkNAkaS-k0WnzYst0pA== 05:28:13 INFO - x-amz-version-id: w67bjbA_8Wy2WqcGaS62o99goB5tU35Z 05:28:13 INFO - Expected file size: 14409028 05:28:13 INFO - Obtained file size: 14409028 05:28:13 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')]} 05:28:13 INFO - trying https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:28:17 INFO - Downloaded 112125483 bytes. 05:28:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:28:17 INFO - mkdir: /builds/slave/test/properties 05:28:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:17 INFO - Contents: 05:28:17 INFO - build_url:https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:28:17 INFO - Running post-action listener: _resource_record_post_action 05:28:17 INFO - Running post-action listener: set_extra_try_arguments 05:28:17 INFO - [mozharness: 2016-10-15 12:28:17.984543Z] Finished download-and-extract step (success) 05:28:17 INFO - [mozharness: 2016-10-15 12:28:17.984675Z] Running populate-webroot step. 05:28:17 INFO - Running pre-action listener: _resource_record_pre_action 05:28:17 INFO - Running main action method: populate_webroot 05:28:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:17 INFO - '--tppagecycles', 05:28:17 INFO - '7'], 05:28:17 INFO - 'tests': ['tsvgm']}}, 05:28:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:17 INFO - 'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:17 INFO - 'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['damp', 'tps']}, 05:28:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:17 INFO - 'tests': ['damp', 'tps']}, 05:28:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['dromaeo_dom']}, 05:28:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['basic_compositor_video']}, 05:28:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:28:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['a11yr', 05:28:17 INFO - 'ts_paint', 05:28:17 INFO - 'tpaint', 05:28:17 INFO - 'sessionrestore', 05:28:17 INFO - 'sessionrestore_no_auto_restore', 05:28:17 INFO - 'tabpaint']}, 05:28:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:17 INFO - 'ts_paint', 05:28:17 INFO - 'tpaint', 05:28:17 INFO - 'sessionrestore', 05:28:17 INFO - 'sessionrestore_no_auto_restore', 05:28:17 INFO - 'tabpaint']}, 05:28:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:17 INFO - 'ts_paint', 05:28:17 INFO - 'tpaint', 05:28:17 INFO - 'sessionrestore', 05:28:17 INFO - 'sessionrestore_no_auto_restore', 05:28:17 INFO - 'tabpaint']}, 05:28:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:17 INFO - 'ts_paint', 05:28:17 INFO - 'tpaint', 05:28:17 INFO - 'sessionrestore', 05:28:17 INFO - 'sessionrestore_no_auto_restore', 05:28:17 INFO - 'tabpaint']}, 05:28:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:17 INFO - 'tests': ['a11yr', 05:28:17 INFO - 'ts_paint', 05:28:17 INFO - 'tpaint', 05:28:17 INFO - 'sessionrestore', 05:28:18 INFO - 'sessionrestore_no_auto_restore', 05:28:18 INFO - 'tabpaint']}, 05:28:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:18 INFO - 'tests': ['a11yr', 05:28:18 INFO - 'ts_paint', 05:28:18 INFO - 'tpaint', 05:28:18 INFO - 'sessionrestore', 05:28:18 INFO - 'sessionrestore_no_auto_restore', 05:28:18 INFO - 'tabpaint']}, 05:28:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:18 INFO - 'tests': ['tsvgx', 05:28:18 INFO - 'tsvgr_opacity', 05:28:18 INFO - 'tart', 05:28:18 INFO - 'tscrollx', 05:28:18 INFO - 'cart']}, 05:28:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:18 INFO - 'tsvgr_opacity', 05:28:18 INFO - 'tart', 05:28:18 INFO - 'tscrollx', 05:28:18 INFO - 'cart']}, 05:28:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:18 INFO - 'talos_options': ['--disable-e10s'], 05:28:18 INFO - 'tests': ['tp5o']}, 05:28:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:18 INFO - 'tests': ['tp5o']}, 05:28:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:18 INFO - 'talos_options': ['--disable-e10s', 05:28:18 INFO - '--xperf_path', 05:28:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:18 INFO - 'tests': ['tp5n']}, 05:28:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:18 INFO - 'talos_options': ['--xperf_path', 05:28:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:18 INFO - 'tests': ['tp5n']}}, 05:28:18 INFO - 'talos.zip': {'path': '', 05:28:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:18 INFO - Running post-action listener: _resource_record_post_action 05:28:18 INFO - [mozharness: 2016-10-15 12:28:18.004073Z] Finished populate-webroot step (success) 05:28:18 INFO - [mozharness: 2016-10-15 12:28:18.004203Z] Running create-virtualenv step. 05:28:18 INFO - Running pre-action listener: _resource_record_pre_action 05:28:18 INFO - Running main action method: create_virtualenv 05:28:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:18 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 05:28:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:18 INFO - Using real prefix '/tools/python27' 05:28:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:21 INFO - Installing pip.................done. 05:28:21 INFO - Return code: 0 05:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:28:21 INFO - Reading from file tmpfile_stdout 05:28:21 INFO - Output received: 05:28:21 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) 05:28:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:21 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:21 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 05:28:21 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 05:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:21 INFO - 'HOME': '/Users/cltbld', 05:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:21 INFO - 'LOGNAME': 'cltbld', 05:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:21 INFO - 'MOZ_NO_REMOTE': '1', 05:28:21 INFO - 'NO_EM_RESTART': '1', 05:28:21 INFO - 'PAGER': '/bin/cat', 05:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:21 INFO - 'PWD': '/builds/slave/test', 05:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:21 INFO - 'SHELL': '/bin/bash', 05:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:21 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:21 INFO - 'USER': 'cltbld', 05:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:21 INFO - 'XPC_FLAGS': '0x0', 05:28:21 INFO - 'XPC_SERVICE_NAME': '0', 05:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:22 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 05:28:22 INFO - Cleaning up... 05:28:22 INFO - Return code: 0 05:28:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:22 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:22 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 05:28:22 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 05:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:22 INFO - 'HOME': '/Users/cltbld', 05:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:22 INFO - 'LOGNAME': 'cltbld', 05:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:22 INFO - 'MOZ_NO_REMOTE': '1', 05:28:22 INFO - 'NO_EM_RESTART': '1', 05:28:22 INFO - 'PAGER': '/bin/cat', 05:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:22 INFO - 'PWD': '/builds/slave/test', 05:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:22 INFO - 'SHELL': '/bin/bash', 05:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:22 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:22 INFO - 'USER': 'cltbld', 05:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:22 INFO - 'XPC_FLAGS': '0x0', 05:28:22 INFO - 'XPC_SERVICE_NAME': '0', 05:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:22 INFO - Downloading/unpacking psutil>=3.1.1 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:26 INFO - Installing collected packages: psutil 05:28:26 INFO - Running setup.py install for psutil 05:28:26 INFO - building 'psutil._psutil_osx' extension 05:28:26 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 05:28:26 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 05:28:26 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 05:28:27 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 05:28:27 INFO - building 'psutil._psutil_posix' extension 05:28:27 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 05:28:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:28:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:28:27 INFO - ^ 05:28:27 INFO - 1 warning generated. 05:28:27 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 05:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:27 INFO - Successfully installed psutil 05:28:27 INFO - Cleaning up... 05:28:27 INFO - Return code: 0 05:28:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:27 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')]} 05:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:27 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')]} 05:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:27 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:27 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 05:28:27 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 05:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:27 INFO - 'HOME': '/Users/cltbld', 05:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:27 INFO - 'LOGNAME': 'cltbld', 05:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:27 INFO - 'MOZ_NO_REMOTE': '1', 05:28:27 INFO - 'NO_EM_RESTART': '1', 05:28:27 INFO - 'PAGER': '/bin/cat', 05:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:27 INFO - 'PWD': '/builds/slave/test', 05:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:27 INFO - 'SHELL': '/bin/bash', 05:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:27 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:27 INFO - 'USER': 'cltbld', 05:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:27 INFO - 'XPC_FLAGS': '0x0', 05:28:27 INFO - 'XPC_SERVICE_NAME': '0', 05:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28:27 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 05:28:27 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 05:28:27 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 05:28:27 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 05:28:27 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 05:28:27 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 05:28:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:30 INFO - Installing collected packages: mozsystemmonitor 05:28:30 INFO - Running setup.py install for mozsystemmonitor 05:28:30 INFO - Successfully installed mozsystemmonitor 05:28:30 INFO - Cleaning up... 05:28:30 INFO - Return code: 0 05:28:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28:30 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')]} 05:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:30 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')]} 05:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:30 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:30 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 05:28:30 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 05:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:30 INFO - 'HOME': '/Users/cltbld', 05:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:30 INFO - 'LOGNAME': 'cltbld', 05:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:30 INFO - 'MOZ_NO_REMOTE': '1', 05:28:30 INFO - 'NO_EM_RESTART': '1', 05:28:30 INFO - 'PAGER': '/bin/cat', 05:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:30 INFO - 'PWD': '/builds/slave/test', 05:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:30 INFO - 'SHELL': '/bin/bash', 05:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:30 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:30 INFO - 'USER': 'cltbld', 05:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:30 INFO - 'XPC_FLAGS': '0x0', 05:28:30 INFO - 'XPC_SERVICE_NAME': '0', 05:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:30 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:30 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 05:28:30 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 05:28:30 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 05:28:30 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 05:28:30 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 05:28:30 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 05:28:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:33 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 05:28:33 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 05:28:33 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 05:28:33 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 05:28:33 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 05:28:33 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 05:28:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:33 INFO - warning: no files found matching '*.txt' 05:28:33 INFO - no previously-included directories found matching 'build' 05:28:33 INFO - no previously-included directories found matching 'dist' 05:28:33 INFO - no previously-included directories found matching '.git*' 05:28:33 INFO - Installing collected packages: jsonschema, functools32 05:28:33 INFO - Running setup.py install for functools32 05:28:33 INFO - warning: no files found matching '*.txt' 05:28:33 INFO - no previously-included directories found matching 'build' 05:28:33 INFO - no previously-included directories found matching 'dist' 05:28:33 INFO - no previously-included directories found matching '.git*' 05:28:34 INFO - Successfully installed jsonschema functools32 05:28:34 INFO - Cleaning up... 05:28:34 INFO - Return code: 0 05:28:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:34 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 05:28:34 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 05:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:34 INFO - 'HOME': '/Users/cltbld', 05:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:34 INFO - 'LOGNAME': 'cltbld', 05:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:34 INFO - 'MOZ_NO_REMOTE': '1', 05:28:34 INFO - 'NO_EM_RESTART': '1', 05:28:34 INFO - 'PAGER': '/bin/cat', 05:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:34 INFO - 'PWD': '/builds/slave/test', 05:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:34 INFO - 'SHELL': '/bin/bash', 05:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:34 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:34 INFO - 'USER': 'cltbld', 05:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:34 INFO - 'XPC_FLAGS': '0x0', 05:28:34 INFO - 'XPC_SERVICE_NAME': '0', 05:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:34 INFO - Cleaning up... 05:28:34 INFO - Return code: 0 05:28:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:34 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:34 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 05:28:34 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 05:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:34 INFO - 'HOME': '/Users/cltbld', 05:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:34 INFO - 'LOGNAME': 'cltbld', 05:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:34 INFO - 'MOZ_NO_REMOTE': '1', 05:28:34 INFO - 'NO_EM_RESTART': '1', 05:28:34 INFO - 'PAGER': '/bin/cat', 05:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:34 INFO - 'PWD': '/builds/slave/test', 05:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:34 INFO - 'SHELL': '/bin/bash', 05:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:34 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:34 INFO - 'USER': 'cltbld', 05:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:34 INFO - 'XPC_FLAGS': '0x0', 05:28:34 INFO - 'XPC_SERVICE_NAME': '0', 05:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:34 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 05:28:34 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 05:28:34 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 05:28:34 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 05:28:34 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 05:28:34 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 05:28:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:38 INFO - Downloading docopt-0.6.1.tar.gz 05:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:38 INFO - Running setup.py install for blobuploader 05:28:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:38 INFO - Running setup.py install for requests 05:28:39 INFO - Running setup.py install for docopt 05:28:39 INFO - Successfully installed blobuploader requests docopt 05:28:39 INFO - Cleaning up... 05:28:39 INFO - Return code: 0 05:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:39 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:39 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 05:28:39 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 05:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:39 INFO - 'HOME': '/Users/cltbld', 05:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:39 INFO - 'LOGNAME': 'cltbld', 05:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:39 INFO - 'MOZ_NO_REMOTE': '1', 05:28:39 INFO - 'NO_EM_RESTART': '1', 05:28:39 INFO - 'PAGER': '/bin/cat', 05:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:39 INFO - 'PWD': '/builds/slave/test', 05:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:39 INFO - 'SHELL': '/bin/bash', 05:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:39 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:39 INFO - 'USER': 'cltbld', 05:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:39 INFO - 'XPC_FLAGS': '0x0', 05:28:39 INFO - 'XPC_SERVICE_NAME': '0', 05:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-t2Itsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cDTg6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-6r8KBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-G6t4x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-A5EdvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zj7WnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-fp0NbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-IVzFVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-60ikwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zcMDC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-v8DyQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-2Sf91S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-R84ASo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ihg5qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-7y8sUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-SVm_yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xjNDmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:41 INFO - Running setup.py install for manifestparser 05:28:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:41 INFO - Running setup.py install for mozcrash 05:28:41 INFO - Running setup.py install for mozdebug 05:28:41 INFO - Running setup.py install for mozdevice 05:28:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:41 INFO - Running setup.py install for mozfile 05:28:42 INFO - Running setup.py install for mozhttpd 05:28:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Running setup.py install for mozinfo 05:28:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Running setup.py install for mozInstall 05:28:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Running setup.py install for mozleak 05:28:42 INFO - Running setup.py install for mozlog 05:28:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:42 INFO - Running setup.py install for moznetwork 05:28:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Running setup.py install for mozprocess 05:28:43 INFO - Running setup.py install for mozprofile 05:28:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Running setup.py install for mozrunner 05:28:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Running setup.py install for mozscreenshot 05:28:43 INFO - Running setup.py install for moztest 05:28:43 INFO - Running setup.py install for mozversion 05:28:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:43 INFO - Cleaning up... 05:28:43 INFO - Return code: 0 05:28:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:43 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:43 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 05:28:43 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 05:28:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:43 INFO - 'HOME': '/Users/cltbld', 05:28:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:43 INFO - 'LOGNAME': 'cltbld', 05:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:43 INFO - 'MOZ_NO_REMOTE': '1', 05:28:43 INFO - 'NO_EM_RESTART': '1', 05:28:43 INFO - 'PAGER': '/bin/cat', 05:28:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:43 INFO - 'PWD': '/builds/slave/test', 05:28:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:43 INFO - 'SHELL': '/bin/bash', 05:28:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:43 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:43 INFO - 'USER': 'cltbld', 05:28:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:43 INFO - 'XPC_FLAGS': '0x0', 05:28:43 INFO - 'XPC_SERVICE_NAME': '0', 05:28:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-wpkHDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-iVY8Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-5yfMBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-p6Ufqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-x61rFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-yfT8x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JZVWVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:44 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)) 05:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-8U3vL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Z3avhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hryw5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-FdqGqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-kZxX4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-UdM8_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-N__PSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-OwxE7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:45 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)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DZfWV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xOuQzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:46 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)) 05:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:46 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)) 05:28:46 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)) 05:28:46 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)) 05:28:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:28:48 INFO - Downloading blessings-1.6.tar.gz 05:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:48 INFO - Installing collected packages: blessings 05:28:48 INFO - Running setup.py install for blessings 05:28:48 INFO - Successfully installed blessings 05:28:48 INFO - Cleaning up... 05:28:48 INFO - Return code: 0 05:28:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:49 INFO - Reading from file tmpfile_stdout 05:28:49 INFO - Current package versions: 05:28:49 INFO - blessings == 1.6 05:28:49 INFO - blobuploader == 1.2.4 05:28:49 INFO - docopt == 0.6.1 05:28:49 INFO - functools32 == 3.2.3-2 05:28:49 INFO - jsonschema == 2.5.1 05:28:49 INFO - manifestparser == 1.1 05:28:49 INFO - mozInstall == 1.12 05:28:49 INFO - mozcrash == 0.17 05:28:49 INFO - mozdebug == 0.1 05:28:49 INFO - mozdevice == 0.48 05:28:49 INFO - mozfile == 1.2 05:28:49 INFO - mozhttpd == 0.7 05:28:49 INFO - mozinfo == 0.9 05:28:49 INFO - mozleak == 0.1 05:28:49 INFO - mozlog == 3.4 05:28:49 INFO - moznetwork == 0.27 05:28:49 INFO - mozprocess == 0.23 05:28:49 INFO - mozprofile == 0.28 05:28:49 INFO - mozrunner == 6.12 05:28:49 INFO - mozscreenshot == 0.1 05:28:49 INFO - mozsystemmonitor == 0.3 05:28:49 INFO - moztest == 0.7 05:28:49 INFO - mozversion == 1.4 05:28:49 INFO - psutil == 3.1.1 05:28:49 INFO - requests == 1.2.3 05:28:49 INFO - wsgiref == 0.1.2 05:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:49 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')]} 05:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 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')]} 05:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:49 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 05:28:49 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 05:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:49 INFO - 'HOME': '/Users/cltbld', 05:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:49 INFO - 'LOGNAME': 'cltbld', 05:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:49 INFO - 'MOZ_NO_REMOTE': '1', 05:28:49 INFO - 'NO_EM_RESTART': '1', 05:28:49 INFO - 'PAGER': '/bin/cat', 05:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:49 INFO - 'PWD': '/builds/slave/test', 05:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:49 INFO - 'SHELL': '/bin/bash', 05:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:49 INFO - 'USER': 'cltbld', 05:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:49 INFO - 'XPC_FLAGS': '0x0', 05:28:49 INFO - 'XPC_SERVICE_NAME': '0', 05:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 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)) 05:28:49 INFO - Cleaning up... 05:28:49 INFO - Return code: 0 05:28:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28:49 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')]} 05:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 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')]} 05:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 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 0x100c45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bbb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b2c59830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, '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.LtIbvRD4Si/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.tBpi8uW89J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 05:28:49 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 05:28:49 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 05:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:49 INFO - 'HOME': '/Users/cltbld', 05:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:49 INFO - 'LOGNAME': 'cltbld', 05:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:49 INFO - 'MOZ_NO_REMOTE': '1', 05:28:49 INFO - 'NO_EM_RESTART': '1', 05:28:49 INFO - 'PAGER': '/bin/cat', 05:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:49 INFO - 'PWD': '/builds/slave/test', 05:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:49 INFO - 'SHELL': '/bin/bash', 05:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:28:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:49 INFO - 'USER': 'cltbld', 05:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:49 INFO - 'XPC_FLAGS': '0x0', 05:28:49 INFO - 'XPC_SERVICE_NAME': '0', 05:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:49 INFO - Cleaning up... 05:28:49 INFO - Return code: 0 05:28:49 INFO - Running post-action listener: _resource_record_post_action 05:28:49 INFO - Running post-action listener: _start_resource_monitoring 05:28:49 INFO - Starting resource monitoring. 05:28:49 INFO - [mozharness: 2016-10-15 12:28:49.767245Z] Finished create-virtualenv step (success) 05:28:49 INFO - [mozharness: 2016-10-15 12:28:49.768233Z] Running install step. 05:28:49 INFO - Running pre-action listener: _resource_record_pre_action 05:28:49 INFO - Running main action method: install 05:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:50 INFO - Reading from file tmpfile_stdout 05:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:50 INFO - Reading from file tmpfile_stdout 05:28:50 INFO - Output received: 05:28:50 INFO - Usage: mozinstall [options] installer 05:28:50 INFO - Options: 05:28:50 INFO - -h, --help show this help message and exit 05:28:50 INFO - -d DEST, --destination=DEST 05:28:50 INFO - Directory to install application into. [default: 05:28:50 INFO - "/builds/slave/test"] 05:28:50 INFO - --app=APP Application being installed. [default: firefox] 05:28:50 INFO - mkdir: /builds/slave/test/build/application 05:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:29:24 INFO - Reading from file tmpfile_stdout 05:29:24 INFO - Output received: 05:29:24 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:29:24 INFO - Running post-action listener: _resource_record_post_action 05:29:24 INFO - [mozharness: 2016-10-15 12:29:24.933221Z] Finished install step (success) 05:29:24 INFO - [mozharness: 2016-10-15 12:29:24.933366Z] Running run-tests step. 05:29:24 INFO - Running pre-action listener: _resource_record_pre_action 05:29:24 INFO - Running main action method: run_tests 05:29:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:24 INFO - 2016-10-15 05:29:24.947 screenresolution[1646:10114] starting screenresolution argv=screenresolution get 05:29:24 INFO - 2016-10-15 05:29:24.950 screenresolution[1646:10114] Display 0: 1600x1200x32@60 05:29:24 INFO - 2016-10-15 05:29:24.956 screenresolution[1647:10116] starting screenresolution argv=screenresolution list 05:29:24 INFO - Available Modes on Display 0 05:29:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:25 INFO - Intel Iris: 05:29:25 INFO - Chipset Model: Intel Iris 05:29:25 INFO - Type: GPU 05:29:25 INFO - Bus: Built-In 05:29:25 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:25 INFO - Vendor: Intel (0x8086) 05:29:25 INFO - Device ID: 0x0a2e 05:29:25 INFO - Revision ID: 0x0009 05:29:25 INFO - Displays: 05:29:25 INFO - Display: 05:29:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:25 INFO - Display Serial Number: 1600x1200 60 05:29:25 INFO - Main Display: Yes 05:29:25 INFO - Mirror: Off 05:29:25 INFO - Online: Yes 05:29:25 INFO - Rotation: Supported 05:29:25 INFO - Return code: 0 05:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:25 INFO - Python 2.7.3 05:29:25 INFO - Return code: 0 05:29:25 INFO - grabbing minidump binary from tooltool 05:29:25 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')]} 05:29:25 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 0x100a59d30>, '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 0x10087fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a51b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:25 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 05:29:25 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 05:29:25 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 05:29:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:25 INFO - Return code: 0 05:29:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:29:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:29:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 05:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 05:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtIbvRD4Si/Render', 05:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:25 INFO - 'HOME': '/Users/cltbld', 05:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:25 INFO - 'LOGNAME': 'cltbld', 05:29:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:25 INFO - 'MOZ_NO_REMOTE': '1', 05:29:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:25 INFO - 'NO_EM_RESTART': '1', 05:29:25 INFO - 'PAGER': '/bin/cat', 05:29:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:25 INFO - 'PWD': '/builds/slave/test', 05:29:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:25 INFO - 'SHELL': '/bin/bash', 05:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tBpi8uW89J/Listeners', 05:29:25 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 05:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:25 INFO - 'USER': 'cltbld', 05:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:25 INFO - 'XPC_FLAGS': '0x0', 05:29:25 INFO - 'XPC_SERVICE_NAME': '0', 05:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 05:29:25 INFO - mozversion application_buildid: 20161015030203 05:29:25 INFO - mozversion application_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 05:29:25 INFO - mozversion application_display_name: Nightly 05:29:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:25 INFO - mozversion application_name: Firefox 05:29:25 INFO - mozversion application_remotingname: firefox 05:29:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:29:25 INFO - mozversion application_vendor: Mozilla 05:29:25 INFO - mozversion application_version: 52.0a1 05:29:25 INFO - mozversion platform_buildid: 20161015030203 05:29:25 INFO - mozversion platform_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 05:29:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:29:25 INFO - mozversion platform_version: 52.0a1 05:29:25 INFO - using testdate: 1476534565 05:29:25 INFO - actual date: 1476534565 05:29:25 INFO - starting webserver on 'localhost:49270' 05:29:25 INFO - SUITE-START | Running 2 tests 05:29:25 INFO - TEST-START | dromaeo_css 05:29:25 INFO - operating with platform_type : mac_ 05:29:25 INFO - Initialising browser for dromaeo_css test... 05:29:25 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpmX_J8o/profile http://localhost:49270/getInfo.html) 05:29:28 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:29:28 INFO - PROCESS | 1657 | colorDepth:24 05:29:28 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:29:28 INFO - PROCESS | 1657 | __metrics 05:29:28 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:29:28 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:28 INFO - TEST-INFO | 1657: exit 0 05:29:28 INFO - Browser initialized. 05:29:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:28 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpmX_J8o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:40 INFO - PROCESS | 1661 | RSS: Main: 232345600 05:29:40 INFO - PROCESS | 1661 | 05:30:31 INFO - PROCESS | 1661 | 1476534631983 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:32:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:32:49 INFO - PROCESS | 1661 | RSS: Main: 396185600 05:32:49 INFO - PROCESS | 1661 | 05:35:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:35:52 INFO - PROCESS | 1661 | RSS: Main: 371027968 05:35:52 INFO - PROCESS | 1661 | 05:38:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:38:55 INFO - PROCESS | 1661 | RSS: Main: 363679744 05:38:55 INFO - PROCESS | 1661 | 05:41:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:41:58 INFO - PROCESS | 1661 | RSS: Main: 367046656 05:41:58 INFO - PROCESS | 1661 | 05:45:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:45:02 INFO - PROCESS | 1661 | RSS: Main: 330657792 05:45:02 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:48:06 INFO - PROCESS | 1661 | RSS: Main: 412717056 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | __start_tp_report 05:48:06 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 05:48:06 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 05:48:06 INFO - PROCESS | 1661 | |i|pagename|runs| 05:48:06 INFO - PROCESS | 1661 | |0;dojo.html;3237.6600456952006;3269.724807325143;3273.4107860585086;3324.783889047211;3362.478815783553;4659.394278743758;5497.340319161696;5556.9444305556935;5671.71641417929;5680.545556355487;5556.277683901088;5566.415526369724;5576.191452239433;5577.832665020056;5588.161775733642;5059.949400505985;5084.923726144111;5092.745362731848;5128.461511541291;5166.328377310944;5125.615578831584;5204.635675502716;5216.947830521684;5219.817306394277;5229.3201883755055;5110;5138.306328645641;5157.793688252485;5181.378234611833;5215.947840521603;5210.270562121306;5217.50433708797;5217.608679349064;5217.660852044605;5237.502437268491;5020.748962551895;5038.7984480620735;5094.057599344133;5133.204353325241;5137.229415587692;4615.861524154281;5595.1886976388605;5626.127950167731;5627.549796016309;5667.716614169316;6172.197614310111;6172.382761723837;6179.9803032499585;6185.536084793658;6200.255969283715;6112.266528016667;6134.325224225332;6170.537209709245;6244.56288059836;6245.094461303131;5643.125315576092;5647.040003199466;5653.943460565424;5655.462731040545;5656.2929633795775;6175.752969881244;6236.407541283571;6236.532260080512;6237.750489980441;6273.560850740404;5904.232449781501;5953.672548009815;5967.403259673998;5970.044792833126;5971.2834459864225;6107.097787096225;6121.57491608479;6121.849304493819;6126.366913828976;6133.662648554372;6078.6048906820915;6097.420745029215;6117.174181485531;6126.387361263927;6134.723937422827;6102.115193296947;6114.969425152845;6118;6120.387961203844;6129.540284478593;4815.422149342101;4881.731504767201;4890.2909078184175;4891.241857512091;4934.679245849008;4263.936040959388;4392.231359512137;4394.384786129945;4433.866983990485;4436.401085853368;5530.308711411074;5597.916031259534;5603.3836278009385;5603.7478313475995;5610.326760788732;6155.661438620829;6159.076138579159;6164.907526387108;6186.505079593621;6189.50483961282;4835.734034628059;4960.330355402047;5645.153227015899;5686.630369026083;5712.314522257273;5213.50471705195;5271.077561426811;5280.049591073567;5324.707141107198;5326.334208223972;6220.098085777628;6278.215223097113;6286.968565157145;6288.40260175301;6292.622442653455;6234.625922444668;6235.220597425322;6240.438360547391;6240.563160578716;6254.437100660963;6171.352008039091;6251;6263.4362907338555;6306.180196574416;6309.400606942333;5990.3710110439515;6069.362716914837;6106.725197366218;6106.938930610815;6136.365905528456;6211.09939058843;6219.129321895029;6221.9377806223165;6224.1597384354345;6229.2524897012645;6029.3669164737075;6034.456898879122;6039.275286965592;6042.939570604413;6050.21347224858;5867.970660146842;5877.471027607536;5888.852778680567;5913.083472061838;5987.31145918225;5782.219400381063;5813.476787089182;5849.590528662953;5867;5891.970540147443;5983.640981541122;5984.371640977634;6010.7295171716505;6024.427679370453;6044.032954727222;5709.25779648643;5787.681677507778;5789.565782566408;5808.361080281081;5861.6189947653265 05:48:06 INFO - PROCESS | 1661 | |1;ext.html;440.2801419678826;488.6164360976634;493.95801356884664;510.3951817096743;515.8779654252004;30392.848035759846;32774.344513109754;40864.795676021575;40893.591064089385;43411.34882976758;37795.62204377962;40359.19281614366;42524.14951700964;42900.57099429005;42917.570824291746;9424.811503769937;9607;9617.90382096177;9625.759356016086;9656.468894210815;9550.665726699566;9597.280203984694;9605.423674579513;9609.039096090404;9625.085616866387;9568.282378821581;9580.700631848376;9608.039196080372;9619.951900240489;9629.133377995979;8308.916910830874;9423.293253006052;9529.428234305964;9592.424454532751;9600.567974441097;9507.57215925285;9540.713778586654;9554.713358599252;9556.331056826026;9560.187384072362;40019.399709004385;40387.59612403897;40458.595414045776;40556.59443405558;40569.797151014056;3362.714169295613;3382.543356646846;3511.087117349482;3565.286942611462;3608.855645774166;30665.540016899766;30742.538861917088;31995.040148795575;32020.879269225697;32453.837730811196;3203.759718021158;3223.9838800805846;3255.4953982132806;3348.5981682198294;3367.848446819899;478222;486696;486697;487259;487381.5630921858;33442.83278583591;61169.08246376308;61655;61706.69146654238;61805.38194618086;29241.707582924322;33286;34583.65416345804;34612.48081278783;34711.82644086763;14685.926570367079;14811;14812.70374592502;14822.92588537072;14830.33263503145;12503.374831258401;12623.747525049448;12630.747385052247;12639.620811375673;12657.367131643381;7683.001209842796;7711.151773304932;7760.068791745027;7771.922280777233;7787.065552133667;3148.307372378073;3206.9198270043435;3211.74306055515;3215.1962009497624;3237.449633562253;925.8194652042787;984.8276551603441;995.2485873165714;1053.657561292583;1071.2180108520668;29173.27066823304;29491.018712473542;29799;29976.850115749283;30155.396892062476;1010.7422607235108;1012.5747186181821;1036.1762398892897;1060.6340812419703;1086.2830531848942;14959.476418325306;15460.613484662748;15527.068375897483;15577.065376077471;15931.601709957344;526312;530412;530584;531745;531847;56845;57271.713641431525;57301.567460813814;57504.849903001705;57506.42493575095;1243.154654834703;1296.500847173845;1370.4381203706432;1396.6089494941432;1416.7520683880487;31498.055058348287;31603.20991975219;31829.681703182672;31907.68092319047;32203.642433455505;50784.73038174075;51596.48403515917;51651;51672.741636291576;51775.74112129566;507941;508485;509634;511153;512005;23700.762992369855;24243.272701818973;26414.603780943686;27219.04733334324;27236.863815680794;39547;46936;47389.052218956116;47403.76298118625;47792;39255.6074439252;39599.60400395959;39629.60370396259;40834.591654084266;41390.793046034574;38452.038699031626;39817.80091099526;39859.80070099631;39982;40366;38221.80889095537;38476;39197.804010979766;39340.81977540678;39404;33545;34792.73730728493;35513.467297990035;37002.44496332611;37464.438033428974;25360.492790144464;25546.361340965883;25806.61290080688;25926.22221333363;26482.86758566195 05:48:06 INFO - PROCESS | 1661 | |2;jquery.html;368.21202626379534;374.9718771092168;379.6545143919033;391.6455607675052;401.945737325461;14157.789470150075;15335.616609584766;18935.905320473397;20957.68563471547;21137.26019589315;19078.90460547699;19855.602887942234;20705;20705.896470517626;20847.687284690743;5649.887002259952;5960.701964901759;5969.373215812342;5970.223870896777;5975.342712301644;4172.102997855461;4383.715058521202;4397.956020439787;5834.56240781941;6180.443760061594;6346.01636746305;6498.837529061764;6513.902291465632;6519.8044058678315;6536.869262614745;5614.578906582023;5904.350521442617;5950.7917222896995;6044.093385992092;6045.093236014589;5547.417521160301;5725.856853578653;5786.913196302059;5817.912731309034;5824.88350232993;13252.734945301136;13477.86522134776;13480.123791953492;13494.527691530848;20789;2156.040561949933;2267.7732226777357;2324.395657129142;2429.514097180571;2676.210517897225;9753.951230243803;9795.951020244853;10171.796564068678;10195.847062294071;10289;1834.0279651784576;1843.787964384086;1856.0193948065207;1879.8872067675984;1881.8964956927364;111604.4419777904;113563;118661;119142.40428797888;120658;11268.943655281671;11329.60346387889;11427;11548.826767598493;11641.825372619418;14568.41726330956;14575.927120364331;14580.86511400054;14602.853971460361;14607.634809129644;8434.704785332606;8562.52906090171;8592.65629374818;8612.913870861337;8680.609372578248;7292.197858235696;8469.449485783405;8562.914370856337;8572.742817715478;8740.956295218482;3679.633135680822;4461.04087621163;4468.530804265571;4469.843555475542;4551.180787458289;1845.5386153461634;1883.4161409962956;1893.0629338477268;1902.6099649571804;1903.571696368306;889.7997950461095;900.4687234531658;940.8729821474013;973.2992245583168;980.4705459052175;16820.915895420443;19370.261866855628;19450.513737156685;19857.106430210675;21579.92100394974;926.6200857648332;937;937.3953799799092;943.8772959515219;965.9661911833052;10560.419176945188;10977.451127443595;11193;11232;11232.719182020515;548686;552422;554037;567506;571979;96881.51559242299;119061;127904;128178.99999999814;129808;889.3729920406098;921.2814005076051;926.4117285523741;952.0669743651122;953.7424895278236;18061.548461288574;18596.907015464836;18949.526261843563;19012.14445349935;19080.618387632447;52331.21503177379;53917.73041134769;53975.19037214523;54037.189442159186;54578.72710636421;77166.6141669288;78137.60931195307;78458;79253.4149316999;80176.1982380192;5389;6960.860782784214;7667.3099421052375;7694.115176754744;7969.282764551218;10739.946300268448;12947.870521295043;13153.699137478752;13380.598582042554;13437.529686460926;11117.555297788322;11501.137414693763;11512.136589755635;11710.94144529272;11834.053275738093;11132.276402033842;11191;11194.44027798623;11738;11890.881091188978;11455.885441145816;11584.942075289906;11603.01374383153;11796.88203117992;11877.346745929057;7269.673704414537;7437.590932498764;7465.29079737424;7494.5128566643;7661.62489628217;9435.811283774148;11358;11462.770744585228;11627.383838636239;11641.708957276136 05:48:06 INFO - PROCESS | 1661 | |3;mootools.html;1517.9924100379496;1544.7528395456725;1752.2903224194197;1883.3408307092511;1926.056232446101;8369.163083691636;8880.156385143417;8885.68900088497;8886.377953543255;8886.511241881703;7791.298783109519;8055.879161812578;8066.3546916246705;8398.874016889751;8652.826943461127;2345.8709770962632;2379.547885901673;2385.689860318156;2387.880605969703;2394.281715485356;2326.6510023496526;2350.8589484630975;2362.9645555316683;2374.1453076892303;2396.880155992202;2090.1430413530456;2358.988205058972;2385.8926348314367;2393.461471168982;2395.1736650855514;2345.3667509772436;2367.2779802160335;2367.5146594948164;2375.714914210306;2376.251480783548;1945.9416217513497;2264.5810525052752;2272.9659055114184;2278.0773786616446;2281.977180228193;8612.224899759052;8668.8699669505;8725.38922275441;8747;8766.824663506693;5174.146265866128;5329.467053294678;5345.3585569731495;5347.973260133675;5350.438203988564;3424.2466657335594;3508.105433114565;3657.8902632921054;3658.487811706363;3665.3585622515952;934.9158575728217;1073.661796534097;1075.5643964194514;1079.1959989807565;1094.43089593411;11129.220954533186;11258.04306633937;11277.943610281978;11278.379689117095;11296.491657875415;3810.7523011004196;4532.660050496226;4771.642126840501;4784.64115191362;4785.803549112722;9699.030096990386;9719.368241064309;9720.513974301257;9737.853932191023;9742.75643108928;5321.2018197269945;5324.467553244722;5325.387580428301;5349.251104845324;5355.277037599952;4357.847475338412;4358.106588149421;4711.1519926413575;4887.535684110004;4901.877453063631;3861.9034524137123;3871.825767840454;4010.5588385277597;4013.4581831452965;4027.899302517402;1263.9873601264053;1286.408252203978;1287.497875828409;1301.5965050834272;1302.8501722301867;879.520661239626;902.9503377314311;913.7761248494029;946.4557879219476;949.4350861237552;5754.1944127822135;5920.141579470953;6039.486643635252;6057.24672419304;6289.465395441439;770.6609091999502;810.9635066422026;922.5110691333604;949.1694767078806;965.5654955270156;3811.294910441577;3849.615038496128;3909.4558540364014;4051.0480037191237;4085.632293093636;8856.424332418372;10617.840732388866;10622.415767132727;10623.628173013907;10633.73415664599;8976.730698079067;10542.525586348633;10550.683479495627;10562.20783441245;10623.946880265548;8010.439269251096;8146.429749917567;8153.510789352539;8159;8180.672773089129;5496.917546236729;5736.512396446349;5903.144044113666;5907.645541267538;5926.911096333644;9859.260555458513;9874.456904870302;9941.155001824925;9970.152537034433;9979.950100249453;9432.95283523578;9772.657956971472;9803.354828421481;9963.950180249052;10044.849327259952;6888.690008949709;7152;7342.77971660851;7459.515131516434;7543.132539757778;7871.33093687043;7923.484973476706;7935.722249721232;7964.163762805054;8154.266116049347;7299.087614048244;7471.514351567348;7474.92525074764;7557.470977031555;7623;7066.752663656747;7264.636768161465;7348.70605175787;7395.667194976131;7448.031755871702;6843.178818541807;6868.416184624363;6967.477439192182;6972.44220462372;6998.335158159966;4960.280759289955;4991.326170967018;5009.749512524432;5034.370703662043;5112;4916.360873086476;4919.901601968012;4959.330490383752;5002.924956125734;5139.383274007143 05:48:06 INFO - PROCESS | 1661 | |4;prototype.html;287.9366539361341;295.6998646373931;304.4018503640346;309.9566060751495;313.53596676918147;4464.598186163249;5047.77285022174;5286.65636733613;5362.731863406829;5423.972880135599;3772.4341348797693;4630.768461576925;4642.419697537808;5106.719130447824;5294.682319060849;4088.1414902870433;4092.1611069730634;4102.5179766241445;4106.753594784323;4111.691623128262;4116.423700681907;4130.607592278729;4156.251874662559;4158.6673066154635;4167.270727622669;3686.7234957378305;3821.388577827548;3928.2143571285715;3990.501187351581;4104.40486129511;4054.635082842529;4071.9389209161886;4104.158647477275;4111.280525907954;4147.258151576315;3540.345036168317;3558.7864728116397;3566.625504322061;3581.8209089545417;3602.3155600435834;4544.590986811169;4729.013814198045;5202.401723801773;5241.588869120209;5253.921191182136;4528.8641340759505;4540.6594505411895;4569.2003899317815;4571;4576.359309696645;4389.978050109761;5055.761338472098;5673.347565030033;5677.545796336283;5679.744411501492;3672.632736726306;3708.4437334400054;3819.7899115548635;3833.9808300958593;3838.654521093115;5533.833984980457;5543.695096769717;5772.278465191851;5775.826725198251;5929.703514824241;3722.1439069014277;3738.9626103738615;3836.7889766062576;3858.6720128788807;3864.516935383077;3564.9643503565153;3714.461403096536;3927.410888366711;3930.272899513599;3939.7045221608496;3996.300647386696;4542.88642783933;4567.314902764612;4596.598037598497;4599.379083823708;4815.807367705253;4875.854174269044;5342.786288548492;5563.471470210324;5619.915701264485;1300.3888172558882;1328.973420531584;1330.760463116629;1334.7197088611501;1340.169095160987;725.8040329111216;726.0778810910115;800.771780042685;814.4217605500161;820.335528222142;4350.58669426404;4430.712003719748;4455.1312494064;4490.483594386622;4495.775211239425;4320.589543993316;4790.826247569368;4792.976035119872;4819;4823.348847905558;3814.9809250953567;4378.489421149762;4378.868633940987;4446.177457170434;4484.5873549831695;2133.605283022646;2168.7722789107233;2244.696965909581;2394.4133687246735;2511.8696586535766;4001.8199181036925;4846.030793841246;4945.3571035765835;4953.984433191187;4990.426100998359;4085.4688890444054;4169.437125988014;4245.5542168072525;4309.612134907873;4698.624110071186;4477.19410506112;4798.760061996886;4951.331570237971;5016.949830501649;5027.8827127181385;4040.3535434330365;4770.594499467584;4804.35141255926;4805.37530121082;4830.975845120752;3866.1465244589576;4036.5357983832237;4345.435093437833;4670.789814458425;4787.353707249476;4046.8785936421955;4959.776810043629;5684.3231246783125;5954.940450595612;6142.682951206477;3459.965400346065;3855.710821688441;3898.3372826618975;3898.9667738050007;3918.333883239799;5258.8159414420315;5863.618864773776;5898.675572843535;5922.032238400196;5945.91081133792;4814.855554333376;4911.58251548608;5428.592855535771;5646.85882852932;5646.9152962704775;5672.269957662952;5692.31692196939;5693.629914055573;5696.8006119785605;5718.542516598745;4746.525347465225;5381.67709937405;5576.208178438538;5616.522595579421;5633.774649013993;5568.888622227614;5597.608167428241;5605.439456054362;5620.325560932714;5672.057919745902;4664.766761661971;4927.18701414277;5487.314085739283;5544.69504177258;5579.8884022320135 05:48:06 INFO - PROCESS | 1661 | |5;yui.html;722.2452537098733;757.7158565537924;791.8337149198668;794.789380814084;844.1853611265129;15186.468473603427;15996.920015399906;15999.92000040001;16006.35974561019;16051.277692503836;14154.50459233927;14214.218217998006;14544.345504452298;14623.78064329036;14697.485588004422;696.9059177011114;720.906282183318;872.1017352127319;896.3635818568824;900.9504477253748;719.2376081353756;875.2910142784365;895.9731208063736;896.6413434626137;911.0479548871446;967.032967032967;967.0377973915963;970.4419958523841;970.5632465390568;973.352720440906;956.7464621875208;957.004715096299;957.1385752822446;957.6408846682494;959.0170075672422;542.7394850471757;562.3252097483037;670.8490589617297;692.6605963078106;693.5110746923407;15260.160691161982;15319.31063102163;15369.154696491689;15370.538883833502;15374.077555346716;13655.795163072562;14161.645958851008;14292.071015383966;14295;14300;12694.555690550878;12719.554815581503;12734.363281835964;12893;12902.741945161139;4510.120526497334;4544.613707834838;4641.907161856744;4750.192467280571;4762.857114286542;106270.46864765626;107173.46413267961;107393;108450;119255.4037229817;9881.604735810488;11268.887311126948;11431.942840285745;11509.136814738928;11611.767764644828;20325.898370508054;21217.62085464471;22570.435739106655;22572.66141007886;22600.66099008516;7791.688332466638;8178.427510074238;8184.754457366289;8190.8771368429525;8192.877106843402;4295.978520107379;4411.20598292304;4529.569690879362;4594.448666160082;4604.332371806069;3462.9307413852084;3572.91067723309;3576.588692300367;3578.7673801202836;3585.4263317869018;641.425923798198;646.2309851276965;658.1148355461896;666.0907860770014;673.2089794491453;540.7215284128677;592.8666050138685;606.9696515174223;633.6134957675814;654.6334052930374;8603.741887743377;8897.154770296811;8970.506622135845;8978.024834536522;9108.271338292921;539.2692901119005;541.8401571536406;554.8058179637095;596.0879853823657;627.3475585391142;3616.5660120785674;3936.7441116327345;4253.170631726845;4420.403245561808;4439.467263928284;156461.2176939108;158972;160159.3984060168;161317;167007.16496417683;123593;130971.34514327368;133437;139192.30403848118;144407;114664;115490;117684.64630707509;117839;119839.80160198461;8269.503829770232;8503.829923401621;8538.895646798393;8604.569771511524;8844.557772111497;56196;58800.70599646975;59719.50701232504;61317.70776045634;64063.679681601294;93439.53280233555;101200.49399752954;101201.48197776893;102133;104924.95122824947;11514.37297251363;11686.766264674829;11818.527258909548;12076.637700868989;12290.815637765261;12113.939430302793;12198.75602487963;12234.327112008925;12460.813087803508;12919.806202906775;11548.884511154782;11653.184277100521;11873;11962.222455540363;11968.46141923598;11620.186586938833;11976.401179940794;12102.152849300464;12148.388096559282;12364.56724014655;10500.369977801356;10512.789744205225;10783.784324313627;10968.287061341307;11023.83464248021;9616.423014618866;9633.470159141314;9634.067838573905;9636.180924621205;9883.604655813688;9217.216536594464;9583.616655333708;9700;9747;9760.85358719634 05:48:06 INFO - PROCESS | 1661 | __end_tp_report 05:48:06 INFO - PROCESS | 1661 | __start_cc_report 05:48:06 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1616 05:48:06 INFO - PROCESS | 1661 | __end_cc_report 05:48:06 INFO - PROCESS | 1661 | __startTimestamp1476535686517__endTimestamp 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | ------- Summary: start ------- 05:48:06 INFO - PROCESS | 1661 | Number of tests: 6 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5647.61 Median:5861.62 stddev:647.65 (11.0%) stddev-sans-first:621.43 05:48:06 INFO - PROCESS | 1661 | Values: 3237.7 3269.7 3273.4 3324.8 3362.5 4659.4 5497.3 5556.9 5671.7 5680.5 5556.3 5566.4 5576.2 5577.8 5588.2 5059.9 5084.9 5092.7 5128.5 5166.3 5125.6 5204.6 5216.9 5219.8 5229.3 5110.0 5138.3 5157.8 5181.4 5215.9 5210.3 5217.5 5217.6 5217.7 5237.5 5020.7 5038.8 5094.1 5133.2 5137.2 4615.9 5595.2 5626.1 5627.5 5667.7 6172.2 6172.4 6180.0 6185.5 6200.3 6112.3 6134.3 6170.5 6244.6 6245.1 5643.1 5647.0 5653.9 5655.5 5656.3 6175.8 6236.4 6236.5 6237.8 6273.6 5904.2 5953.7 5967.4 5970.0 5971.3 6107.1 6121.6 6121.8 6126.4 6133.7 6078.6 6097.4 6117.2 6126.4 6134.7 6102.1 6115.0 6118.0 6120.4 6129.5 4815.4 4881.7 4890.3 4891.2 4934.7 4263.9 4392.2 4394.4 4433.9 4436.4 5530.3 5597.9 5603.4 5603.7 5610.3 6155.7 6159.1 6164.9 6186.5 6189.5 4835.7 4960.3 5645.2 5686.6 5712.3 5213.5 5271.1 5280.0 5324.7 5326.3 6220.1 6278.2 6287.0 6288.4 6292.6 6234.6 6235.2 6240.4 6240.6 6254.4 6171.4 6251.0 6263.4 6306.2 6309.4 5990.4 6069.4 6106.7 6106.9 6136.4 6211.1 6219.1 6221.9 6224.2 6229.3 6029.4 6034.5 6039.3 6042.9 6050.2 5868.0 5877.5 5888.9 5913.1 5987.3 5782.2 5813.5 5849.6 5867.0 5892.0 5983.6 5984.4 6010.7 6024.4 6044.0 5709.3 5787.7 5789.6 5808.4 5861.6 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:63880.76 Median:39723.70 stddev:135591.38 (341.3%) stddev-sans-first:135888.08 05:48:06 INFO - PROCESS | 1661 | Values: 440.3 488.6 494.0 510.4 515.9 30392.8 32774.3 40864.8 40893.6 43411.3 37795.6 40359.2 42524.1 42900.6 42917.6 9424.8 9607.0 9617.9 9625.8 9656.5 9550.7 9597.3 9605.4 9609.0 9625.1 9568.3 9580.7 9608.0 9620.0 9629.1 8308.9 9423.3 9529.4 9592.4 9600.6 9507.6 9540.7 9554.7 9556.3 9560.2 40019.4 40387.6 40458.6 40556.6 40569.8 3362.7 3382.5 3511.1 3565.3 3608.9 30665.5 30742.5 31995.0 32020.9 32453.8 3203.8 3224.0 3255.5 3348.6 3367.8 478222.0 486696.0 486697.0 487259.0 487381.6 33442.8 61169.1 61655.0 61706.7 61805.4 29241.7 33286.0 34583.7 34612.5 34711.8 14685.9 14811.0 14812.7 14822.9 14830.3 12503.4 12623.7 12630.7 12639.6 12657.4 7683.0 7711.2 7760.1 7771.9 7787.1 3148.3 3206.9 3211.7 3215.2 3237.4 925.8 984.8 995.2 1053.7 1071.2 29173.3 29491.0 29799.0 29976.9 30155.4 1010.7 1012.6 1036.2 1060.6 1086.3 14959.5 15460.6 15527.1 15577.1 15931.6 526312.0 530412.0 530584.0 531745.0 531847.0 56845.0 57271.7 57301.6 57504.8 57506.4 1243.2 1296.5 1370.4 1396.6 1416.8 31498.1 31603.2 31829.7 31907.7 32203.6 50784.7 51596.5 51651.0 51672.7 51775.7 507941.0 508485.0 509634.0 511153.0 512005.0 23700.8 24243.3 26414.6 27219.0 27236.9 39547.0 46936.0 47389.1 47403.8 47792.0 39255.6 39599.6 39629.6 40834.6 41390.8 38452.0 39817.8 39859.8 39982.0 40366.0 38221.8 38476.0 39197.8 39340.8 39404.0 33545.0 34792.7 35513.5 37002.4 37464.4 25360.5 25546.4 25806.6 25926.2 26482.9 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33321.45 Median:3177.92 stddev:93545.96 (2943.6%) stddev-sans-first:93775.65 05:48:06 INFO - PROCESS | 1661 | Values: 368.2 375.0 379.7 391.6 401.9 14157.8 15335.6 18935.9 20957.7 21137.3 19078.9 19855.6 20705.0 20705.9 20847.7 5649.9 5960.7 5969.4 5970.2 5975.3 4172.1 4383.7 4398.0 5834.6 6180.4 6346.0 6498.8 6513.9 6519.8 6536.9 5614.6 5904.4 5950.8 6044.1 6045.1 5547.4 5725.9 5786.9 5817.9 5824.9 13252.7 13477.9 13480.1 13494.5 20789.0 2156.0 2267.8 2324.4 2429.5 2676.2 9754.0 9796.0 10171.8 10195.8 10289.0 1834.0 1843.8 1856.0 1879.9 1881.9 111604.4 113563.0 118661.0 119142.4 120658.0 11268.9 11329.6 11427.0 11548.8 11641.8 14568.4 14575.9 14580.9 14602.9 14607.6 8434.7 8562.5 8592.7 8612.9 8680.6 7292.2 8469.4 8562.9 8572.7 8741.0 3679.6 4461.0 4468.5 4469.8 4551.2 1845.5 1883.4 1893.1 1902.6 1903.6 889.8 900.5 940.9 973.3 980.5 16820.9 19370.3 19450.5 19857.1 21579.9 926.6 937.0 937.4 943.9 966.0 10560.4 10977.5 11193.0 11232.0 11232.7 548686.0 552422.0 554037.0 567506.0 571979.0 96881.5 119061.0 127904.0 128179.0 129808.0 889.4 921.3 926.4 952.1 953.7 18061.5 18596.9 18949.5 19012.1 19080.6 52331.2 53917.7 53975.2 54037.2 54578.7 77166.6 78137.6 78458.0 79253.4 80176.2 5389.0 6960.9 7667.3 7694.1 7969.3 10739.9 12947.9 13153.7 13380.6 13437.5 11117.6 11501.1 11512.1 11710.9 11834.1 11132.3 11191.0 11194.4 11738.0 11890.9 11455.9 11584.9 11603.0 11796.9 11877.3 7269.7 7437.6 7465.3 7494.5 7661.6 9435.8 11358.0 11462.8 11627.4 11641.7 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5628.55 Median:5324.93 stddev:3101.82 (58.3%) stddev-sans-first:3095.14 05:48:06 INFO - PROCESS | 1661 | Values: 1518.0 1544.8 1752.3 1883.3 1926.1 8369.2 8880.2 8885.7 8886.4 8886.5 7791.3 8055.9 8066.4 8398.9 8652.8 2345.9 2379.5 2385.7 2387.9 2394.3 2326.7 2350.9 2363.0 2374.1 2396.9 2090.1 2359.0 2385.9 2393.5 2395.2 2345.4 2367.3 2367.5 2375.7 2376.3 1945.9 2264.6 2273.0 2278.1 2282.0 8612.2 8668.9 8725.4 8747.0 8766.8 5174.1 5329.5 5345.4 5348.0 5350.4 3424.2 3508.1 3657.9 3658.5 3665.4 934.9 1073.7 1075.6 1079.2 1094.4 11129.2 11258.0 11277.9 11278.4 11296.5 3810.8 4532.7 4771.6 4784.6 4785.8 9699.0 9719.4 9720.5 9737.9 9742.8 5321.2 5324.5 5325.4 5349.3 5355.3 4357.8 4358.1 4711.2 4887.5 4901.9 3861.9 3871.8 4010.6 4013.5 4027.9 1264.0 1286.4 1287.5 1301.6 1302.9 879.5 903.0 913.8 946.5 949.4 5754.2 5920.1 6039.5 6057.2 6289.5 770.7 811.0 922.5 949.2 965.6 3811.3 3849.6 3909.5 4051.0 4085.6 8856.4 10617.8 10622.4 10623.6 10633.7 8976.7 10542.5 10550.7 10562.2 10623.9 8010.4 8146.4 8153.5 8159.0 8180.7 5496.9 5736.5 5903.1 5907.6 5926.9 9859.3 9874.5 9941.2 9970.2 9980.0 9433.0 9772.7 9803.4 9964.0 10044.8 6888.7 7152.0 7342.8 7459.5 7543.1 7871.3 7923.5 7935.7 7964.2 8154.3 7299.1 7471.5 7474.9 7557.5 7623.0 7066.8 7264.6 7348.7 7395.7 7448.0 6843.2 6868.4 6967.5 6972.4 6998.3 4960.3 4991.3 5009.7 5034.4 5112.0 4916.4 4919.9 4959.3 5002.9 5139.4 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4291.69 Median:4568.26 stddev:1313.96 (28.8%) stddev-sans-first:1282.82 05:48:06 INFO - PROCESS | 1661 | Values: 287.9 295.7 304.4 310.0 313.5 4464.6 5047.8 5286.7 5362.7 5424.0 3772.4 4630.8 4642.4 5106.7 5294.7 4088.1 4092.2 4102.5 4106.8 4111.7 4116.4 4130.6 4156.3 4158.7 4167.3 3686.7 3821.4 3928.2 3990.5 4104.4 4054.6 4071.9 4104.2 4111.3 4147.3 3540.3 3558.8 3566.6 3581.8 3602.3 4544.6 4729.0 5202.4 5241.6 5253.9 4528.9 4540.7 4569.2 4571.0 4576.4 4390.0 5055.8 5673.3 5677.5 5679.7 3672.6 3708.4 3819.8 3834.0 3838.7 5533.8 5543.7 5772.3 5775.8 5929.7 3722.1 3739.0 3836.8 3858.7 3864.5 3565.0 3714.5 3927.4 3930.3 3939.7 3996.3 4542.9 4567.3 4596.6 4599.4 4815.8 4875.9 5342.8 5563.5 5619.9 1300.4 1329.0 1330.8 1334.7 1340.2 725.8 726.1 800.8 814.4 820.3 4350.6 4430.7 4455.1 4490.5 4495.8 4320.6 4790.8 4793.0 4819.0 4823.3 3815.0 4378.5 4378.9 4446.2 4484.6 2133.6 2168.8 2244.7 2394.4 2511.9 4001.8 4846.0 4945.4 4954.0 4990.4 4085.5 4169.4 4245.6 4309.6 4698.6 4477.2 4798.8 4951.3 5016.9 5027.9 4040.4 4770.6 4804.4 4805.4 4831.0 3866.1 4036.5 4345.4 4670.8 4787.4 4046.9 4959.8 5684.3 5954.9 6142.7 3460.0 3855.7 3898.3 3899.0 3918.3 5258.8 5863.6 5898.7 5922.0 5945.9 4814.9 4911.6 5428.6 5646.9 5646.9 5672.3 5692.3 5693.6 5696.8 5718.5 4746.5 5381.7 5576.2 5616.5 5633.8 5568.9 5597.6 5605.4 5620.3 5672.1 4664.8 4927.2 5487.3 5544.7 5579.9 05:48:06 INFO - PROCESS | 1661 | 05:48:06 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:25429.61 Median:4274.57 stddev:41959.71 (981.6%) stddev-sans-first:42036.41 05:48:06 INFO - PROCESS | 1661 | Values: 722.2 757.7 791.8 794.8 844.2 15186.5 15996.9 15999.9 16006.4 16051.3 14154.5 14214.2 14544.3 14623.8 14697.5 696.9 720.9 872.1 896.4 901.0 719.2 875.3 896.0 896.6 911.0 967.0 967.0 970.4 970.6 973.4 956.7 957.0 957.1 957.6 959.0 542.7 562.3 670.8 692.7 693.5 15260.2 15319.3 15369.2 15370.5 15374.1 13655.8 14161.6 14292.1 14295.0 14300.0 12694.6 12719.6 12734.4 12893.0 12902.7 4510.1 4544.6 4641.9 4750.2 4762.9 106270.5 107173.5 107393.0 108450.0 119255.4 9881.6 11268.9 11431.9 11509.1 11611.8 20325.9 21217.6 22570.4 22572.7 22600.7 7791.7 8178.4 8184.8 8190.9 8192.9 4296.0 4411.2 4529.6 4594.4 4604.3 3462.9 3572.9 3576.6 3578.8 3585.4 641.4 646.2 658.1 666.1 673.2 540.7 592.9 607.0 633.6 654.6 8603.7 8897.2 8970.5 8978.0 9108.3 539.3 541.8 554.8 596.1 627.3 3616.6 3936.7 4253.2 4420.4 4439.5 156461.2 158972.0 160159.4 161317.0 167007.2 123593.0 130971.3 133437.0 139192.3 144407.0 114664.0 115490.0 117684.6 117839.0 119839.8 8269.5 8503.8 8538.9 8604.6 8844.6 56196.0 58800.7 59719.5 61317.7 64063.7 93439.5 101200.5 101201.5 102133.0 104925.0 11514.4 11686.8 11818.5 12076.6 12290.8 12113.9 12198.8 12234.3 12460.8 12919.8 11548.9 11653.2 11873.0 11962.2 11968.5 11620.2 11976.4 12102.2 12148.4 12364.6 10500.4 10512.8 10783.8 10968.3 11023.8 9616.4 9633.5 9634.1 9636.2 9883.6 9217.2 9583.6 9700.0 9747.0 9760.9 05:48:06 INFO - PROCESS | 1661 | -------- Summary: end -------- 05:48:06 INFO - PROCESS | 1661 | 05:48:07 INFO - TEST-INFO | 1661: exit 0 05:48:07 INFO - TEST-OK | dromaeo_css | took 1121611ms 05:48:07 INFO - TEST-START | kraken 05:48:07 INFO - operating with platform_type : mac_ 05:48:07 INFO - Initialising browser for kraken test... 05:48:07 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpB6CeVE/profile http://localhost:49270/getInfo.html) 05:48:09 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:48:09 INFO - PROCESS | 1669 | colorDepth:24 05:48:09 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:48:09 INFO - PROCESS | 1669 | __metrics 05:48:09 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:48:09 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:10 INFO - TEST-INFO | 1669: exit 0 05:48:10 INFO - Browser initialized. 05:48:10 INFO - Running cycle 1/1 for kraken test... 05:48:10 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpB6CeVE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:22 INFO - PROCESS | 1671 | RSS: Main: 230649856 05:48:22 INFO - PROCESS | 1671 | 05:48:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:25 INFO - PROCESS | 1671 | RSS: Main: 290799616 05:48:25 INFO - PROCESS | 1671 | 05:48:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:48:28 INFO - PROCESS | 1671 | RSS: Main: 291491840 05:48:28 INFO - PROCESS | 1671 | 05:48:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:48:33 INFO - PROCESS | 1671 | RSS: Main: 383729664 05:48:33 INFO - PROCESS | 1671 | 05:48:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:48:35 INFO - PROCESS | 1671 | RSS: Main: 286212096 05:48:35 INFO - PROCESS | 1671 | 05:48:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:38 INFO - PROCESS | 1671 | RSS: Main: 290807808 05:48:38 INFO - PROCESS | 1671 | 05:48:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:41 INFO - PROCESS | 1671 | RSS: Main: 328351744 05:48:41 INFO - PROCESS | 1671 | 05:48:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:45 INFO - PROCESS | 1671 | RSS: Main: 328798208 05:48:45 INFO - PROCESS | 1671 | 05:48:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:48:48 INFO - PROCESS | 1671 | RSS: Main: 328998912 05:48:48 INFO - PROCESS | 1671 | 05:48:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:50 INFO - PROCESS | 1671 | RSS: Main: 302768128 05:48:50 INFO - PROCESS | 1671 | 05:48:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:53 INFO - PROCESS | 1671 | RSS: Main: 306012160 05:48:53 INFO - PROCESS | 1671 | 05:48:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:56 INFO - PROCESS | 1671 | RSS: Main: 309735424 05:48:56 INFO - PROCESS | 1671 | 05:48:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:00 INFO - PROCESS | 1671 | RSS: Main: 320319488 05:49:00 INFO - PROCESS | 1671 | 05:49:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:03 INFO - PROCESS | 1671 | RSS: Main: 320311296 05:49:03 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:49:05 INFO - PROCESS | 1671 | RSS: Main: 364703744 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | __start_tp_report 05:49:05 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:49:05 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:49:05 INFO - PROCESS | 1671 | |i|pagename|runs| 05:49:05 INFO - PROCESS | 1671 | |0;ai-astar;111;113;113;113;113;113;112;111;112;113 05:49:05 INFO - PROCESS | 1671 | |1;audio-beat-detection;151;112;112;150;113;114;114;114;144;111 05:49:05 INFO - PROCESS | 1671 | |2;audio-dft;182;184;183;186;185;186;179;189;187;188 05:49:05 INFO - PROCESS | 1671 | |3;audio-fft;79;59;59;90;62;60;74;83;100;58 05:49:05 INFO - PROCESS | 1671 | |4;audio-oscillator;82;72;91;69;70;68;93;68;69;91 05:49:05 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;85;89;87;88;86;91;87;89;85 05:49:05 INFO - PROCESS | 1671 | |6;imaging-darkroom;98;97;97;97;97;98;98;99;98;96 05:49:05 INFO - PROCESS | 1671 | |7;imaging-desaturate;84;82;81;80;82;84;85;84;83;81 05:49:05 INFO - PROCESS | 1671 | |8;json-parse-financial;56;53;53;54;55;56;54;54;56;55 05:49:05 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;68;71;68;75;72;69;69;70;69;71 05:49:05 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;89;88;91;86;88;86;88;96;99 05:49:05 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;165;157;148;147;146;144;149;144;197;136 05:49:05 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;173;172;177;173;173;172;171;172;173;173 05:49:05 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;70;69;70;68;68;68;68;69;69 05:49:05 INFO - PROCESS | 1671 | __end_tp_report 05:49:05 INFO - PROCESS | 1671 | __start_cc_report 05:49:05 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2098 05:49:05 INFO - PROCESS | 1671 | __end_cc_report 05:49:05 INFO - PROCESS | 1671 | __startTimestamp1476535745678__endTimestamp 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:49:05 INFO - PROCESS | 1671 | Number of tests: 14 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.84 (0.7%) stddev-sans-first:0.73 05:49:05 INFO - PROCESS | 1671 | Values: 111.0 113.0 113.0 113.0 113.0 113.0 112.0 111.0 112.0 113.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:114.00 stddev:17.26 (15.1%) stddev-sans-first:15.17 05:49:05 INFO - PROCESS | 1671 | Values: 151.0 112.0 112.0 150.0 113.0 114.0 114.0 114.0 144.0 111.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:3.00 (1.6%) stddev-sans-first:2.99 05:49:05 INFO - PROCESS | 1671 | Values: 182.0 184.0 183.0 186.0 185.0 186.0 179.0 189.0 187.0 188.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:72.40 Median:68.00 stddev:15.12 (22.2%) stddev-sans-first:15.85 05:49:05 INFO - PROCESS | 1671 | Values: 79.0 59.0 59.0 90.0 62.0 60.0 74.0 83.0 100.0 58.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:10.73 (13.9%) stddev-sans-first:11.24 05:49:05 INFO - PROCESS | 1671 | Values: 82.0 72.0 91.0 69.0 70.0 68.0 93.0 68.0 69.0 91.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.96 (2.2%) stddev-sans-first:2.01 05:49:05 INFO - PROCESS | 1671 | Values: 89.0 85.0 89.0 87.0 88.0 86.0 91.0 87.0 89.0 85.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:98.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 05:49:05 INFO - PROCESS | 1671 | Values: 98.0 97.0 97.0 97.0 97.0 98.0 98.0 99.0 98.0 96.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:82.60 Median:83.50 stddev:1.65 (2.0%) stddev-sans-first:1.67 05:49:05 INFO - PROCESS | 1671 | Values: 84.0 82.0 81.0 80.0 82.0 84.0 85.0 84.0 83.0 81.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.13 05:49:05 INFO - PROCESS | 1671 | Values: 56.0 53.0 53.0 54.0 55.0 56.0 54.0 54.0 56.0 55.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:2.15 (3.0%) stddev-sans-first:2.13 05:49:05 INFO - PROCESS | 1671 | Values: 68.0 71.0 68.0 75.0 72.0 69.0 69.0 70.0 69.0 71.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:88.50 stddev:4.45 (5.0%) stddev-sans-first:4.51 05:49:05 INFO - PROCESS | 1671 | Values: 86.0 89.0 88.0 91.0 86.0 88.0 86.0 88.0 96.0 99.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:148.50 stddev:17.23 (11.6%) stddev-sans-first:17.75 05:49:05 INFO - PROCESS | 1671 | Values: 165.0 157.0 148.0 147.0 146.0 144.0 149.0 144.0 197.0 136.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.00 stddev:1.60 (0.9%) stddev-sans-first:1.69 05:49:05 INFO - PROCESS | 1671 | Values: 173.0 172.0 177.0 173.0 173.0 172.0 171.0 172.0 173.0 173.0 05:49:05 INFO - PROCESS | 1671 | 05:49:05 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 05:49:05 INFO - PROCESS | 1671 | Values: 69.0 70.0 69.0 70.0 68.0 68.0 68.0 68.0 69.0 69.0 05:49:05 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:49:05 INFO - PROCESS | 1671 | 05:49:06 INFO - TEST-INFO | 1671: exit 0 05:49:06 INFO - TEST-OK | kraken | took 59449ms 05:49:06 INFO - SUITE-END | took 1181s 05:49:06 INFO - Completed test suite (00:19:41) 05:49:06 INFO - javascript benchmark 05:49:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.6600456952006, 3269.724807325143, 3273.4107860585086, 3324.783889047211, 3362.478815783553, 4659.394278743758, 5497.340319161696, 5556.9444305556935, 5671.71641417929, 5680.545556355487, 5556.277683901088, 5566.415526369724, 5576.191452239433, 5577.832665020056, 5588.161775733642, 5059.949400505985, 5084.923726144111, 5092.745362731848, 5128.461511541291, 5166.328377310944, 5125.615578831584, 5204.635675502716, 5216.947830521684, 5219.817306394277, 5229.3201883755055, 5110.0, 5138.306328645641, 5157.793688252485, 5181.378234611833, 5215.947840521603, 5210.270562121306, 5217.50433708797, 5217.608679349064, 5217.660852044605, 5237.502437268491, 5020.748962551895, 5038.7984480620735, 5094.057599344133, 5133.204353325241, 5137.229415587692, 4615.861524154281, 5595.1886976388605, 5626.127950167731, 5627.549796016309, 5667.716614169316, 6172.197614310111, 6172.382761723837, 6179.9803032499585, 6185.536084793658, 6200.255969283715, 6112.266528016667, 6134.325224225332, 6170.537209709245, 6244.56288059836, 6245.094461303131, 5643.125315576092, 5647.040003199466, 5653.943460565424, 5655.462731040545, 5656.2929633795775, 6175.752969881244, 6236.407541283571, 6236.532260080512, 6237.750489980441, 6273.560850740404, 5904.232449781501, 5953.672548009815, 5967.403259673998, 5970.044792833126, 5971.2834459864225, 6107.097787096225, 6121.57491608479, 6121.849304493819, 6126.366913828976, 6133.662648554372, 6078.6048906820915, 6097.420745029215, 6117.174181485531, 6126.387361263927, 6134.723937422827, 6102.115193296947, 6114.969425152845, 6118.0, 6120.387961203844, 6129.540284478593, 4815.422149342101, 4881.731504767201, 4890.2909078184175, 4891.241857512091, 4934.679245849008, 4263.936040959388, 4392.231359512137, 4394.384786129945, 4433.866983990485, 4436.401085853368, 5530.308711411074, 5597.916031259534, 5603.3836278009385, 5603.7478313475995, 5610.326760788732, 6155.661438620829, 6159.076138579159, 6164.907526387108, 6186.505079593621, 6189.50483961282, 4835.734034628059, 4960.330355402047, 5645.153227015899, 5686.630369026083, 5712.314522257273, 5213.50471705195, 5271.077561426811, 5280.049591073567, 5324.707141107198, 5326.334208223972, 6220.098085777628, 6278.215223097113, 6286.968565157145, 6288.40260175301, 6292.622442653455, 6234.625922444668, 6235.220597425322, 6240.438360547391, 6240.563160578716, 6254.437100660963, 6171.352008039091, 6251.0, 6263.4362907338555, 6306.180196574416, 6309.400606942333, 5990.3710110439515, 6069.362716914837, 6106.725197366218, 6106.938930610815, 6136.365905528456, 6211.09939058843, 6219.129321895029, 6221.9377806223165, 6224.1597384354345, 6229.2524897012645, 6029.3669164737075, 6034.456898879122, 6039.275286965592, 6042.939570604413, 6050.21347224858, 5867.970660146842, 5877.471027607536, 5888.852778680567, 5913.083472061838, 5987.31145918225, 5782.219400381063, 5813.476787089182, 5849.590528662953, 5867.0, 5891.970540147443, 5983.640981541122, 5984.371640977634, 6010.7295171716505, 6024.427679370453, 6044.032954727222, 5709.25779648643, 5787.681677507778, 5789.565782566408, 5808.361080281081, 5861.6189947653265], "value": 5605.555141152304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.2801419678826, 488.6164360976634, 493.95801356884664, 510.3951817096743, 515.8779654252004, 30392.848035759846, 32774.344513109754, 40864.795676021575, 40893.591064089385, 43411.34882976758, 37795.62204377962, 40359.19281614366, 42524.14951700964, 42900.57099429005, 42917.570824291746, 9424.811503769937, 9607.0, 9617.90382096177, 9625.759356016086, 9656.468894210815, 9550.665726699566, 9597.280203984694, 9605.423674579513, 9609.039096090404, 9625.085616866387, 9568.282378821581, 9580.700631848376, 9608.039196080372, 9619.951900240489, 9629.133377995979, 8308.916910830874, 9423.293253006052, 9529.428234305964, 9592.424454532751, 9600.567974441097, 9507.57215925285, 9540.713778586654, 9554.713358599252, 9556.331056826026, 9560.187384072362, 40019.399709004385, 40387.59612403897, 40458.595414045776, 40556.59443405558, 40569.797151014056, 3362.714169295613, 3382.543356646846, 3511.087117349482, 3565.286942611462, 3608.855645774166, 30665.540016899766, 30742.538861917088, 31995.040148795575, 32020.879269225697, 32453.837730811196, 3203.759718021158, 3223.9838800805846, 3255.4953982132806, 3348.5981682198294, 3367.848446819899, 478222.0, 486696.0, 486697.0, 487259.0, 487381.5630921858, 33442.83278583591, 61169.08246376308, 61655.0, 61706.69146654238, 61805.38194618086, 29241.707582924322, 33286.0, 34583.65416345804, 34612.48081278783, 34711.82644086763, 14685.926570367079, 14811.0, 14812.70374592502, 14822.92588537072, 14830.33263503145, 12503.374831258401, 12623.747525049448, 12630.747385052247, 12639.620811375673, 12657.367131643381, 7683.001209842796, 7711.151773304932, 7760.068791745027, 7771.922280777233, 7787.065552133667, 3148.307372378073, 3206.9198270043435, 3211.74306055515, 3215.1962009497624, 3237.449633562253, 925.8194652042787, 984.8276551603441, 995.2485873165714, 1053.657561292583, 1071.2180108520668, 29173.27066823304, 29491.018712473542, 29799.0, 29976.850115749283, 30155.396892062476, 1010.7422607235108, 1012.5747186181821, 1036.1762398892897, 1060.6340812419703, 1086.2830531848942, 14959.476418325306, 15460.613484662748, 15527.068375897483, 15577.065376077471, 15931.601709957344, 526312.0, 530412.0, 530584.0, 531745.0, 531847.0, 56845.0, 57271.713641431525, 57301.567460813814, 57504.849903001705, 57506.42493575095, 1243.154654834703, 1296.500847173845, 1370.4381203706432, 1396.6089494941432, 1416.7520683880487, 31498.055058348287, 31603.20991975219, 31829.681703182672, 31907.68092319047, 32203.642433455505, 50784.73038174075, 51596.48403515917, 51651.0, 51672.741636291576, 51775.74112129566, 507941.0, 508485.0, 509634.0, 511153.0, 512005.0, 23700.762992369855, 24243.272701818973, 26414.603780943686, 27219.04733334324, 27236.863815680794, 39547.0, 46936.0, 47389.052218956116, 47403.76298118625, 47792.0, 39255.6074439252, 39599.60400395959, 39629.60370396259, 40834.591654084266, 41390.793046034574, 38452.038699031626, 39817.80091099526, 39859.80070099631, 39982.0, 40366.0, 38221.80889095537, 38476.0, 39197.804010979766, 39340.81977540678, 39404.0, 33545.0, 34792.73730728493, 35513.467297990035, 37002.44496332611, 37464.438033428974, 25360.492790144464, 25546.361340965883, 25806.61290080688, 25926.22221333363, 26482.86758566195], "value": 18488.524269686837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.21202626379534, 374.9718771092168, 379.6545143919033, 391.6455607675052, 401.945737325461, 14157.789470150075, 15335.616609584766, 18935.905320473397, 20957.68563471547, 21137.26019589315, 19078.90460547699, 19855.602887942234, 20705.0, 20705.896470517626, 20847.687284690743, 5649.887002259952, 5960.701964901759, 5969.373215812342, 5970.223870896777, 5975.342712301644, 4172.102997855461, 4383.715058521202, 4397.956020439787, 5834.56240781941, 6180.443760061594, 6346.01636746305, 6498.837529061764, 6513.902291465632, 6519.8044058678315, 6536.869262614745, 5614.578906582023, 5904.350521442617, 5950.7917222896995, 6044.093385992092, 6045.093236014589, 5547.417521160301, 5725.856853578653, 5786.913196302059, 5817.912731309034, 5824.88350232993, 13252.734945301136, 13477.86522134776, 13480.123791953492, 13494.527691530848, 20789.0, 2156.040561949933, 2267.7732226777357, 2324.395657129142, 2429.514097180571, 2676.210517897225, 9753.951230243803, 9795.951020244853, 10171.796564068678, 10195.847062294071, 10289.0, 1834.0279651784576, 1843.787964384086, 1856.0193948065207, 1879.8872067675984, 1881.8964956927364, 111604.4419777904, 113563.0, 118661.0, 119142.40428797888, 120658.0, 11268.943655281671, 11329.60346387889, 11427.0, 11548.826767598493, 11641.825372619418, 14568.41726330956, 14575.927120364331, 14580.86511400054, 14602.853971460361, 14607.634809129644, 8434.704785332606, 8562.52906090171, 8592.65629374818, 8612.913870861337, 8680.609372578248, 7292.197858235696, 8469.449485783405, 8562.914370856337, 8572.742817715478, 8740.956295218482, 3679.633135680822, 4461.04087621163, 4468.530804265571, 4469.843555475542, 4551.180787458289, 1845.5386153461634, 1883.4161409962956, 1893.0629338477268, 1902.6099649571804, 1903.571696368306, 889.7997950461095, 900.4687234531658, 940.8729821474013, 973.2992245583168, 980.4705459052175, 16820.915895420443, 19370.261866855628, 19450.513737156685, 19857.106430210675, 21579.92100394974, 926.6200857648332, 937.0, 937.3953799799092, 943.8772959515219, 965.9661911833052, 10560.419176945188, 10977.451127443595, 11193.0, 11232.0, 11232.719182020515, 548686.0, 552422.0, 554037.0, 567506.0, 571979.0, 96881.51559242299, 119061.0, 127904.0, 128178.99999999814, 129808.0, 889.3729920406098, 921.2814005076051, 926.4117285523741, 952.0669743651122, 953.7424895278236, 18061.548461288574, 18596.907015464836, 18949.526261843563, 19012.14445349935, 19080.618387632447, 52331.21503177379, 53917.73041134769, 53975.19037214523, 54037.189442159186, 54578.72710636421, 77166.6141669288, 78137.60931195307, 78458.0, 79253.4149316999, 80176.1982380192, 5389.0, 6960.860782784214, 7667.3099421052375, 7694.115176754744, 7969.282764551218, 10739.946300268448, 12947.870521295043, 13153.699137478752, 13380.598582042554, 13437.529686460926, 11117.555297788322, 11501.137414693763, 11512.136589755635, 11710.94144529272, 11834.053275738093, 11132.276402033842, 11191.0, 11194.44027798623, 11738.0, 11890.881091188978, 11455.885441145816, 11584.942075289906, 11603.01374383153, 11796.88203117992, 11877.346745929057, 7269.673704414537, 7437.590932498764, 7465.29079737424, 7494.5128566643, 7661.62489628217, 9435.811283774148, 11358.0, 11462.770744585228, 11627.383838636239, 11641.708957276136], "value": 9303.868395651123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.9924100379496, 1544.7528395456725, 1752.2903224194197, 1883.3408307092511, 1926.056232446101, 8369.163083691636, 8880.156385143417, 8885.68900088497, 8886.377953543255, 8886.511241881703, 7791.298783109519, 8055.879161812578, 8066.3546916246705, 8398.874016889751, 8652.826943461127, 2345.8709770962632, 2379.547885901673, 2385.689860318156, 2387.880605969703, 2394.281715485356, 2326.6510023496526, 2350.8589484630975, 2362.9645555316683, 2374.1453076892303, 2396.880155992202, 2090.1430413530456, 2358.988205058972, 2385.8926348314367, 2393.461471168982, 2395.1736650855514, 2345.3667509772436, 2367.2779802160335, 2367.5146594948164, 2375.714914210306, 2376.251480783548, 1945.9416217513497, 2264.5810525052752, 2272.9659055114184, 2278.0773786616446, 2281.977180228193, 8612.224899759052, 8668.8699669505, 8725.38922275441, 8747.0, 8766.824663506693, 5174.146265866128, 5329.467053294678, 5345.3585569731495, 5347.973260133675, 5350.438203988564, 3424.2466657335594, 3508.105433114565, 3657.8902632921054, 3658.487811706363, 3665.3585622515952, 934.9158575728217, 1073.661796534097, 1075.5643964194514, 1079.1959989807565, 1094.43089593411, 11129.220954533186, 11258.04306633937, 11277.943610281978, 11278.379689117095, 11296.491657875415, 3810.7523011004196, 4532.660050496226, 4771.642126840501, 4784.64115191362, 4785.803549112722, 9699.030096990386, 9719.368241064309, 9720.513974301257, 9737.853932191023, 9742.75643108928, 5321.2018197269945, 5324.467553244722, 5325.387580428301, 5349.251104845324, 5355.277037599952, 4357.847475338412, 4358.106588149421, 4711.1519926413575, 4887.535684110004, 4901.877453063631, 3861.9034524137123, 3871.825767840454, 4010.5588385277597, 4013.4581831452965, 4027.899302517402, 1263.9873601264053, 1286.408252203978, 1287.497875828409, 1301.5965050834272, 1302.8501722301867, 879.520661239626, 902.9503377314311, 913.7761248494029, 946.4557879219476, 949.4350861237552, 5754.1944127822135, 5920.141579470953, 6039.486643635252, 6057.24672419304, 6289.465395441439, 770.6609091999502, 810.9635066422026, 922.5110691333604, 949.1694767078806, 965.5654955270156, 3811.294910441577, 3849.615038496128, 3909.4558540364014, 4051.0480037191237, 4085.632293093636, 8856.424332418372, 10617.840732388866, 10622.415767132727, 10623.628173013907, 10633.73415664599, 8976.730698079067, 10542.525586348633, 10550.683479495627, 10562.20783441245, 10623.946880265548, 8010.439269251096, 8146.429749917567, 8153.510789352539, 8159.0, 8180.672773089129, 5496.917546236729, 5736.512396446349, 5903.144044113666, 5907.645541267538, 5926.911096333644, 9859.260555458513, 9874.456904870302, 9941.155001824925, 9970.152537034433, 9979.950100249453, 9432.95283523578, 9772.657956971472, 9803.354828421481, 9963.950180249052, 10044.849327259952, 6888.690008949709, 7152.0, 7342.77971660851, 7459.515131516434, 7543.132539757778, 7871.33093687043, 7923.484973476706, 7935.722249721232, 7964.163762805054, 8154.266116049347, 7299.087614048244, 7471.514351567348, 7474.92525074764, 7557.470977031555, 7623.0, 7066.752663656747, 7264.636768161465, 7348.70605175787, 7395.667194976131, 7448.031755871702, 6843.178818541807, 6868.416184624363, 6967.477439192182, 6972.44220462372, 6998.335158159966, 4960.280759289955, 4991.326170967018, 5009.749512524432, 5034.370703662043, 5112.0, 4916.360873086476, 4919.901601968012, 4959.330490383752, 5002.924956125734, 5139.383274007143], "value": 4546.260207044847, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.9366539361341, 295.6998646373931, 304.4018503640346, 309.9566060751495, 313.53596676918147, 4464.598186163249, 5047.77285022174, 5286.65636733613, 5362.731863406829, 5423.972880135599, 3772.4341348797693, 4630.768461576925, 4642.419697537808, 5106.719130447824, 5294.682319060849, 4088.1414902870433, 4092.1611069730634, 4102.5179766241445, 4106.753594784323, 4111.691623128262, 4116.423700681907, 4130.607592278729, 4156.251874662559, 4158.6673066154635, 4167.270727622669, 3686.7234957378305, 3821.388577827548, 3928.2143571285715, 3990.501187351581, 4104.40486129511, 4054.635082842529, 4071.9389209161886, 4104.158647477275, 4111.280525907954, 4147.258151576315, 3540.345036168317, 3558.7864728116397, 3566.625504322061, 3581.8209089545417, 3602.3155600435834, 4544.590986811169, 4729.013814198045, 5202.401723801773, 5241.588869120209, 5253.921191182136, 4528.8641340759505, 4540.6594505411895, 4569.2003899317815, 4571.0, 4576.359309696645, 4389.978050109761, 5055.761338472098, 5673.347565030033, 5677.545796336283, 5679.744411501492, 3672.632736726306, 3708.4437334400054, 3819.7899115548635, 3833.9808300958593, 3838.654521093115, 5533.833984980457, 5543.695096769717, 5772.278465191851, 5775.826725198251, 5929.703514824241, 3722.1439069014277, 3738.9626103738615, 3836.7889766062576, 3858.6720128788807, 3864.516935383077, 3564.9643503565153, 3714.461403096536, 3927.410888366711, 3930.272899513599, 3939.7045221608496, 3996.300647386696, 4542.88642783933, 4567.314902764612, 4596.598037598497, 4599.379083823708, 4815.807367705253, 4875.854174269044, 5342.786288548492, 5563.471470210324, 5619.915701264485, 1300.3888172558882, 1328.973420531584, 1330.760463116629, 1334.7197088611501, 1340.169095160987, 725.8040329111216, 726.0778810910115, 800.771780042685, 814.4217605500161, 820.335528222142, 4350.58669426404, 4430.712003719748, 4455.1312494064, 4490.483594386622, 4495.775211239425, 4320.589543993316, 4790.826247569368, 4792.976035119872, 4819.0, 4823.348847905558, 3814.9809250953567, 4378.489421149762, 4378.868633940987, 4446.177457170434, 4484.5873549831695, 2133.605283022646, 2168.7722789107233, 2244.696965909581, 2394.4133687246735, 2511.8696586535766, 4001.8199181036925, 4846.030793841246, 4945.3571035765835, 4953.984433191187, 4990.426100998359, 4085.4688890444054, 4169.437125988014, 4245.5542168072525, 4309.612134907873, 4698.624110071186, 4477.19410506112, 4798.760061996886, 4951.331570237971, 5016.949830501649, 5027.8827127181385, 4040.3535434330365, 4770.594499467584, 4804.35141255926, 4805.37530121082, 4830.975845120752, 3866.1465244589576, 4036.5357983832237, 4345.435093437833, 4670.789814458425, 4787.353707249476, 4046.8785936421955, 4959.776810043629, 5684.3231246783125, 5954.940450595612, 6142.682951206477, 3459.965400346065, 3855.710821688441, 3898.3372826618975, 3898.9667738050007, 3918.333883239799, 5258.8159414420315, 5863.618864773776, 5898.675572843535, 5922.032238400196, 5945.91081133792, 4814.855554333376, 4911.58251548608, 5428.592855535771, 5646.85882852932, 5646.9152962704775, 5672.269957662952, 5692.31692196939, 5693.629914055573, 5696.8006119785605, 5718.542516598745, 4746.525347465225, 5381.67709937405, 5576.208178438538, 5616.522595579421, 5633.774649013993, 5568.888622227614, 5597.608167428241, 5605.439456054362, 5620.325560932714, 5672.057919745902, 4664.766761661971, 4927.18701414277, 5487.314085739283, 5544.69504177258, 5579.8884022320135], "value": 3874.201024269627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2452537098733, 757.7158565537924, 791.8337149198668, 794.789380814084, 844.1853611265129, 15186.468473603427, 15996.920015399906, 15999.92000040001, 16006.35974561019, 16051.277692503836, 14154.50459233927, 14214.218217998006, 14544.345504452298, 14623.78064329036, 14697.485588004422, 696.9059177011114, 720.906282183318, 872.1017352127319, 896.3635818568824, 900.9504477253748, 719.2376081353756, 875.2910142784365, 895.9731208063736, 896.6413434626137, 911.0479548871446, 967.032967032967, 967.0377973915963, 970.4419958523841, 970.5632465390568, 973.352720440906, 956.7464621875208, 957.004715096299, 957.1385752822446, 957.6408846682494, 959.0170075672422, 542.7394850471757, 562.3252097483037, 670.8490589617297, 692.6605963078106, 693.5110746923407, 15260.160691161982, 15319.31063102163, 15369.154696491689, 15370.538883833502, 15374.077555346716, 13655.795163072562, 14161.645958851008, 14292.071015383966, 14295.0, 14300.0, 12694.555690550878, 12719.554815581503, 12734.363281835964, 12893.0, 12902.741945161139, 4510.120526497334, 4544.613707834838, 4641.907161856744, 4750.192467280571, 4762.857114286542, 106270.46864765626, 107173.46413267961, 107393.0, 108450.0, 119255.4037229817, 9881.604735810488, 11268.887311126948, 11431.942840285745, 11509.136814738928, 11611.767764644828, 20325.898370508054, 21217.62085464471, 22570.435739106655, 22572.66141007886, 22600.66099008516, 7791.688332466638, 8178.427510074238, 8184.754457366289, 8190.8771368429525, 8192.877106843402, 4295.978520107379, 4411.20598292304, 4529.569690879362, 4594.448666160082, 4604.332371806069, 3462.9307413852084, 3572.91067723309, 3576.588692300367, 3578.7673801202836, 3585.4263317869018, 641.425923798198, 646.2309851276965, 658.1148355461896, 666.0907860770014, 673.2089794491453, 540.7215284128677, 592.8666050138685, 606.9696515174223, 633.6134957675814, 654.6334052930374, 8603.741887743377, 8897.154770296811, 8970.506622135845, 8978.024834536522, 9108.271338292921, 539.2692901119005, 541.8401571536406, 554.8058179637095, 596.0879853823657, 627.3475585391142, 3616.5660120785674, 3936.7441116327345, 4253.170631726845, 4420.403245561808, 4439.467263928284, 156461.2176939108, 158972.0, 160159.3984060168, 161317.0, 167007.16496417683, 123593.0, 130971.34514327368, 133437.0, 139192.30403848118, 144407.0, 114664.0, 115490.0, 117684.64630707509, 117839.0, 119839.80160198461, 8269.503829770232, 8503.829923401621, 8538.895646798393, 8604.569771511524, 8844.557772111497, 56196.0, 58800.70599646975, 59719.50701232504, 61317.70776045634, 64063.679681601294, 93439.53280233555, 101200.49399752954, 101201.48197776893, 102133.0, 104924.95122824947, 11514.37297251363, 11686.766264674829, 11818.527258909548, 12076.637700868989, 12290.815637765261, 12113.939430302793, 12198.75602487963, 12234.327112008925, 12460.813087803508, 12919.806202906775, 11548.884511154782, 11653.184277100521, 11873.0, 11962.222455540363, 11968.46141923598, 11620.186586938833, 11976.401179940794, 12102.152849300464, 12148.388096559282, 12364.56724014655, 10500.369977801356, 10512.789744205225, 10783.784324313627, 10968.287061341307, 11023.83464248021, 9616.423014618866, 9633.470159141314, 9634.067838573905, 9636.180924621205, 9883.604655813688, 9217.216536594464, 9583.616655333708, 9700.0, 9747.0, 9760.85358719634], "value": 7683.810542301374, "unit": "score"}], "name": "dromaeo_css", "value": 7122.086412566584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 111.0, 112.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 112.0, 112.0, 150.0, 113.0, 114.0, 114.0, 114.0, 144.0, 111.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 186.0, 185.0, 186.0, 179.0, 189.0, 187.0, 188.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 90.0, 62.0, 60.0, 74.0, 83.0, 100.0, 58.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 91.0, 69.0, 70.0, 68.0, 93.0, 68.0, 69.0, 91.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 88.0, 86.0, 91.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 97.0, 97.0, 97.0, 98.0, 98.0, 99.0, 98.0, 96.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 80.0, 82.0, 84.0, 85.0, 84.0, 83.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 55.0, 56.0, 54.0, 54.0, 56.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 75.0, 72.0, 69.0, 69.0, 70.0, 69.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 88.0, 91.0, 86.0, 88.0, 86.0, 88.0, 96.0, 99.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 157.0, 148.0, 147.0, 146.0, 144.0, 149.0, 144.0, 197.0, 136.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 177.0, 173.0, 173.0, 172.0, 171.0, 172.0, 173.0, 173.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1447.7, "alertThreshold": 2.0}]} 05:49:06 INFO - Return code: 0 05:49:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:49:06 INFO - # TBPL SUCCESS # 05:49:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:49:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:49:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:49:07 INFO - 2016-10-15 05:49:07.008 screenresolution[1675:12482] starting screenresolution argv=screenresolution get 05:49:07 INFO - 2016-10-15 05:49:07.010 screenresolution[1675:12482] Display 0: 1600x1200x32@60 05:49:07 INFO - 2016-10-15 05:49:07.016 screenresolution[1676:12485] starting screenresolution argv=screenresolution list 05:49:07 INFO - Available Modes on Display 0 05:49:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:49:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:49:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:49:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:49:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:49:07 INFO - Intel Iris: 05:49:07 INFO - Chipset Model: Intel Iris 05:49:07 INFO - Type: GPU 05:49:07 INFO - Bus: Built-In 05:49:07 INFO - VRAM (Dynamic, Max): 1536 MB 05:49:07 INFO - Vendor: Intel (0x8086) 05:49:07 INFO - Device ID: 0x0a2e 05:49:07 INFO - Revision ID: 0x0009 05:49:07 INFO - Displays: 05:49:07 INFO - Display: 05:49:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:49:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:49:07 INFO - Display Serial Number: 1600x1200 60 05:49:07 INFO - Main Display: Yes 05:49:07 INFO - Mirror: Off 05:49:07 INFO - Online: Yes 05:49:07 INFO - Rotation: Supported 05:49:07 INFO - Return code: 0 05:49:07 INFO - Running post-action listener: _resource_record_post_action 05:49:07 INFO - [mozharness: 2016-10-15 12:49:07.253748Z] Finished run-tests step (success) 05:49:07 INFO - Running post-run listener: _resource_record_post_run 05:49:07 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 33184768; Write bytes: 711366144; Read time: 308; Write time: 2025 05:49:07 INFO - TinderboxPrint: CPU usage
53.6% 05:49:07 INFO - TinderboxPrint: I/O read bytes / time
33,184,768 / 308 05:49:07 INFO - TinderboxPrint: I/O write bytes / time
711,366,144 / 2,025 05:49:07 INFO - TinderboxPrint: CPU idle
2,258.3 (46.4%) 05:49:07 INFO - TinderboxPrint: CPU system
969.6 (19.9%) 05:49:07 INFO - TinderboxPrint: CPU user
1,637.9 (33.7%) 05:49:07 INFO - TinderboxPrint: Swap in / out
437,174,272 / 0 05:49:07 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 409162240; Write bytes: 411441152; Read time: 31047; Write time: 823 05:49:07 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29215744; Write bytes: 298475008; Read time: 280; Write time: 1195 05:49:07 INFO - Running post-run listener: _upload_blobber_files 05:49:07 INFO - Blob upload gear active. 05:49:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:07 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 05:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:49:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:08 INFO - (blobuploader) - INFO - Done attempting. 05:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:09 INFO - (blobuploader) - INFO - Done attempting. 05:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:49:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:12 INFO - (blobuploader) - INFO - Done attempting. 05:49:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:12 INFO - Return code: 0 05:49:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e982ab467b613831b476d152c3d5020342a85a0df8879aa8bd12cdd2a69302c1a7c9af7f8d7f3c7dd01c4b7436648ecb1d44ac57c295d6c74447507e4d4d4218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ac6304a89959fa9e60646993ae03275d5a1a9e72ae65e6cccc61069ef6ab418344bd0d212c3716525ef96f39f97739c9e63b1be020fe9a3e115bf5205c708c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abde59f3bd0a733d4dded49268fe6766eafae1a30c14e232481bdfbdc1df66cefd1445cf3d585cbc144fd850d16e57d5f1b556c088e6d25cbf5a4d694e0c1375"} 05:49:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:12 INFO - Contents: 05:49:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e982ab467b613831b476d152c3d5020342a85a0df8879aa8bd12cdd2a69302c1a7c9af7f8d7f3c7dd01c4b7436648ecb1d44ac57c295d6c74447507e4d4d4218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ac6304a89959fa9e60646993ae03275d5a1a9e72ae65e6cccc61069ef6ab418344bd0d212c3716525ef96f39f97739c9e63b1be020fe9a3e115bf5205c708c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abde59f3bd0a733d4dded49268fe6766eafae1a30c14e232481bdfbdc1df66cefd1445cf3d585cbc144fd850d16e57d5f1b556c088e6d25cbf5a4d694e0c1375"} 05:49:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:12 INFO - Copying logs to upload dir... 05:49:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.193959 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-15 05:49:13.031798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 05:49:13.035267) ========= 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.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Firefox/sha512/e982ab467b613831b476d152c3d5020342a85a0df8879aa8bd12cdd2a69302c1a7c9af7f8d7f3c7dd01c4b7436648ecb1d44ac57c295d6c74447507e4d4d4218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ac6304a89959fa9e60646993ae03275d5a1a9e72ae65e6cccc61069ef6ab418344bd0d212c3716525ef96f39f97739c9e63b1be020fe9a3e115bf5205c708c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abde59f3bd0a733d4dded49268fe6766eafae1a30c14e232481bdfbdc1df66cefd1445cf3d585cbc144fd850d16e57d5f1b556c088e6d25cbf5a4d694e0c1375"} build_url:https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/DTEIrgJbSYiquyn8yq-RFg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e982ab467b613831b476d152c3d5020342a85a0df8879aa8bd12cdd2a69302c1a7c9af7f8d7f3c7dd01c4b7436648ecb1d44ac57c295d6c74447507e4d4d4218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ac6304a89959fa9e60646993ae03275d5a1a9e72ae65e6cccc61069ef6ab418344bd0d212c3716525ef96f39f97739c9e63b1be020fe9a3e115bf5205c708c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abde59f3bd0a733d4dded49268fe6766eafae1a30c14e232481bdfbdc1df66cefd1445cf3d585cbc144fd850d16e57d5f1b556c088e6d25cbf5a4d694e0c1375"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 05:49:13.067525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:49:13.067856) ========= 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.LtIbvRD4Si/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.tBpi8uW89J/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005130 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 05:49:13.116685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 05:49:13.117010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 05:49:13.117305) ========= ========= Total master_lag: 0.20 =========