builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0291 starttime: 1479134830.39 results: success (0) buildid: 20161114042943 builduid: 8015f0299ff34759a2df148e66135704 revision: a516c754042c438a5c1499171ca525a980ecb911 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.390182) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.390606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.390873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.414820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.415167) ========= 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.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-11-14 06:47:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-11-14 06:47:10 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.560769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.561108) ========= 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.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.019220 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:10.609801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:47:10.610175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a516c754042c438a5c1499171ca525a980ecb911 --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 a516c754042c438a5c1499171ca525a980ecb911 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-11-14 06:47:10,695 truncating revision to first 12 chars 2016-11-14 06:47:10,695 Setting DEBUG logging. 2016-11-14 06:47:10,695 attempt 1/10 2016-11-14 06:47:10,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a516c754042c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 06:47:11,442 unpacking tar archive at: mozilla-central-a516c754042c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.006364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:47:11.638676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:11.639011) ========= script_repo_revision: a516c754042c438a5c1499171ca525a980ecb911 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:11.639389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:11.639651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:47:11.657850) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 06:47:11.658253) ========= /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.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:11 INFO - MultiFileLogger online at 20161114 06:47:11 in /builds/slave/test 06:47:11 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 06:47:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:11 INFO - {'append_to_log': False, 06:47:11 INFO - 'base_work_dir': '/builds/slave/test', 06:47:11 INFO - 'blob_upload_branch': 'Firefox', 06:47:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:11 INFO - 'branch': 'Firefox', 06:47:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:11 INFO - 'config_files': ('talos/mac_config.py',), 06:47:11 INFO - 'default_actions': ('clobber', 06:47:11 INFO - 'read-buildbot-config', 06:47:11 INFO - 'download-and-extract', 06:47:11 INFO - 'populate-webroot', 06:47:11 INFO - 'create-virtualenv', 06:47:11 INFO - 'install', 06:47:11 INFO - 'run-tests'), 06:47:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:11 INFO - 'download_minidump_stackwalk': True, 06:47:11 INFO - 'download_symbols': 'ondemand', 06:47:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:11 INFO - 'installer_path': 'installer.exe', 06:47:11 INFO - 'log_level': 'info', 06:47:11 INFO - 'log_name': 'talos', 06:47:11 INFO - 'log_to_console': True, 06:47:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:47:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:47:11 INFO - 'opt_config_files': (), 06:47:11 INFO - 'pip_index': False, 06:47:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:47:11 INFO - 'cmd': ('bash', 06:47:11 INFO - '-c', 06:47:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:47:11 INFO - 'enabled': True, 06:47:11 INFO - 'halt_on_failure': False, 06:47:11 INFO - 'name': 'check_screen_resolution'},), 06:47:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:47:11 INFO - 'cmd': ('bash', 06:47:11 INFO - '-c', 06:47:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:47:11 INFO - 'enabled': True, 06:47:11 INFO - 'halt_on_failure': False, 06:47:11 INFO - 'name': 'check_screen_resolution'},), 06:47:11 INFO - 'run_cmd_checks_enabled': True, 06:47:11 INFO - 'sps_profile': False, 06:47:11 INFO - 'sps_profile_interval': 0, 06:47:11 INFO - 'suite': 'dromaeojs', 06:47:11 INFO - 'system_bits': '32', 06:47:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:11 INFO - 'title': 't-yosemite-r7-0291', 06:47:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:11 INFO - 'use_talos_json': True, 06:47:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:11 INFO - 'work_dir': 'build'} 06:47:11 INFO - [mozharness: 2016-11-14 14:47:11.865749Z] Running clobber step. 06:47:11 INFO - Running pre-action listener: _resource_record_pre_action 06:47:11 INFO - Running main action method: clobber 06:47:11 INFO - rmtree: /builds/slave/test/build 06:47:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:12 INFO - Running post-action listener: _resource_record_post_action 06:47:12 INFO - [mozharness: 2016-11-14 14:47:12.471446Z] Finished clobber step (success) 06:47:12 INFO - [mozharness: 2016-11-14 14:47:12.471617Z] Running read-buildbot-config step. 06:47:12 INFO - Running pre-action listener: _resource_record_pre_action 06:47:12 INFO - Running main action method: read_buildbot_config 06:47:12 INFO - Using buildbot properties: 06:47:12 INFO - { 06:47:12 INFO - "project": "", 06:47:12 INFO - "product": "firefox", 06:47:12 INFO - "script_repo_revision": "production", 06:47:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:47:12 INFO - "repository": "", 06:47:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:47:12 INFO - "buildid": "20161114042943", 06:47:12 INFO - "pgo_build": "False", 06:47:12 INFO - "basedir": "/builds/slave/test", 06:47:12 INFO - "buildnumber": 10, 06:47:12 INFO - "slavename": "t-yosemite-r7-0291", 06:47:12 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:47:12 INFO - "platform": "yosemite_r7", 06:47:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:47:12 INFO - "branch": "mozilla-central", 06:47:12 INFO - "repo_path": "mozilla-central", 06:47:12 INFO - "revision": "a516c754042c438a5c1499171ca525a980ecb911", 06:47:12 INFO - "stage_platform": "macosx64", 06:47:12 INFO - "builduid": "8015f0299ff34759a2df148e66135704", 06:47:12 INFO - "slavebuilddir": "test" 06:47:12 INFO - } 06:47:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:47:12 INFO - Running post-action listener: _resource_record_post_action 06:47:12 INFO - [mozharness: 2016-11-14 14:47:12.474768Z] Finished read-buildbot-config step (success) 06:47:12 INFO - [mozharness: 2016-11-14 14:47:12.474894Z] Running download-and-extract step. 06:47:12 INFO - Running pre-action listener: _resource_record_pre_action 06:47:12 INFO - Running main action method: download_and_extract 06:47:12 INFO - mkdir: /builds/slave/test/build/tests 06:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:12 INFO - trying https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:47:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 06:47:13 INFO - Downloaded 1199 bytes. 06:47:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:47:13 INFO - Using the following test package requirements: 06:47:13 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:47:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:47:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:47:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'jsshell-mac.zip'], 06:47:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:47:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:47:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:47:13 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:47:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:47:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:47:13 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:47:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:47:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:47:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:47:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:47:14 INFO - Http code: 200 06:47:14 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 06:47:14 INFO - x-amz-cf-id: LSBvj0TrRSitZkCSaGdDwlW6lRgxf7TdKi9Pdwh6pcX8gYUIfuQFZA== 06:47:14 INFO - x-amz-version-id: SAFS8jL729wvM2O6zIz7nzGxgDj8g4AT 06:47:15 INFO - Expected file size: 16328825 06:47:15 INFO - Obtained file size: 16328825 06:47:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:47:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:47:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:47:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:47:22 INFO - Http code: 200 06:47:22 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 06:47:22 INFO - x-amz-cf-id: Cz92gL2bp6ThsDRG4KRzkeun-3OXX4EUIX6xWEXpEhIg1px4n_urRA== 06:47:22 INFO - x-amz-version-id: SAFS8jL729wvM2O6zIz7nzGxgDj8g4AT 06:47:22 INFO - Expected file size: 16328825 06:47:22 INFO - Obtained file size: 16328825 06:47:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:47:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:47:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:47:30 INFO - Http code: 200 06:47:30 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 06:47:30 INFO - x-amz-cf-id: fy2fo4rFUMEY2wcsjcSgWCjR6QEQM3_OG_hqpXseQpfsiosjHKt12A== 06:47:30 INFO - x-amz-version-id: BYR5dw0BTrxhQUeYkvnQ2QdleIBGUopv 06:47:31 INFO - Expected file size: 14409038 06:47:31 INFO - Obtained file size: 14409038 06:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:31 INFO - trying https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:47:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 06:47:35 INFO - Downloaded 110959153 bytes. 06:47:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:47:35 INFO - mkdir: /builds/slave/test/properties 06:47:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:35 INFO - Contents: 06:47:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:47:35 INFO - Running post-action listener: _resource_record_post_action 06:47:35 INFO - Running post-action listener: set_extra_try_arguments 06:47:35 INFO - [mozharness: 2016-11-14 14:47:35.985986Z] Finished download-and-extract step (success) 06:47:35 INFO - [mozharness: 2016-11-14 14:47:35.986104Z] Running populate-webroot step. 06:47:35 INFO - Running pre-action listener: _resource_record_pre_action 06:47:35 INFO - Running main action method: populate_webroot 06:47:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:35 INFO - '--tppagecycles', 06:47:35 INFO - '7'], 06:47:35 INFO - 'tests': ['tsvgm']}}, 06:47:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:35 INFO - 'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:35 INFO - 'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['damp', 'tps']}, 06:47:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:35 INFO - 'tests': ['damp', 'tps']}, 06:47:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['dromaeo_dom']}, 06:47:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['basic_compositor_video']}, 06:47:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:47:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:35 INFO - 'tests': ['a11yr', 06:47:35 INFO - 'ts_paint', 06:47:35 INFO - 'tpaint', 06:47:35 INFO - 'sessionrestore', 06:47:35 INFO - 'sessionrestore_no_auto_restore', 06:47:35 INFO - 'tabpaint']}, 06:47:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:35 INFO - 'ts_paint', 06:47:35 INFO - 'tpaint', 06:47:35 INFO - 'sessionrestore', 06:47:35 INFO - 'sessionrestore_no_auto_restore', 06:47:35 INFO - 'tabpaint']}, 06:47:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:35 INFO - 'ts_paint', 06:47:35 INFO - 'tpaint', 06:47:35 INFO - 'sessionrestore', 06:47:35 INFO - 'sessionrestore_no_auto_restore', 06:47:35 INFO - 'tabpaint']}, 06:47:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:36 INFO - 'ts_paint', 06:47:36 INFO - 'tpaint', 06:47:36 INFO - 'sessionrestore', 06:47:36 INFO - 'sessionrestore_no_auto_restore', 06:47:36 INFO - 'tabpaint']}, 06:47:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:36 INFO - 'tests': ['a11yr', 06:47:36 INFO - 'ts_paint', 06:47:36 INFO - 'tpaint', 06:47:36 INFO - 'sessionrestore', 06:47:36 INFO - 'sessionrestore_no_auto_restore', 06:47:36 INFO - 'tabpaint']}, 06:47:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:36 INFO - 'tests': ['a11yr', 06:47:36 INFO - 'ts_paint', 06:47:36 INFO - 'tpaint', 06:47:36 INFO - 'sessionrestore', 06:47:36 INFO - 'sessionrestore_no_auto_restore', 06:47:36 INFO - 'tabpaint']}, 06:47:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:36 INFO - 'tests': ['tsvgx', 06:47:36 INFO - 'tsvgr_opacity', 06:47:36 INFO - 'tart', 06:47:36 INFO - 'tscrollx', 06:47:36 INFO - 'cart']}, 06:47:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:36 INFO - 'tsvgr_opacity', 06:47:36 INFO - 'tart', 06:47:36 INFO - 'tscrollx', 06:47:36 INFO - 'cart']}, 06:47:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:36 INFO - 'talos_options': ['--disable-e10s'], 06:47:36 INFO - 'tests': ['tp5o']}, 06:47:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:36 INFO - 'tests': ['tp5o']}, 06:47:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:36 INFO - 'talos_options': ['--disable-e10s', 06:47:36 INFO - '--xperf_path', 06:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:36 INFO - 'tests': ['tp5n']}, 06:47:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:36 INFO - 'talos_options': ['--xperf_path', 06:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:36 INFO - 'tests': ['tp5n']}}, 06:47:36 INFO - 'talos.zip': {'path': '', 06:47:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:36 INFO - Running post-action listener: _resource_record_post_action 06:47:36 INFO - [mozharness: 2016-11-14 14:47:36.004955Z] Finished populate-webroot step (success) 06:47:36 INFO - [mozharness: 2016-11-14 14:47:36.005077Z] Running create-virtualenv step. 06:47:36 INFO - Running pre-action listener: _resource_record_pre_action 06:47:36 INFO - Running main action method: create_virtualenv 06:47:36 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:36 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 06:47:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:36 INFO - Using real prefix '/tools/python27' 06:47:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:39 INFO - Installing pip.................done. 06:47:39 INFO - Return code: 0 06:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:47:39 INFO - Reading from file tmpfile_stdout 06:47:39 INFO - Output received: 06:47:39 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) 06:47:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47: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')]} 06:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47: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')]} 06:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:39 INFO - 'HOME': '/Users/cltbld', 06:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:39 INFO - 'LOGNAME': 'cltbld', 06:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:39 INFO - 'MOZ_NO_REMOTE': '1', 06:47:39 INFO - 'NO_EM_RESTART': '1', 06:47:39 INFO - 'PAGER': '/bin/cat', 06:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:39 INFO - 'PWD': '/builds/slave/test', 06:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:39 INFO - 'SHELL': '/bin/bash', 06:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:39 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:39 INFO - 'USER': 'cltbld', 06:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:39 INFO - 'XPC_FLAGS': '0x0', 06:47:39 INFO - 'XPC_SERVICE_NAME': '0', 06:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:40 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 06:47:40 INFO - Cleaning up... 06:47:40 INFO - Return code: 0 06:47:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:47:40 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')]} 06:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:40 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')]} 06:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:40 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:40 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 06:47:40 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 06:47:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:40 INFO - 'HOME': '/Users/cltbld', 06:47:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:40 INFO - 'LOGNAME': 'cltbld', 06:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:40 INFO - 'MOZ_NO_REMOTE': '1', 06:47:40 INFO - 'NO_EM_RESTART': '1', 06:47:40 INFO - 'PAGER': '/bin/cat', 06:47:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:40 INFO - 'PWD': '/builds/slave/test', 06:47:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:40 INFO - 'SHELL': '/bin/bash', 06:47:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:40 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:40 INFO - 'USER': 'cltbld', 06:47:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:40 INFO - 'XPC_FLAGS': '0x0', 06:47:40 INFO - 'XPC_SERVICE_NAME': '0', 06:47:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:40 INFO - Downloading/unpacking psutil>=3.1.1 06:47:40 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 06:47:40 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 06:47:40 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 06:47:40 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 06:47:40 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 06:47:40 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 06:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:44 INFO - Installing collected packages: psutil 06:47:44 INFO - Running setup.py install for psutil 06:47:44 INFO - building 'psutil._psutil_osx' extension 06:47:44 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 06:47:44 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 06:47:44 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 06:47:44 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 06:47:44 INFO - building 'psutil._psutil_posix' extension 06:47:44 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 06:47:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:47:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:47:44 INFO - ^ 06:47:44 INFO - 1 warning generated. 06:47:44 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 06:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:45 INFO - Successfully installed psutil 06:47:45 INFO - Cleaning up... 06:47:45 INFO - Return code: 0 06:47:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:45 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 06:47:45 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 06:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:45 INFO - 'HOME': '/Users/cltbld', 06:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:45 INFO - 'LOGNAME': 'cltbld', 06:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:45 INFO - 'MOZ_NO_REMOTE': '1', 06:47:45 INFO - 'NO_EM_RESTART': '1', 06:47:45 INFO - 'PAGER': '/bin/cat', 06:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:45 INFO - 'PWD': '/builds/slave/test', 06:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:45 INFO - 'SHELL': '/bin/bash', 06:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:45 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:45 INFO - 'USER': 'cltbld', 06:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:45 INFO - 'XPC_FLAGS': '0x0', 06:47:45 INFO - 'XPC_SERVICE_NAME': '0', 06:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:47:48 INFO - Installing collected packages: mozsystemmonitor 06:47:48 INFO - Running setup.py install for mozsystemmonitor 06:47:48 INFO - Successfully installed mozsystemmonitor 06:47:48 INFO - Cleaning up... 06:47:48 INFO - Return code: 0 06:47:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:48 INFO - 'HOME': '/Users/cltbld', 06:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:48 INFO - 'LOGNAME': 'cltbld', 06:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:48 INFO - 'MOZ_NO_REMOTE': '1', 06:47:48 INFO - 'NO_EM_RESTART': '1', 06:47:48 INFO - 'PAGER': '/bin/cat', 06:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:48 INFO - 'PWD': '/builds/slave/test', 06:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:48 INFO - 'SHELL': '/bin/bash', 06:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:48 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:48 INFO - 'USER': 'cltbld', 06:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:48 INFO - 'XPC_FLAGS': '0x0', 06:47:48 INFO - 'XPC_SERVICE_NAME': '0', 06:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:48 INFO - Downloading/unpacking jsonschema==2.5.1 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:47:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:47:51 INFO - warning: no files found matching '*.txt' 06:47:51 INFO - no previously-included directories found matching 'build' 06:47:51 INFO - no previously-included directories found matching 'dist' 06:47:51 INFO - no previously-included directories found matching '.git*' 06:47:51 INFO - Installing collected packages: jsonschema, functools32 06:47:51 INFO - Running setup.py install for functools32 06:47:51 INFO - warning: no files found matching '*.txt' 06:47:51 INFO - no previously-included directories found matching 'build' 06:47:51 INFO - no previously-included directories found matching 'dist' 06:47:51 INFO - no previously-included directories found matching '.git*' 06:47:51 INFO - Successfully installed jsonschema functools32 06:47:51 INFO - Cleaning up... 06:47:51 INFO - Return code: 0 06:47:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:47:51 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')]} 06:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:51 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')]} 06:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:51 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:51 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 06:47:51 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 06:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:51 INFO - 'HOME': '/Users/cltbld', 06:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:51 INFO - 'LOGNAME': 'cltbld', 06:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:51 INFO - 'MOZ_NO_REMOTE': '1', 06:47:51 INFO - 'NO_EM_RESTART': '1', 06:47:51 INFO - 'PAGER': '/bin/cat', 06:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:51 INFO - 'PWD': '/builds/slave/test', 06:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:51 INFO - 'SHELL': '/bin/bash', 06:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:51 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:51 INFO - 'USER': 'cltbld', 06:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:51 INFO - 'XPC_FLAGS': '0x0', 06:47:51 INFO - 'XPC_SERVICE_NAME': '0', 06:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:47:52 INFO - Cleaning up... 06:47:52 INFO - Return code: 0 06:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:47:52 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')]} 06:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:52 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')]} 06:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:52 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:52 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 06:47:52 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 06:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:52 INFO - 'HOME': '/Users/cltbld', 06:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:52 INFO - 'LOGNAME': 'cltbld', 06:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:52 INFO - 'MOZ_NO_REMOTE': '1', 06:47:52 INFO - 'NO_EM_RESTART': '1', 06:47:52 INFO - 'PAGER': '/bin/cat', 06:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:52 INFO - 'PWD': '/builds/slave/test', 06:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:52 INFO - 'SHELL': '/bin/bash', 06:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:52 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:52 INFO - 'USER': 'cltbld', 06:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:52 INFO - 'XPC_FLAGS': '0x0', 06:47:52 INFO - 'XPC_SERVICE_NAME': '0', 06:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:47:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:56 INFO - Downloading docopt-0.6.1.tar.gz 06:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:56 INFO - Running setup.py install for blobuploader 06:47:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:47:56 INFO - Running setup.py install for requests 06:47:56 INFO - Running setup.py install for docopt 06:47:57 INFO - Successfully installed blobuploader requests docopt 06:47:57 INFO - Cleaning up... 06:47:57 INFO - Return code: 0 06:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47: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')]} 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47: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')]} 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:47:57 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 06:47:57 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 06:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:57 INFO - 'HOME': '/Users/cltbld', 06:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:57 INFO - 'LOGNAME': 'cltbld', 06:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:57 INFO - 'MOZ_NO_REMOTE': '1', 06:47:57 INFO - 'NO_EM_RESTART': '1', 06:47:57 INFO - 'PAGER': '/bin/cat', 06:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:57 INFO - 'PWD': '/builds/slave/test', 06:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:57 INFO - 'SHELL': '/bin/bash', 06:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:47:57 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:57 INFO - 'USER': 'cltbld', 06:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:57 INFO - 'XPC_FLAGS': '0x0', 06:47:57 INFO - 'XPC_SERVICE_NAME': '0', 06:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-2u79Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-PHFulB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-BhXA44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-O5qZYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:57 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-E8fYCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-vhJtkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Bubb_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-yKQrZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-peGFbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-iyr33G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-HOsBlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Ggwe1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-qU3vx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-SuJBTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-KWWXvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-MaykVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-LrAuvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:59 INFO - Running setup.py install for manifestparser 06:47:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:47:59 INFO - Running setup.py install for mozcrash 06:47:59 INFO - Running setup.py install for mozdebug 06:47:59 INFO - Running setup.py install for mozdevice 06:47:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:47:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:47:59 INFO - Running setup.py install for mozfile 06:48:00 INFO - Running setup.py install for mozhttpd 06:48:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Running setup.py install for mozinfo 06:48:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Running setup.py install for mozInstall 06:48:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Running setup.py install for mozleak 06:48:00 INFO - Running setup.py install for mozlog 06:48:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Running setup.py install for moznetwork 06:48:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:00 INFO - Running setup.py install for mozprocess 06:48:01 INFO - Running setup.py install for mozprofile 06:48:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:01 INFO - Running setup.py install for mozrunner 06:48:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:01 INFO - Running setup.py install for mozscreenshot 06:48:01 INFO - Running setup.py install for moztest 06:48:01 INFO - Running setup.py install for mozversion 06:48:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:01 INFO - Cleaning up... 06:48:01 INFO - Return code: 0 06:48:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:48:01 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 06:48:01 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 06:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:01 INFO - 'HOME': '/Users/cltbld', 06:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:01 INFO - 'LOGNAME': 'cltbld', 06:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:01 INFO - 'MOZ_NO_REMOTE': '1', 06:48:01 INFO - 'NO_EM_RESTART': '1', 06:48:01 INFO - 'PAGER': '/bin/cat', 06:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:01 INFO - 'PWD': '/builds/slave/test', 06:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:01 INFO - 'SHELL': '/bin/bash', 06:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:48:01 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:01 INFO - 'USER': 'cltbld', 06:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:01 INFO - 'XPC_FLAGS': '0x0', 06:48:01 INFO - 'XPC_SERVICE_NAME': '0', 06:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-p8qplr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-40RpjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-_aBcqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-DyCK1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-GLzVz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-R1Xx1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-xt5MjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-TranAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:02 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)) 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:02 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-vGS8u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-bmlD3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oF872e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-QUAOr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-jY8ycp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-8RRF3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-MDZQru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-U0h3s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:03 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)) 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:03 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-NGuIAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:03 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)) 06:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:03 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)) 06:48:03 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)) 06:48:03 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)) 06:48:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:03 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 06:48:03 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 06:48:03 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 06:48:03 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 06:48:03 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 06:48:03 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 06:48:06 INFO - Downloading blessings-1.6.tar.gz 06:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:06 INFO - Installing collected packages: blessings 06:48:06 INFO - Running setup.py install for blessings 06:48:06 INFO - Successfully installed blessings 06:48:06 INFO - Cleaning up... 06:48:06 INFO - Return code: 0 06:48:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:07 INFO - Reading from file tmpfile_stdout 06:48:07 INFO - Current package versions: 06:48:07 INFO - blessings == 1.6 06:48:07 INFO - blobuploader == 1.2.4 06:48:07 INFO - docopt == 0.6.1 06:48:07 INFO - functools32 == 3.2.3-2 06:48:07 INFO - jsonschema == 2.5.1 06:48:07 INFO - manifestparser == 1.1 06:48:07 INFO - mozInstall == 1.12 06:48:07 INFO - mozcrash == 1.0 06:48:07 INFO - mozdebug == 0.1 06:48:07 INFO - mozdevice == 0.48 06:48:07 INFO - mozfile == 1.2 06:48:07 INFO - mozhttpd == 0.7 06:48:07 INFO - mozinfo == 0.9 06:48:07 INFO - mozleak == 0.1 06:48:07 INFO - mozlog == 3.4 06:48:07 INFO - moznetwork == 0.27 06:48:07 INFO - mozprocess == 0.23 06:48:07 INFO - mozprofile == 0.28 06:48:07 INFO - mozrunner == 6.13 06:48:07 INFO - mozscreenshot == 0.1 06:48:07 INFO - mozsystemmonitor == 0.3 06:48:07 INFO - moztest == 0.7 06:48:07 INFO - mozversion == 1.4 06:48:07 INFO - psutil == 3.1.1 06:48:07 INFO - requests == 1.2.3 06:48:07 INFO - wsgiref == 0.1.2 06:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:07 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')]} 06:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 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')]} 06:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:48:07 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 06:48:07 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 06:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:07 INFO - 'HOME': '/Users/cltbld', 06:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:07 INFO - 'LOGNAME': 'cltbld', 06:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:07 INFO - 'MOZ_NO_REMOTE': '1', 06:48:07 INFO - 'NO_EM_RESTART': '1', 06:48:07 INFO - 'PAGER': '/bin/cat', 06:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:07 INFO - 'PWD': '/builds/slave/test', 06:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:07 INFO - 'SHELL': '/bin/bash', 06:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:48:07 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:07 INFO - 'USER': 'cltbld', 06:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:07 INFO - 'XPC_FLAGS': '0x0', 06:48:07 INFO - 'XPC_SERVICE_NAME': '0', 06:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 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)) 06:48:07 INFO - Cleaning up... 06:48:07 INFO - Return code: 0 06:48:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:07 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')]} 06:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 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')]} 06:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 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 0x10d4b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d429570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f8cd1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, '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.6ggeB47Xfd/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.0n2RAEekXF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 06:48:07 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 06:48:07 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 06:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:07 INFO - 'HOME': '/Users/cltbld', 06:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:07 INFO - 'LOGNAME': 'cltbld', 06:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:07 INFO - 'MOZ_NO_REMOTE': '1', 06:48:07 INFO - 'NO_EM_RESTART': '1', 06:48:07 INFO - 'PAGER': '/bin/cat', 06:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:07 INFO - 'PWD': '/builds/slave/test', 06:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:07 INFO - 'SHELL': '/bin/bash', 06:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:48:07 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:07 INFO - 'USER': 'cltbld', 06:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:07 INFO - 'XPC_FLAGS': '0x0', 06:48:07 INFO - 'XPC_SERVICE_NAME': '0', 06:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:48:07 INFO - Cleaning up... 06:48:07 INFO - Return code: 0 06:48:07 INFO - Running post-action listener: _resource_record_post_action 06:48:07 INFO - Running post-action listener: _start_resource_monitoring 06:48:07 INFO - Starting resource monitoring. 06:48:07 INFO - [mozharness: 2016-11-14 14:48:07.706248Z] Finished create-virtualenv step (success) 06:48:07 INFO - [mozharness: 2016-11-14 14:48:07.707344Z] Running install step. 06:48:07 INFO - Running pre-action listener: _resource_record_pre_action 06:48:07 INFO - Running main action method: install 06:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:07 INFO - Reading from file tmpfile_stdout 06:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:08 INFO - Reading from file tmpfile_stdout 06:48:08 INFO - Output received: 06:48:08 INFO - Usage: mozinstall [options] installer 06:48:08 INFO - Options: 06:48:08 INFO - -h, --help show this help message and exit 06:48:08 INFO - -d DEST, --destination=DEST 06:48:08 INFO - Directory to install application into. [default: 06:48:08 INFO - "/builds/slave/test"] 06:48:08 INFO - --app=APP Application being installed. [default: firefox] 06:48:08 INFO - mkdir: /builds/slave/test/build/application 06:48:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:48:42 INFO - Reading from file tmpfile_stdout 06:48:42 INFO - Output received: 06:48:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:48:42 INFO - Running post-action listener: _resource_record_post_action 06:48:42 INFO - [mozharness: 2016-11-14 14:48:42.046582Z] Finished install step (success) 06:48:42 INFO - [mozharness: 2016-11-14 14:48:42.046766Z] Running run-tests step. 06:48:42 INFO - Running pre-action listener: _resource_record_pre_action 06:48:42 INFO - Running main action method: run_tests 06:48:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:42 INFO - 2016-11-14 06:48:42.061 screenresolution[29372:269418] starting screenresolution argv=screenresolution get 06:48:42 INFO - 2016-11-14 06:48:42.064 screenresolution[29372:269418] Display 0: 1600x1200x32@60 06:48:42 INFO - 2016-11-14 06:48:42.069 screenresolution[29373:269420] starting screenresolution argv=screenresolution list 06:48:42 INFO - Available Modes on Display 0 06:48:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:42 INFO - Intel Iris: 06:48:42 INFO - Chipset Model: Intel Iris 06:48:42 INFO - Type: GPU 06:48:42 INFO - Bus: Built-In 06:48:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:42 INFO - Vendor: Intel (0x8086) 06:48:42 INFO - Device ID: 0x0a2e 06:48:42 INFO - Revision ID: 0x0009 06:48:42 INFO - Displays: 06:48:42 INFO - Display: 06:48:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:42 INFO - Display Serial Number: 1600x1200 60 06:48:42 INFO - Main Display: Yes 06:48:42 INFO - Mirror: Off 06:48:42 INFO - Online: Yes 06:48:42 INFO - Rotation: Supported 06:48:42 INFO - Return code: 0 06:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:42 INFO - Python 2.7.3 06:48:42 INFO - Return code: 0 06:48:42 INFO - grabbing minidump binary from tooltool 06:48:42 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')]} 06:48:42 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 0x10d2c7d30>, '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 0x10d0eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:42 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 06:48:42 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 06:48:42 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 06:48:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:42 INFO - Return code: 0 06:48:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:48:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:48:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:42 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 06:48:42 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --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 06:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ggeB47Xfd/Render', 06:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:42 INFO - 'HOME': '/Users/cltbld', 06:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:42 INFO - 'LOGNAME': 'cltbld', 06:48:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:42 INFO - 'MOZ_NO_REMOTE': '1', 06:48:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:42 INFO - 'NO_EM_RESTART': '1', 06:48:42 INFO - 'PAGER': '/bin/cat', 06:48:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:42 INFO - 'PWD': '/builds/slave/test', 06:48:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:42 INFO - 'SHELL': '/bin/bash', 06:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0n2RAEekXF/Listeners', 06:48:42 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 06:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:42 INFO - 'USER': 'cltbld', 06:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:42 INFO - 'XPC_FLAGS': '0x0', 06:48:42 INFO - 'XPC_SERVICE_NAME': '0', 06:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:42 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 06:48:42 INFO - mozversion application_buildid: 20161114042943 06:48:42 INFO - mozversion application_changeset: a516c754042c438a5c1499171ca525a980ecb911 06:48:42 INFO - mozversion application_display_name: Nightly 06:48:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:42 INFO - mozversion application_name: Firefox 06:48:42 INFO - mozversion application_remotingname: firefox 06:48:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:48:42 INFO - mozversion application_vendor: Mozilla 06:48:42 INFO - mozversion application_version: 53.0a1 06:48:42 INFO - mozversion platform_buildid: 20161114042943 06:48:42 INFO - mozversion platform_changeset: a516c754042c438a5c1499171ca525a980ecb911 06:48:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:48:42 INFO - mozversion platform_version: 53.0a1 06:48:42 INFO - using testdate: 1479134922 06:48:42 INFO - actual date: 1479134922 06:48:42 INFO - starting webserver on 'localhost:49356' 06:48:42 INFO - SUITE-START | Running 2 tests 06:48:42 INFO - TEST-START | dromaeo_css 06:48:42 INFO - operating with platform_type : mac_ 06:48:42 INFO - Initialising browser for dromaeo_css test... 06:48:42 INFO - TEST-INFO | started process 29383 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpzHuW5o/profile http://localhost:49356/getInfo.html) 06:48:45 INFO - PROCESS | 29383 | __metrics Screen width/height:1600/1200 06:48:45 INFO - PROCESS | 29383 | colorDepth:24 06:48:45 INFO - PROCESS | 29383 | Browser inner width/height: 1024/689 06:48:45 INFO - PROCESS | 29383 | __metrics 06:48:45 INFO - PROCESS | 29383 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:48:45 INFO - PROCESS | 29383 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:48:45 INFO - TEST-INFO | 29383: exit 0 06:48:45 INFO - Browser initialized. 06:48:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:48:45 INFO - TEST-INFO | started process 29386 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpzHuW5o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:57 INFO - PROCESS | 29386 | RSS: Main: 239136768 06:48:57 INFO - PROCESS | 29386 | 06:49:49 INFO - PROCESS | 29386 | 1479134989100 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] 06:52:01 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49356/tests/dromaeo/cssquery-ext.html) 06:52:03 INFO - PROCESS | 29386 | RSS: Main: 362442752 06:52:03 INFO - PROCESS | 29386 | 06:55:06 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-ext.html (next: http://localhost:49356/tests/dromaeo/cssquery-jquery.html) 06:55:06 INFO - PROCESS | 29386 | RSS: Main: 372084736 06:55:06 INFO - PROCESS | 29386 | 06:58:09 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49356/tests/dromaeo/cssquery-mootools.html) 06:58:09 INFO - PROCESS | 29386 | RSS: Main: 343179264 06:58:09 INFO - PROCESS | 29386 | 07:01:12 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49356/tests/dromaeo/cssquery-prototype.html) 07:01:12 INFO - PROCESS | 29386 | RSS: Main: 342925312 07:01:12 INFO - PROCESS | 29386 | 07:04:16 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49356/tests/dromaeo/cssquery-yui.html) 07:04:16 INFO - PROCESS | 29386 | RSS: Main: 331841536 07:04:16 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-yui.html (next: http://localhost:49356/tests/dromaeo/cssquery-dojo.html) 07:07:20 INFO - PROCESS | 29386 | RSS: Main: 420552704 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | __start_tp_report 07:07:20 INFO - PROCESS | 29386 | _x_x_mozilla_page_load 07:07:20 INFO - PROCESS | 29386 | _x_x_mozilla_page_load_details 07:07:20 INFO - PROCESS | 29386 | |i|pagename|runs| 07:07:20 INFO - PROCESS | 29386 | |0;dojo.html;3242.3515296940614;3246.983765081174;3250.869965201392;3290.226796702776;3321.6014078310604;5427.158790387496;5505.614606977508;5545.1682247662875;5649.802256921003;5662.43375662434;5498.395176530578;5612.298462692163;5630.296212973368;5697.230873832032;5704.54363650908;5106.846794596168;5123.615728820335;5130.050940576006;5144.408393034792;5176.327077479922;5153.433122356538;5259.6055295852775;5264;5267.23625074364;5270.9736451317685;5059.494050594948;5074.4925507449325;5190.558802501754;5246.134387826023;5258.710770907599;5088.643794934356;5155.226715992593;5155.278261043457;5177.508136727005;5189.974050129726;5048.747562621854;5109.156989096795;5119.180931051014;5130.563902068328;5133.794648214067;5138.81807184346;5625.634333768333;5647.491725744702;5650.208970744099;5653.349864765522;5923.674197919113;6007.15899774032;6027.638341699469;6036.305824830157;6124.785632502841;5486.725663716798;6001.099835024781;6129.601575897553;6186.474149697281;6211.2857021442205;4818.349522814446;5677.460641239076;5706.77172913083;5719.14212868069;5732.484076433057;6174.536909731788;6223.941929871932;6251.12484252205;6252.093446450239;6270;5925.851853703692;5995.400459954057;5999.400059993965;6004.879902401927;6065.302490213682;6122.663253521099;6188.783392581328;6189.195404597373;6202.689865506707;6207.534434917399;5873.588848780544;6031.459872813399;6097.207363042865;6122.142899994004;6136.6318020918;5960.523158147338;6053.818385448443;6055.394460553909;6061.090836374491;6064.939350606437;4831.975840120847;4858.125537403231;4866.391701037371;4899.730514821647;4922.409310882717;4342.174986752507;4364.454443194601;4372.868813935587;4373.103513779667;4401.2517871961845;5478.671279723229;5545;5566.888662226733;5578.135389014709;5625.353084395347;6105.8843398869;6132.141500189977;6140.3552626974415;6145.801568694062;6223.719932602953;5626.240457538262;5647.971760141255;5648.8870222595315;5662.207290979266;5692.772289108472;5297.655652382583;5314.92027619586;5319.361676598755;5325.147976323847;5348.251244825728;6132.662703551258;6202.937970620236;6214.9689251553455;6216.751329946752;6233.376662333912;6149.292831324455;6205.410486003822;6210.472109870711;6211.565190436626;6219.502439804895;6277.5605707600025;6285.025820997753;6286.654234017173;6290.968545157245;6299.086632438362;5877.089051197071;5972.283326000907;6026.969865150646;6055.727492262947;6060.969635161945;5038.168702164102;6117.724702388314;6128.3503509891225;6209.037599172136;6220.129181914626;4973.254011898244;5986.521078313812;5989.970050149721;5990.670513121646;6017.037274036134;5792.391798861059;5865.120231965239;5953.196318496947;6006.249218847644;6012.819615411545;5754.280714910637;5782.45066718661;5838.2702162229725;5860.179574859438;5868.677222752619;5988.640681559121;6022.1870047543025;6025.487833534199;6030.728617212324;6032.54755893301;5672.4894759471845;5753.597248192586;5759.424057594207;5792.21805056312;5798.304203495608 07:07:20 INFO - PROCESS | 29386 | |1;ext.html;466.87627778638654;480.71888417367717;501.6855837705213;511.483401764218;513.8432778002708;28363.858180709092;38271.61728382715;39424;39489.210215795705;39534.60465395345;40345.39481907774;40735.796321018424;40741.59258407415;40862.59137408625;40925;9281.582328795204;9473.952630236874;9492.857607135898;9495.857562136573;9509.476978766164;9335.673251436201;9429.622815087423;9434.292428067922;9434.386764860263;9452.102050305244;9396.436213827192;9452.8582071269;9462.195713364372;9474.384165029285;9482.905170948306;9389.014153513885;9418.717438476857;9426.717198484022;9452.385594936308;9455.621775128986;9368.67209647659;9449.52752362386;9459.479728614924;9463.621455141785;9487.288453366025;38435.231295374215;38766.030849228715;38786;38790.41814372787;38811.41782873259;2856.3072240481133;3504.56192975878;3606.6393360663988;3779.829907654162;3943.132510847609;28716.897181563603;29436.82252709889;29675.258118546994;29755.256118596993;29795.55306670402;3117.8908738194054;3240.141362538929;3309.040378290293;3312.4368857294075;3324.434846076173;454933;458160;459491;461769;462190;56076.42968199323;56490.17549122527;56519.71740141273;56555;56592.151117733265;59077.70461147667;59192;59225.70387148123;59252.70373648104;59288;15115.848841511664;15335.693286134216;15346.15596142223;15352.07887526752;15375.923120384326;11822.822657660143;11899.643010709693;11908.583199587973;11922.28466292008;11924.523019079139;12793.29636869981;15640.983336083345;15745.606359841096;15780.842191578167;15882.523524294289;6819.795406137824;6902.827429314308;6929.896051559231;6974.26770189133;6994.965025174944;705.3792662457005;729.8576777528331;792.6829268292729;828.9917100829035;991.2813210422386;26839.865800670872;28406;28898.070800522935;29256.122316330544;29301.827926883114;1022.3303736052749;1039.6101461951769;1096.5778175402527;1110.361542113272;1117.407773879845;13832.239226842621;14759.409623615149;14941.850581494045;15169.696606068037;15183.924080379527;638872;640116;641300;643860.6841794754;644987;55632.44367556353;55691;55854.88290234173;55934;56276.71861640666;1192.8270400791837;1233.2846948769693;1296.805479178112;1323.7220183761517;1347.198416941918;28455.573166402108;29433;29495.410091797614;29946.401071978875;30279.848600756854;46823.82940426517;47336.76331618457;47361.52638473571;47540.28689569728;47580;507338;525314;526876;528771;530374;24785.008599655812;25652.358691032874;25686.357841054123;26303.73696263013;26377.868110659325;43960.780196098814;44486.663500236966;44716.77641611771;45234.547654523034;45310.546894530635;30948.845255773576;36571;36692.6614677071;37378.38307161839;37714.43428348632;35955.82022089873;36885;37725.62274377221;38028.2394352117;38470;36598.08504787295;36936;37419.81290093532;37542.812285938395;37571;28800.84796608112;32382.676173237967;32476.700931962456;32565.67434325721;32787.50818737769;20172.495687607927;23946.844783969525;24003.879980599984;24566;24610.261692149263 07:07:20 INFO - PROCESS | 29386 | |2;jquery.html;352.95411596492454;367.3552914634816;370.6108585984716;375.90978165240335;407.43570155334874;12934.935325323371;13251.469941202353;15234.16212108335;16697.415590454337;19287.842729436245;18811.247550097978;19134.330298439556;19647.115879785408;19858.304959326426;19878;5561.77752889884;5910.586258961875;5927.644341339512;5933.050711886099;5937.703114844262;5577.832665020035;5760.222369980041;5788.884222315552;5865.501432378232;5896.528277737792;5801.563343395763;5808.12878068289;5810.1865738796605;5813.796517121901;5819.912701309484;5556.222128901957;5790.33411157718;5798.681072541009;5852.034414321632;5858.238429004245;5092.694438333712;5101.4133374662015;5101.642884998052;5103.18349064148;5108.667936584147;21951.341459756233;24003.7599624005;24032.399190020216;24190.87904560466;24262;2248.7638797926147;2323.977449922029;2352.6000579901456;2374.5725769361507;2846.3595690969573;14460.855391446055;14547.70904581913;14689.706205875822;15241.695166096615;15384.615384615363;1606.2370374072339;1755.2452445448453;1776.0764402510752;1796.3114672208212;1804.143032059761;98764;100770;102150.9784902149;103314;103734.48132759288;10101.494925253708;10256.17950563968;10555.89444105549;10678.476102886028;10795.78408431827;13252;13259.337033148304;13264.270465124511;13284.070115092045;13285.468581256642;7847.362514029181;8118.512889226666;8136.959315203504;8271.95864020676;8281.21328473794;8073.192680731997;8099.676012959533;8125.578940029241;8235.8352832943;8272.007359116824;6271;6288.685565721696;6302.306746257908;6309.179806625109;6326.588771729823;1795.9102044897702;1835.8990255536073;1836.219606667161;1837.0814592703648;1839.4297767692058;884.4648987362682;933.3793027636546;937.8968313485511;938.0947385772762;971.3928794503436;19991.100400482013;21190.258340957993;21245.150193992376;21255.468613284793;21460.678089828663;795.3875515852761;915;937.8968313485511;975.5658731864253;1009.4430161958372;9266;10626.468676566295;11056.11551075912;11322.320660760215;11357.602483913024;573331;582257;587470;589912;597855;70164;77408;99835.00164998403;102072.48963755282;104775;874.2175752701297;976.3556053004983;980.352967041749;980.4313498171043;981.2052237687496;14469.638259043188;18147.27410903549;18405.907970460063;18534.86849012381;18543.072846357896;29199.7080029197;40871.79564102161;41785.373219401125;43175;43861.122777543635;59863.70068149632;60066.69966650139;60402.791944159995;60834.39165608287;61741;6830.487713421414;7017.158818834633;7146.392556632744;7334.486585938933;7362.374198193;11527.423628818693;11953.521859125538;12195.51217951272;12219.26684398939;12243.30647257602;10249.282550221413;10385.273030887765;10702.682168527781;10815.783684326427;10900.945495272474;8909.420887642282;10170.89829101729;10444.477776111013;10594.894051059391;10789.40658263803;10504.947475262881;10646.254762166574;10838.67483975482;10877.619283325046;10990.670279891616;5968.432998865101;7172.49792514519;7175.354218120394;7229.132504099542;7359.521631094176;10377.273590848568;10544.630937917136;10671.306365086244;10716.196285278791;10796.946015269874 07:07:20 INFO - PROCESS | 29386 | |3;mootools.html;1337.799330100485;1472.4331132513985;1622.8214896361399;1817.4184261036473;1845.3080094964396;8003.479773814698;8449.281811046054;8464.534450605213;8466.153384661538;8473.745787626365;7339.559626422419;7652.617369131535;7653.961730191355;7743.806404839882;7756.457048006641;2020.969685454723;2208.094681180716;2277.6128058230142;2284.7258329000542;2300.401895507172;2317.084751523147;2336.789688927996;2342.484653376263;2349.7650234976536;2350.8707021113833;2311.6648086027517;2328.592496313147;2330.1727886600265;2331.3006098170567;2332.825038122139;2250.85369450986;2292.1404473322505;2293.8050265727434;2294.8852557372147;2294.977050229493;1949.4736421166206;2287.5310561334886;2293.7820907013975;2309.86140831549;2314.0396735354807;8260.380471464665;8291.212334828182;8367.665293388258;8369.790755231106;8377.078521362646;4964.751762411865;5128.71792051437;5134.229865520165;5136.126858434075;5144.0740666679985;2599.922002339933;3352.3295340931913;3403.7787543809573;3414.641462646411;3431.24512607226;809.2918696140877;954.4464210757744;967.5549247346229;986.8651051291001;1033.7722208640391;10834.837477437844;10906.345619262791;10924.563017479211;10927.180461465343;10964.780704385868;4288;4484.080763443486;4556.567126123013;4586.839460618862;4621.815127394933;9355.625774969061;9359.34484586086;9368.344215904957;9374.531273436301;9376.29677774156;5121.308623335802;5130;5131.1277082895995;5134.589232861362;5138.3577052868395;4556.3621093047;4595.862124136282;4653.95346046542;4716.985848042687;4718.150732868048;3134.639516455591;3649.379605467024;3710.18375957289;3734.9066273343383;3807.1053302473897;1015.9136473399695;1226.1355744200318;1228.6928267933017;1229.6618429931661;1249.8562665293425;801.3469022746559;826.2563692676639;844.438448431786;883.1918794303269;906.8095699903095;5100.7959681613065;5117.667351622207;5160;5429.56563474921;5486.259354987105;412.7523485908431;430.29002146458595;430.43827804715147;438.3074741907778;438.39939283182247;3131.3893790710595;3361.09250502363;3581.3374525712825;3627.147620309225;3670.7614005089586;9694.806103878023;9931;10108.646197383056;10119.342242754197;10162.39025658463;10090.12431457046;10101.646442374482;10115.342502737445;10116.24128190374;10155.086042256233;6058.333583305833;6378.872422551616;7728.381729461629;7824.256695613793;7877.7636670899965;5152.458991805806;5224.52979231871;5228.712420816892;5236.607254455855;5277.261183434399;9180.724578262663;9240.214581760625;9330.533473326172;9350.251979841732;9423.10480504351;9206.125418085272;9515.619375224913;9564.187044101329;9572.377795443273;9606.231501479726;6532.804015879531;6687;6714;6759.188897332155;7095.29047095307;7839.686412543662;7946.205379462239;8033.156518565466;8044.557549334842;8048.919510804817;7081.68132434052;7095.787126386217;7099.645017748989;7140.6786694599905;7191.101112360955;6890.621015844176;6954.130733658293;6971.407430368476;6985.930140698528;7006.054182685272;6443.806685799434;6466;6472.5145614080075;6473;6475.514336424692;4503.852370422516;4626.491085980472;4661.300804879295;4663.7201767892675;4716.504766999416;4509.940164061509;4525.298578720303;4631.235846085358;4698.248280275139;4779.06808172403 07:07:20 INFO - PROCESS | 29386 | |4;prototype.html;300.469671030631;306.0939618728563;307.35608899355844;317.577621763055;319.02060673731654;4317.596781046157;5178.689278643279;5197.090509160891;5216.321878155839;5230.2416149658275;4272.978635106821;4896.828610998616;5162.948370516303;5184.066867963765;5219.5041471060285;3773.264213478366;3884.6892248620184;3888.786116763577;3927.1163988102735;3941.586133455989;3652.8904132875923;3778.8474515272833;3949.4273330367078;3949.9210015799667;3992.341263691502;3929.646331830135;3954.4266081418177;3964.4846169998004;3978.244133614604;3980.2039592081555;3443.6728510791436;3518.1204698825295;3838.808059597009;3928.960710392888;3954.189391174802;2619;3179.0780673604627;3467.4798780182923;3487.424574945131;3496.35317466267;4661.82995563017;5023.497650234984;5026.648134630577;5032.4212715537815;5077.64456488046;4399.868003959887;4495.258282383403;4499.942513509322;4528.932066019012;4602.401687780567;5356.018273238888;5379.973100134474;5387.703676297802;5443.727813609304;5470.972645136789;3829.859515197539;3831.490373805162;3838.5777564467885;3854.9421758673643;3865.4588357629955;5388.568914486832;5680.687562184078;5708.5433165347085;5721.427857214246;5755.158349328217;3274.804696285886;3829.4447305140598;3857;3862.6480731743663;3893.9415908761393;3919.7256192066284;3942.3100957332354;3945.763254204757;3950.4074388841905;3951.4072889066297;4505.43682039745;4511.571400716926;4525.728456292633;4542.318652202196;4546.681732278708;5018.749062546858;5067.974660126676;5322.361316642027;5470.671759694431;5600.60795744294;1111.5276007696696;1236.1717649175075;1236.2568778022944;1239.1387985350275;1248.5005997600852;735.9632018399059;807.7899746066065;843.8860753798282;857.0058731871125;861.6424183963585;4932.585336124149;5066.771995260222;5096;5107.538963211467;5161.74191290434;5041.697498150123;5238.5023422774775;5250.527452529291;5264.5782939848095;5360.437154098841;4570.291604801261;4808.519148085164;5112.539871411591;5124.590032797368;5164.354455693038;2165.375968023982;2448.747152619594;2763.72362763722;2800.2719292983566;2820.8448535330754;4670;4835.468098509161;5171.844844654666;5215.965773348397;5562.638428502134;4003.079291762853;4922;5354.759035843396;5394.595405344615;5593.552515798727;4765.904681906342;5194.3766747990485;5454.7272636368025;5532.640378375473;5589.077802162597;4464.821407143808;5055.368078990126;5286.233496143114;5393;5435.994341046919;4435.756033418193;5147.6911385317;5262.657927234717;5325.547328477122;5440.020796256712;4421.09367579639;4881.609471242221;5861.648301101947;5899.823005309848;5900.675462849585;3804.619538046173;3845.134844659929;3862.613738626227;3876.2053778974678;3880.80595970206;4655.650826187982;4957.454679985127;5570.916436253378;5774.036827478677;5808.477237048686;4804.5195480451675;5241.816536421207;5433.755481003285;5456.645318054314;5498.945010549844;4585.9541404585525;5443.265159203615;5464.453554644504;5465.426130256265;5531.419200984;4545.727256364628;5135.87160320995;5413.431589683184;5427.371788463524;5496.560275178056;4284.243460181436;4953.529414705597;5113.514216149609;5187.236339644388;5457.399686034612;4486.371907932958;4782.508768598873;5259.316288882421;5318;5427 07:07:20 INFO - PROCESS | 29386 | |5;yui.html;648.597869321021;769.55750443495;776.378896882494;782.5539442517763;796.5499492786579;11378.431078446076;15762.605934851621;16437;16442.67114657706;16451.930624509412;15092.698146037073;15195;15215;15216.163111028916;15226.847731522681;830.4809494066209;857.0957639690156;859.3511898516642;861.9094995025526;862.6333808131519;669.3841665667574;692.8233300508389;696.1785093589588;698.7903628911332;699.6991293743688;722.0901663903467;858.2318824651933;883.3330835219432;886.3485338276362;896.3456676626067;882.898466676334;883.7746374674449;884.6196135661663;884.8186121845006;886.5877367024365;658.5094104891838;658.9077529145924;658.9176352955881;661.206552137437;661.8113837556274;11802.94098529502;12304.323262220574;13686.384112714952;14155.716885662332;14282.714345713131;12930.54743083997;13025.934870325587;13254.072214944958;13378.86621133786;13485.865141348657;10974;11076.11391088711;11079.113670906308;11428.485718142703;11569.884301156964;3622.873199438033;3625.8549658013912;3647.726420518445;3654.945175822365;3751.6998640108727;86334.13665863324;87811.12188878158;88153;90149.09850901473;91687;10252.897471025195;10254.179665626882;10274.897251027394;10377.169826413869;10642.787144257072;19178.945158016442;19544.706829397284;19754.802451975585;19813.405597832087;19856.404307870787;7310.4517161213125;7340.229275926058;7405.851882962418;7493.625318734042;7555.320021198118;4162.666986641061;4219.599138081878;4246.596573325529;4344.218040752695;4393.582609652078;3144.371125774854;3231.1114443528218;3242.9946716517957;3245.2860370718404;3253.577034985437;595.2767387624058;596.2993482657946;607.8662694207268;616.6669998201011;616.7995401494533;572.6277919352455;609.1471939284947;625.6954250387901;636.3699937062275;651.9576227545289;9021.413608115452;9049.592768325441;9135.675327077537;9309.44143351401;9497;515.4458956621646;528.3870709976409;545.1305168256624;559.3018643395429;681.5399605266425;3882.9223415531533;4419.734815911055;4539.3271890321175;4576;4611.677182597253;70778.23054423681;88796.5560172195;114623;115339;123104.38447807703;83433.58283208667;96097;98702.50648746711;99341.00658993462;103674;90608.54695726479;91213.54393227858;93158.06841931494;95003.52498237464;96272;7311.451641127043;8068.687492836672;8594.226519613265;9044.50255235942;9060.909390906007;51705.7414712924;51847;54335.91328173335;55834.44165558292;55967.16049259346;57242;66639;75368.62315688387;78937;82273;11912.225705329125;12006.519739210335;12033.518659253532;12257.570985015482;12712.555060572835;13696.911773489948;13748.65628359299;14102.929485352508;14455.204963726675;14847.703045939237;13028.218306901616;13209.735805284034;13214.735705286033;13348.666283342605;13707.588772336845;12818;13078.411471483616;13183.14309569875;13221.603351899459;13757.587272381845;12678;12977.416016279101;13125.081244312807;13356;13387.409872434924;10572.84140737905;10858.728531786768;11014.284071535325;11057.723556911142;11265.267757596057;10515.842262365917;11137.498812553293;11214.607488737855;11280.570075057138;11362.375069371265 07:07:20 INFO - PROCESS | 29386 | __end_tp_report 07:07:20 INFO - PROCESS | 29386 | __start_cc_report 07:07:20 INFO - PROCESS | 29386 | _x_x_mozilla_cycle_collect,1449 07:07:20 INFO - PROCESS | 29386 | __end_cc_report 07:07:20 INFO - PROCESS | 29386 | __startTimestamp1479136040409__endTimestamp 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | ------- Summary: start ------- 07:07:20 INFO - PROCESS | 29386 | Number of tests: 6 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#0] dojo.html Cycles:165 Average:5628.61 Median:5782.45 stddev:629.23 (10.9%) stddev-sans-first:602.67 07:07:20 INFO - PROCESS | 29386 | Values: 3242.4 3247.0 3250.9 3290.2 3321.6 5427.2 5505.6 5545.2 5649.8 5662.4 5498.4 5612.3 5630.3 5697.2 5704.5 5106.8 5123.6 5130.1 5144.4 5176.3 5153.4 5259.6 5264.0 5267.2 5271.0 5059.5 5074.5 5190.6 5246.1 5258.7 5088.6 5155.2 5155.3 5177.5 5190.0 5048.7 5109.2 5119.2 5130.6 5133.8 5138.8 5625.6 5647.5 5650.2 5653.3 5923.7 6007.2 6027.6 6036.3 6124.8 5486.7 6001.1 6129.6 6186.5 6211.3 4818.3 5677.5 5706.8 5719.1 5732.5 6174.5 6223.9 6251.1 6252.1 6270.0 5925.9 5995.4 5999.4 6004.9 6065.3 6122.7 6188.8 6189.2 6202.7 6207.5 5873.6 6031.5 6097.2 6122.1 6136.6 5960.5 6053.8 6055.4 6061.1 6064.9 4832.0 4858.1 4866.4 4899.7 4922.4 4342.2 4364.5 4372.9 4373.1 4401.3 5478.7 5545.0 5566.9 5578.1 5625.4 6105.9 6132.1 6140.4 6145.8 6223.7 5626.2 5648.0 5648.9 5662.2 5692.8 5297.7 5314.9 5319.4 5325.1 5348.3 6132.7 6202.9 6215.0 6216.8 6233.4 6149.3 6205.4 6210.5 6211.6 6219.5 6277.6 6285.0 6286.7 6291.0 6299.1 5877.1 5972.3 6027.0 6055.7 6061.0 5038.2 6117.7 6128.4 6209.0 6220.1 4973.3 5986.5 5990.0 5990.7 6017.0 5792.4 5865.1 5953.2 6006.2 6012.8 5754.3 5782.5 5838.3 5860.2 5868.7 5988.6 6022.2 6025.5 6030.7 6032.5 5672.5 5753.6 5759.4 5792.2 5798.3 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#1] ext.html Cycles:180 Average:66825.14 Median:39117.71 stddev:146212.82 (373.8%) stddev-sans-first:146538.10 07:07:20 INFO - PROCESS | 29386 | Values: 466.9 480.7 501.7 511.5 513.8 28363.9 38271.6 39424.0 39489.2 39534.6 40345.4 40735.8 40741.6 40862.6 40925.0 9281.6 9474.0 9492.9 9495.9 9509.5 9335.7 9429.6 9434.3 9434.4 9452.1 9396.4 9452.9 9462.2 9474.4 9482.9 9389.0 9418.7 9426.7 9452.4 9455.6 9368.7 9449.5 9459.5 9463.6 9487.3 38435.2 38766.0 38786.0 38790.4 38811.4 2856.3 3504.6 3606.6 3779.8 3943.1 28716.9 29436.8 29675.3 29755.3 29795.6 3117.9 3240.1 3309.0 3312.4 3324.4 454933.0 458160.0 459491.0 461769.0 462190.0 56076.4 56490.2 56519.7 56555.0 56592.2 59077.7 59192.0 59225.7 59252.7 59288.0 15115.8 15335.7 15346.2 15352.1 15375.9 11822.8 11899.6 11908.6 11922.3 11924.5 12793.3 15641.0 15745.6 15780.8 15882.5 6819.8 6902.8 6929.9 6974.3 6995.0 705.4 729.9 792.7 829.0 991.3 26839.9 28406.0 28898.1 29256.1 29301.8 1022.3 1039.6 1096.6 1110.4 1117.4 13832.2 14759.4 14941.9 15169.7 15183.9 638872.0 640116.0 641300.0 643860.7 644987.0 55632.4 55691.0 55854.9 55934.0 56276.7 1192.8 1233.3 1296.8 1323.7 1347.2 28455.6 29433.0 29495.4 29946.4 30279.8 46823.8 47336.8 47361.5 47540.3 47580.0 507338.0 525314.0 526876.0 528771.0 530374.0 24785.0 25652.4 25686.4 26303.7 26377.9 43960.8 44486.7 44716.8 45234.5 45310.5 30948.8 36571.0 36692.7 37378.4 37714.4 35955.8 36885.0 37725.6 38028.2 38470.0 36598.1 36936.0 37419.8 37542.8 37571.0 28800.8 32382.7 32476.7 32565.7 32787.5 20172.5 23946.8 24003.9 24566.0 24610.3 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#2] jquery.html Cycles:180 Average:32060.62 Median:14776.33 stddev:96640.28 (654.0%) stddev-sans-first:96882.05 07:07:20 INFO - PROCESS | 29386 | Values: 353.0 367.4 370.6 375.9 407.4 12934.9 13251.5 15234.2 16697.4 19287.8 18811.2 19134.3 19647.1 19858.3 19878.0 5561.8 5910.6 5927.6 5933.1 5937.7 5577.8 5760.2 5788.9 5865.5 5896.5 5801.6 5808.1 5810.2 5813.8 5819.9 5556.2 5790.3 5798.7 5852.0 5858.2 5092.7 5101.4 5101.6 5103.2 5108.7 21951.3 24003.8 24032.4 24190.9 24262.0 2248.8 2324.0 2352.6 2374.6 2846.4 14460.9 14547.7 14689.7 15241.7 15384.6 1606.2 1755.2 1776.1 1796.3 1804.1 98764.0 100770.0 102151.0 103314.0 103734.5 10101.5 10256.2 10555.9 10678.5 10795.8 13252.0 13259.3 13264.3 13284.1 13285.5 7847.4 8118.5 8137.0 8272.0 8281.2 8073.2 8099.7 8125.6 8235.8 8272.0 6271.0 6288.7 6302.3 6309.2 6326.6 1795.9 1835.9 1836.2 1837.1 1839.4 884.5 933.4 937.9 938.1 971.4 19991.1 21190.3 21245.2 21255.5 21460.7 795.4 915.0 937.9 975.6 1009.4 9266.0 10626.5 11056.1 11322.3 11357.6 573331.0 582257.0 587470.0 589912.0 597855.0 70164.0 77408.0 99835.0 102072.5 104775.0 874.2 976.4 980.4 980.4 981.2 14469.6 18147.3 18405.9 18534.9 18543.1 29199.7 40871.8 41785.4 43175.0 43861.1 59863.7 60066.7 60402.8 60834.4 61741.0 6830.5 7017.2 7146.4 7334.5 7362.4 11527.4 11953.5 12195.5 12219.3 12243.3 10249.3 10385.3 10702.7 10815.8 10900.9 8909.4 10170.9 10444.5 10594.9 10789.4 10504.9 10646.3 10838.7 10877.6 10990.7 5968.4 7172.5 7175.4 7229.1 7359.5 10377.3 10544.6 10671.3 10716.2 10796.9 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#3] mootools.html Cycles:180 Average:5330.32 Median:5109.23 stddev:3005.23 (58.8%) stddev-sans-first:2998.68 07:07:20 INFO - PROCESS | 29386 | Values: 1337.8 1472.4 1622.8 1817.4 1845.3 8003.5 8449.3 8464.5 8466.2 8473.7 7339.6 7652.6 7654.0 7743.8 7756.5 2021.0 2208.1 2277.6 2284.7 2300.4 2317.1 2336.8 2342.5 2349.8 2350.9 2311.7 2328.6 2330.2 2331.3 2332.8 2250.9 2292.1 2293.8 2294.9 2295.0 1949.5 2287.5 2293.8 2309.9 2314.0 8260.4 8291.2 8367.7 8369.8 8377.1 4964.8 5128.7 5134.2 5136.1 5144.1 2599.9 3352.3 3403.8 3414.6 3431.2 809.3 954.4 967.6 986.9 1033.8 10834.8 10906.3 10924.6 10927.2 10964.8 4288.0 4484.1 4556.6 4586.8 4621.8 9355.6 9359.3 9368.3 9374.5 9376.3 5121.3 5130.0 5131.1 5134.6 5138.4 4556.4 4595.9 4654.0 4717.0 4718.2 3134.6 3649.4 3710.2 3734.9 3807.1 1015.9 1226.1 1228.7 1229.7 1249.9 801.3 826.3 844.4 883.2 906.8 5100.8 5117.7 5160.0 5429.6 5486.3 412.8 430.3 430.4 438.3 438.4 3131.4 3361.1 3581.3 3627.1 3670.8 9694.8 9931.0 10108.6 10119.3 10162.4 10090.1 10101.6 10115.3 10116.2 10155.1 6058.3 6378.9 7728.4 7824.3 7877.8 5152.5 5224.5 5228.7 5236.6 5277.3 9180.7 9240.2 9330.5 9350.3 9423.1 9206.1 9515.6 9564.2 9572.4 9606.2 6532.8 6687.0 6714.0 6759.2 7095.3 7839.7 7946.2 8033.2 8044.6 8048.9 7081.7 7095.8 7099.6 7140.7 7191.1 6890.6 6954.1 6971.4 6985.9 7006.1 6443.8 6466.0 6472.5 6473.0 6475.5 4503.9 4626.5 4661.3 4663.7 4716.5 4509.9 4525.3 4631.2 4698.2 4779.1 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#4] prototype.html Cycles:180 Average:4358.37 Median:4909.41 stddev:1325.44 (27.0%) stddev-sans-first:1293.69 07:07:20 INFO - PROCESS | 29386 | Values: 300.5 306.1 307.4 317.6 319.0 4317.6 5178.7 5197.1 5216.3 5230.2 4273.0 4896.8 5162.9 5184.1 5219.5 3773.3 3884.7 3888.8 3927.1 3941.6 3652.9 3778.8 3949.4 3949.9 3992.3 3929.6 3954.4 3964.5 3978.2 3980.2 3443.7 3518.1 3838.8 3929.0 3954.2 2619.0 3179.1 3467.5 3487.4 3496.4 4661.8 5023.5 5026.6 5032.4 5077.6 4399.9 4495.3 4499.9 4528.9 4602.4 5356.0 5380.0 5387.7 5443.7 5471.0 3829.9 3831.5 3838.6 3854.9 3865.5 5388.6 5680.7 5708.5 5721.4 5755.2 3274.8 3829.4 3857.0 3862.6 3893.9 3919.7 3942.3 3945.8 3950.4 3951.4 4505.4 4511.6 4525.7 4542.3 4546.7 5018.7 5068.0 5322.4 5470.7 5600.6 1111.5 1236.2 1236.3 1239.1 1248.5 736.0 807.8 843.9 857.0 861.6 4932.6 5066.8 5096.0 5107.5 5161.7 5041.7 5238.5 5250.5 5264.6 5360.4 4570.3 4808.5 5112.5 5124.6 5164.4 2165.4 2448.7 2763.7 2800.3 2820.8 4670.0 4835.5 5171.8 5216.0 5562.6 4003.1 4922.0 5354.8 5394.6 5593.6 4765.9 5194.4 5454.7 5532.6 5589.1 4464.8 5055.4 5286.2 5393.0 5436.0 4435.8 5147.7 5262.7 5325.5 5440.0 4421.1 4881.6 5861.6 5899.8 5900.7 3804.6 3845.1 3862.6 3876.2 3880.8 4655.7 4957.5 5570.9 5774.0 5808.5 4804.5 5241.8 5433.8 5456.6 5498.9 4586.0 5443.3 5464.5 5465.4 5531.4 4545.7 5135.9 5413.4 5427.4 5496.6 4284.2 4953.5 5113.5 5187.2 5457.4 4486.4 4782.5 5259.3 5318.0 5427.0 07:07:20 INFO - PROCESS | 29386 | 07:07:20 INFO - PROCESS | 29386 | [#5] yui.html Cycles:180 Average:20560.12 Median:4479.53 stddev:30181.02 (673.8%) stddev-sans-first:30228.65 07:07:20 INFO - PROCESS | 29386 | Values: 648.6 769.6 776.4 782.6 796.5 11378.4 15762.6 16437.0 16442.7 16451.9 15092.7 15195.0 15215.0 15216.2 15226.8 830.5 857.1 859.4 861.9 862.6 669.4 692.8 696.2 698.8 699.7 722.1 858.2 883.3 886.3 896.3 882.9 883.8 884.6 884.8 886.6 658.5 658.9 658.9 661.2 661.8 11802.9 12304.3 13686.4 14155.7 14282.7 12930.5 13025.9 13254.1 13378.9 13485.9 10974.0 11076.1 11079.1 11428.5 11569.9 3622.9 3625.9 3647.7 3654.9 3751.7 86334.1 87811.1 88153.0 90149.1 91687.0 10252.9 10254.2 10274.9 10377.2 10642.8 19178.9 19544.7 19754.8 19813.4 19856.4 7310.5 7340.2 7405.9 7493.6 7555.3 4162.7 4219.6 4246.6 4344.2 4393.6 3144.4 3231.1 3243.0 3245.3 3253.6 595.3 596.3 607.9 616.7 616.8 572.6 609.1 625.7 636.4 652.0 9021.4 9049.6 9135.7 9309.4 9497.0 515.4 528.4 545.1 559.3 681.5 3882.9 4419.7 4539.3 4576.0 4611.7 70778.2 88796.6 114623.0 115339.0 123104.4 83433.6 96097.0 98702.5 99341.0 103674.0 90608.5 91213.5 93158.1 95003.5 96272.0 7311.5 8068.7 8594.2 9044.5 9060.9 51705.7 51847.0 54335.9 55834.4 55967.2 57242.0 66639.0 75368.6 78937.0 82273.0 11912.2 12006.5 12033.5 12257.6 12712.6 13696.9 13748.7 14102.9 14455.2 14847.7 13028.2 13209.7 13214.7 13348.7 13707.6 12818.0 13078.4 13183.1 13221.6 13757.6 12678.0 12977.4 13125.1 13356.0 13387.4 10572.8 10858.7 11014.3 11057.7 11265.3 10515.8 11137.5 11214.6 11280.6 11362.4 07:07:20 INFO - PROCESS | 29386 | -------- Summary: end -------- 07:07:20 INFO - PROCESS | 29386 | 07:07:21 INFO - TEST-INFO | 29386: exit 0 07:07:21 INFO - TEST-OK | dromaeo_css | took 1118409ms 07:07:21 INFO - TEST-START | kraken 07:07:21 INFO - operating with platform_type : mac_ 07:07:21 INFO - Initialising browser for kraken test... 07:07:21 INFO - TEST-INFO | started process 29391 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpipaBeQ/profile http://localhost:49356/getInfo.html) 07:07:23 INFO - PROCESS | 29391 | __metrics Screen width/height:1600/1200 07:07:23 INFO - PROCESS | 29391 | colorDepth:24 07:07:23 INFO - PROCESS | 29391 | Browser inner width/height: 1024/689 07:07:23 INFO - PROCESS | 29391 | __metrics 07:07:23 INFO - PROCESS | 29391 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:07:23 INFO - PROCESS | 29391 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:24 INFO - TEST-INFO | 29391: exit 0 07:07:24 INFO - Browser initialized. 07:07:24 INFO - Running cycle 1/1 for kraken test... 07:07:24 INFO - TEST-INFO | started process 29392 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpipaBeQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:36 INFO - PROCESS | 29392 | RSS: Main: 229552128 07:07:36 INFO - PROCESS | 29392 | 07:07:39 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:40 INFO - PROCESS | 29392 | RSS: Main: 289181696 07:07:40 INFO - PROCESS | 29392 | 07:07:43 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-dft) 07:07:43 INFO - PROCESS | 29392 | RSS: Main: 291708928 07:07:43 INFO - PROCESS | 29392 | 07:07:47 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-fft) 07:07:47 INFO - PROCESS | 29392 | RSS: Main: 380268544 07:07:47 INFO - PROCESS | 29392 | 07:07:49 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-oscillator) 07:07:50 INFO - PROCESS | 29392 | RSS: Main: 280969216 07:07:50 INFO - PROCESS | 29392 | 07:07:52 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:53 INFO - PROCESS | 29392 | RSS: Main: 287940608 07:07:53 INFO - PROCESS | 29392 | 07:07:55 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:56 INFO - PROCESS | 29392 | RSS: Main: 328335360 07:07:56 INFO - PROCESS | 29392 | 07:07:59 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:59 INFO - PROCESS | 29392 | RSS: Main: 330432512 07:07:59 INFO - PROCESS | 29392 | 07:08:02 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49356/tests/kraken/driver.html?testName=json-parse-financial) 07:08:03 INFO - PROCESS | 29392 | RSS: Main: 327532544 07:08:03 INFO - PROCESS | 29392 | 07:08:04 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:05 INFO - PROCESS | 29392 | RSS: Main: 304291840 07:08:05 INFO - PROCESS | 29392 | 07:08:07 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:08 INFO - PROCESS | 29392 | RSS: Main: 305958912 07:08:08 INFO - PROCESS | 29392 | 07:08:10 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:10 INFO - PROCESS | 29392 | RSS: Main: 310525952 07:08:10 INFO - PROCESS | 29392 | 07:08:13 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:14 INFO - PROCESS | 29392 | RSS: Main: 318402560 07:08:14 INFO - PROCESS | 29392 | 07:08:17 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:18 INFO - PROCESS | 29392 | RSS: Main: 318746624 07:08:18 INFO - PROCESS | 29392 | 07:08:19 INFO - PROCESS | 29392 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49356/tests/kraken/driver.html?testName=ai-astar) 07:08:20 INFO - PROCESS | 29392 | RSS: Main: 362422272 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | __start_tp_report 07:08:20 INFO - PROCESS | 29392 | _x_x_mozilla_page_load 07:08:20 INFO - PROCESS | 29392 | _x_x_mozilla_page_load_details 07:08:20 INFO - PROCESS | 29392 | |i|pagename|runs| 07:08:20 INFO - PROCESS | 29392 | |0;ai-astar;114;116;115;114;114;115;115;114;115;115 07:08:20 INFO - PROCESS | 29392 | |1;audio-beat-detection;145;113;110;147;113;112;126;110;141;105 07:08:20 INFO - PROCESS | 29392 | |2;audio-dft;185;185;187;184;184;185;183;184;181;183 07:08:20 INFO - PROCESS | 29392 | |3;audio-fft;79;60;59;88;60;59;57;57;83;58 07:08:20 INFO - PROCESS | 29392 | |4;audio-oscillator;88;70;93;71;69;70;90;67;70;94 07:08:20 INFO - PROCESS | 29392 | |5;imaging-gaussian-blur;87;85;87;84;90;130;128;84;87;84 07:08:20 INFO - PROCESS | 29392 | |6;imaging-darkroom;92;93;93;93;92;93;93;93;93;92 07:08:20 INFO - PROCESS | 29392 | |7;imaging-desaturate;85;82;80;79;83;83;85;83;81;84 07:08:20 INFO - PROCESS | 29392 | |8;json-parse-financial;52;54;53;55;55;55;54;54;53;55 07:08:20 INFO - PROCESS | 29392 | |9;json-stringify-tinderbox;67;81;73;75;72;69;72;72;72;74 07:08:20 INFO - PROCESS | 29392 | |10;stanford-crypto-aes;87;86;91;90;89;86;82;85;86;89 07:08:20 INFO - PROCESS | 29392 | |11;stanford-crypto-ccm;144;148;151;154;152;157;150;146;189;189 07:08:20 INFO - PROCESS | 29392 | |12;stanford-crypto-pbkdf2;166;175;175;171;174;173;174;174;174;172 07:08:20 INFO - PROCESS | 29392 | |13;stanford-crypto-sha256-iterative;68;67;68;68;67;69;67;67;66;67 07:08:20 INFO - PROCESS | 29392 | __end_tp_report 07:08:20 INFO - PROCESS | 29392 | __start_cc_report 07:08:20 INFO - PROCESS | 29392 | _x_x_mozilla_cycle_collect,1993 07:08:20 INFO - PROCESS | 29392 | __end_cc_report 07:08:20 INFO - PROCESS | 29392 | __startTimestamp1479136100160__endTimestamp 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | ------- Summary: start ------- 07:08:20 INFO - PROCESS | 29392 | Number of tests: 14 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:08:20 INFO - PROCESS | 29392 | Values: 114.0 116.0 115.0 114.0 114.0 115.0 115.0 114.0 115.0 115.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:119.50 stddev:16.23 (13.6%) stddev-sans-first:14.97 07:08:20 INFO - PROCESS | 29392 | Values: 145.0 113.0 110.0 147.0 113.0 112.0 126.0 110.0 141.0 105.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.60 (0.9%) stddev-sans-first:1.66 07:08:20 INFO - PROCESS | 29392 | Values: 185.0 185.0 187.0 184.0 184.0 185.0 183.0 184.0 181.0 183.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:12.19 (20.3%) stddev-sans-first:11.99 07:08:20 INFO - PROCESS | 29392 | Values: 79.0 60.0 59.0 88.0 60.0 59.0 57.0 57.0 83.0 58.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:79.50 stddev:11.39 (14.3%) stddev-sans-first:11.52 07:08:20 INFO - PROCESS | 29392 | Values: 88.0 70.0 93.0 71.0 69.0 70.0 90.0 67.0 70.0 94.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:86.00 stddev:18.23 (21.2%) stddev-sans-first:19.13 07:08:20 INFO - PROCESS | 29392 | Values: 87.0 85.0 87.0 84.0 90.0 130.0 128.0 84.0 87.0 84.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:08:20 INFO - PROCESS | 29392 | Values: 92.0 93.0 93.0 93.0 92.0 93.0 93.0 93.0 93.0 92.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#7] imaging-desaturate Cycles:10 Average:82.50 Median:83.00 stddev:2.01 (2.4%) stddev-sans-first:1.92 07:08:20 INFO - PROCESS | 29392 | Values: 85.0 82.0 80.0 79.0 83.0 83.0 85.0 83.0 81.0 84.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:1.05 (1.9%) stddev-sans-first:0.83 07:08:20 INFO - PROCESS | 29392 | Values: 52.0 54.0 53.0 55.0 55.0 55.0 54.0 54.0 53.0 55.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.50 stddev:3.71 (5.1%) stddev-sans-first:3.32 07:08:20 INFO - PROCESS | 29392 | Values: 67.0 81.0 73.0 75.0 72.0 69.0 72.0 72.0 72.0 74.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.00 stddev:2.69 (3.1%) stddev-sans-first:2.85 07:08:20 INFO - PROCESS | 29392 | Values: 87.0 86.0 91.0 90.0 89.0 86.0 82.0 85.0 86.0 89.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:153.00 stddev:16.76 (11.0%) stddev-sans-first:16.99 07:08:20 INFO - PROCESS | 29392 | Values: 144.0 148.0 151.0 154.0 152.0 157.0 150.0 146.0 189.0 189.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:2.70 (1.6%) stddev-sans-first:1.33 07:08:20 INFO - PROCESS | 29392 | Values: 166.0 175.0 175.0 171.0 174.0 173.0 174.0 174.0 174.0 172.0 07:08:20 INFO - PROCESS | 29392 | 07:08:20 INFO - PROCESS | 29392 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 07:08:20 INFO - PROCESS | 29392 | Values: 68.0 67.0 68.0 68.0 67.0 69.0 67.0 67.0 66.0 67.0 07:08:20 INFO - PROCESS | 29392 | -------- Summary: end -------- 07:08:20 INFO - PROCESS | 29392 | 07:08:21 INFO - TEST-INFO | 29392: exit 0 07:08:21 INFO - TEST-OK | kraken | took 59999ms 07:08:21 INFO - SUITE-END | took 1178s 07:08:21 INFO - Completed test suite (00:19:38) 07:08:21 INFO - javascript benchmark 07:08:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3242.3515296940614, 3246.983765081174, 3250.869965201392, 3290.226796702776, 3321.6014078310604, 5427.158790387496, 5505.614606977508, 5545.1682247662875, 5649.802256921003, 5662.43375662434, 5498.395176530578, 5612.298462692163, 5630.296212973368, 5697.230873832032, 5704.54363650908, 5106.846794596168, 5123.615728820335, 5130.050940576006, 5144.408393034792, 5176.327077479922, 5153.433122356538, 5259.6055295852775, 5264.0, 5267.23625074364, 5270.9736451317685, 5059.494050594948, 5074.4925507449325, 5190.558802501754, 5246.134387826023, 5258.710770907599, 5088.643794934356, 5155.226715992593, 5155.278261043457, 5177.508136727005, 5189.974050129726, 5048.747562621854, 5109.156989096795, 5119.180931051014, 5130.563902068328, 5133.794648214067, 5138.81807184346, 5625.634333768333, 5647.491725744702, 5650.208970744099, 5653.349864765522, 5923.674197919113, 6007.15899774032, 6027.638341699469, 6036.305824830157, 6124.785632502841, 5486.725663716798, 6001.099835024781, 6129.601575897553, 6186.474149697281, 6211.2857021442205, 4818.349522814446, 5677.460641239076, 5706.77172913083, 5719.14212868069, 5732.484076433057, 6174.536909731788, 6223.941929871932, 6251.12484252205, 6252.093446450239, 6270.0, 5925.851853703692, 5995.400459954057, 5999.400059993965, 6004.879902401927, 6065.302490213682, 6122.663253521099, 6188.783392581328, 6189.195404597373, 6202.689865506707, 6207.534434917399, 5873.588848780544, 6031.459872813399, 6097.207363042865, 6122.142899994004, 6136.6318020918, 5960.523158147338, 6053.818385448443, 6055.394460553909, 6061.090836374491, 6064.939350606437, 4831.975840120847, 4858.125537403231, 4866.391701037371, 4899.730514821647, 4922.409310882717, 4342.174986752507, 4364.454443194601, 4372.868813935587, 4373.103513779667, 4401.2517871961845, 5478.671279723229, 5545.0, 5566.888662226733, 5578.135389014709, 5625.353084395347, 6105.8843398869, 6132.141500189977, 6140.3552626974415, 6145.801568694062, 6223.719932602953, 5626.240457538262, 5647.971760141255, 5648.8870222595315, 5662.207290979266, 5692.772289108472, 5297.655652382583, 5314.92027619586, 5319.361676598755, 5325.147976323847, 5348.251244825728, 6132.662703551258, 6202.937970620236, 6214.9689251553455, 6216.751329946752, 6233.376662333912, 6149.292831324455, 6205.410486003822, 6210.472109870711, 6211.565190436626, 6219.502439804895, 6277.5605707600025, 6285.025820997753, 6286.654234017173, 6290.968545157245, 6299.086632438362, 5877.089051197071, 5972.283326000907, 6026.969865150646, 6055.727492262947, 6060.969635161945, 5038.168702164102, 6117.724702388314, 6128.3503509891225, 6209.037599172136, 6220.129181914626, 4973.254011898244, 5986.521078313812, 5989.970050149721, 5990.670513121646, 6017.037274036134, 5792.391798861059, 5865.120231965239, 5953.196318496947, 6006.249218847644, 6012.819615411545, 5754.280714910637, 5782.45066718661, 5838.2702162229725, 5860.179574859438, 5868.677222752619, 5988.640681559121, 6022.1870047543025, 6025.487833534199, 6030.728617212324, 6032.54755893301, 5672.4894759471845, 5753.597248192586, 5759.424057594207, 5792.21805056312, 5798.304203495608], "value": 5588.862785148347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.87627778638654, 480.71888417367717, 501.6855837705213, 511.483401764218, 513.8432778002708, 28363.858180709092, 38271.61728382715, 39424.0, 39489.210215795705, 39534.60465395345, 40345.39481907774, 40735.796321018424, 40741.59258407415, 40862.59137408625, 40925.0, 9281.582328795204, 9473.952630236874, 9492.857607135898, 9495.857562136573, 9509.476978766164, 9335.673251436201, 9429.622815087423, 9434.292428067922, 9434.386764860263, 9452.102050305244, 9396.436213827192, 9452.8582071269, 9462.195713364372, 9474.384165029285, 9482.905170948306, 9389.014153513885, 9418.717438476857, 9426.717198484022, 9452.385594936308, 9455.621775128986, 9368.67209647659, 9449.52752362386, 9459.479728614924, 9463.621455141785, 9487.288453366025, 38435.231295374215, 38766.030849228715, 38786.0, 38790.41814372787, 38811.41782873259, 2856.3072240481133, 3504.56192975878, 3606.6393360663988, 3779.829907654162, 3943.132510847609, 28716.897181563603, 29436.82252709889, 29675.258118546994, 29755.256118596993, 29795.55306670402, 3117.8908738194054, 3240.141362538929, 3309.040378290293, 3312.4368857294075, 3324.434846076173, 454933.0, 458160.0, 459491.0, 461769.0, 462190.0, 56076.42968199323, 56490.17549122527, 56519.71740141273, 56555.0, 56592.151117733265, 59077.70461147667, 59192.0, 59225.70387148123, 59252.70373648104, 59288.0, 15115.848841511664, 15335.693286134216, 15346.15596142223, 15352.07887526752, 15375.923120384326, 11822.822657660143, 11899.643010709693, 11908.583199587973, 11922.28466292008, 11924.523019079139, 12793.29636869981, 15640.983336083345, 15745.606359841096, 15780.842191578167, 15882.523524294289, 6819.795406137824, 6902.827429314308, 6929.896051559231, 6974.26770189133, 6994.965025174944, 705.3792662457005, 729.8576777528331, 792.6829268292729, 828.9917100829035, 991.2813210422386, 26839.865800670872, 28406.0, 28898.070800522935, 29256.122316330544, 29301.827926883114, 1022.3303736052749, 1039.6101461951769, 1096.5778175402527, 1110.361542113272, 1117.407773879845, 13832.239226842621, 14759.409623615149, 14941.850581494045, 15169.696606068037, 15183.924080379527, 638872.0, 640116.0, 641300.0, 643860.6841794754, 644987.0, 55632.44367556353, 55691.0, 55854.88290234173, 55934.0, 56276.71861640666, 1192.8270400791837, 1233.2846948769693, 1296.805479178112, 1323.7220183761517, 1347.198416941918, 28455.573166402108, 29433.0, 29495.410091797614, 29946.401071978875, 30279.848600756854, 46823.82940426517, 47336.76331618457, 47361.52638473571, 47540.28689569728, 47580.0, 507338.0, 525314.0, 526876.0, 528771.0, 530374.0, 24785.008599655812, 25652.358691032874, 25686.357841054123, 26303.73696263013, 26377.868110659325, 43960.780196098814, 44486.663500236966, 44716.77641611771, 45234.547654523034, 45310.546894530635, 30948.845255773576, 36571.0, 36692.6614677071, 37378.38307161839, 37714.43428348632, 35955.82022089873, 36885.0, 37725.62274377221, 38028.2394352117, 38470.0, 36598.08504787295, 36936.0, 37419.81290093532, 37542.812285938395, 37571.0, 28800.84796608112, 32382.676173237967, 32476.700931962456, 32565.67434325721, 32787.50818737769, 20172.495687607927, 23946.844783969525, 24003.879980599984, 24566.0, 24610.261692149263], "value": 19031.580766463932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.95411596492454, 367.3552914634816, 370.6108585984716, 375.90978165240335, 407.43570155334874, 12934.935325323371, 13251.469941202353, 15234.16212108335, 16697.415590454337, 19287.842729436245, 18811.247550097978, 19134.330298439556, 19647.115879785408, 19858.304959326426, 19878.0, 5561.77752889884, 5910.586258961875, 5927.644341339512, 5933.050711886099, 5937.703114844262, 5577.832665020035, 5760.222369980041, 5788.884222315552, 5865.501432378232, 5896.528277737792, 5801.563343395763, 5808.12878068289, 5810.1865738796605, 5813.796517121901, 5819.912701309484, 5556.222128901957, 5790.33411157718, 5798.681072541009, 5852.034414321632, 5858.238429004245, 5092.694438333712, 5101.4133374662015, 5101.642884998052, 5103.18349064148, 5108.667936584147, 21951.341459756233, 24003.7599624005, 24032.399190020216, 24190.87904560466, 24262.0, 2248.7638797926147, 2323.977449922029, 2352.6000579901456, 2374.5725769361507, 2846.3595690969573, 14460.855391446055, 14547.70904581913, 14689.706205875822, 15241.695166096615, 15384.615384615363, 1606.2370374072339, 1755.2452445448453, 1776.0764402510752, 1796.3114672208212, 1804.143032059761, 98764.0, 100770.0, 102150.9784902149, 103314.0, 103734.48132759288, 10101.494925253708, 10256.17950563968, 10555.89444105549, 10678.476102886028, 10795.78408431827, 13252.0, 13259.337033148304, 13264.270465124511, 13284.070115092045, 13285.468581256642, 7847.362514029181, 8118.512889226666, 8136.959315203504, 8271.95864020676, 8281.21328473794, 8073.192680731997, 8099.676012959533, 8125.578940029241, 8235.8352832943, 8272.007359116824, 6271.0, 6288.685565721696, 6302.306746257908, 6309.179806625109, 6326.588771729823, 1795.9102044897702, 1835.8990255536073, 1836.219606667161, 1837.0814592703648, 1839.4297767692058, 884.4648987362682, 933.3793027636546, 937.8968313485511, 938.0947385772762, 971.3928794503436, 19991.100400482013, 21190.258340957993, 21245.150193992376, 21255.468613284793, 21460.678089828663, 795.3875515852761, 915.0, 937.8968313485511, 975.5658731864253, 1009.4430161958372, 9266.0, 10626.468676566295, 11056.11551075912, 11322.320660760215, 11357.602483913024, 573331.0, 582257.0, 587470.0, 589912.0, 597855.0, 70164.0, 77408.0, 99835.00164998403, 102072.48963755282, 104775.0, 874.2175752701297, 976.3556053004983, 980.352967041749, 980.4313498171043, 981.2052237687496, 14469.638259043188, 18147.27410903549, 18405.907970460063, 18534.86849012381, 18543.072846357896, 29199.7080029197, 40871.79564102161, 41785.373219401125, 43175.0, 43861.122777543635, 59863.70068149632, 60066.69966650139, 60402.791944159995, 60834.39165608287, 61741.0, 6830.487713421414, 7017.158818834633, 7146.392556632744, 7334.486585938933, 7362.374198193, 11527.423628818693, 11953.521859125538, 12195.51217951272, 12219.26684398939, 12243.30647257602, 10249.282550221413, 10385.273030887765, 10702.682168527781, 10815.783684326427, 10900.945495272474, 8909.420887642282, 10170.89829101729, 10444.477776111013, 10594.894051059391, 10789.40658263803, 10504.947475262881, 10646.254762166574, 10838.67483975482, 10877.619283325046, 10990.670279891616, 5968.432998865101, 7172.49792514519, 7175.354218120394, 7229.132504099542, 7359.521631094176, 10377.273590848568, 10544.630937917136, 10671.306365086244, 10716.196285278791, 10796.946015269874], "value": 9098.189369780033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.799330100485, 1472.4331132513985, 1622.8214896361399, 1817.4184261036473, 1845.3080094964396, 8003.479773814698, 8449.281811046054, 8464.534450605213, 8466.153384661538, 8473.745787626365, 7339.559626422419, 7652.617369131535, 7653.961730191355, 7743.806404839882, 7756.457048006641, 2020.969685454723, 2208.094681180716, 2277.6128058230142, 2284.7258329000542, 2300.401895507172, 2317.084751523147, 2336.789688927996, 2342.484653376263, 2349.7650234976536, 2350.8707021113833, 2311.6648086027517, 2328.592496313147, 2330.1727886600265, 2331.3006098170567, 2332.825038122139, 2250.85369450986, 2292.1404473322505, 2293.8050265727434, 2294.8852557372147, 2294.977050229493, 1949.4736421166206, 2287.5310561334886, 2293.7820907013975, 2309.86140831549, 2314.0396735354807, 8260.380471464665, 8291.212334828182, 8367.665293388258, 8369.790755231106, 8377.078521362646, 4964.751762411865, 5128.71792051437, 5134.229865520165, 5136.126858434075, 5144.0740666679985, 2599.922002339933, 3352.3295340931913, 3403.7787543809573, 3414.641462646411, 3431.24512607226, 809.2918696140877, 954.4464210757744, 967.5549247346229, 986.8651051291001, 1033.7722208640391, 10834.837477437844, 10906.345619262791, 10924.563017479211, 10927.180461465343, 10964.780704385868, 4288.0, 4484.080763443486, 4556.567126123013, 4586.839460618862, 4621.815127394933, 9355.625774969061, 9359.34484586086, 9368.344215904957, 9374.531273436301, 9376.29677774156, 5121.308623335802, 5130.0, 5131.1277082895995, 5134.589232861362, 5138.3577052868395, 4556.3621093047, 4595.862124136282, 4653.95346046542, 4716.985848042687, 4718.150732868048, 3134.639516455591, 3649.379605467024, 3710.18375957289, 3734.9066273343383, 3807.1053302473897, 1015.9136473399695, 1226.1355744200318, 1228.6928267933017, 1229.6618429931661, 1249.8562665293425, 801.3469022746559, 826.2563692676639, 844.438448431786, 883.1918794303269, 906.8095699903095, 5100.7959681613065, 5117.667351622207, 5160.0, 5429.56563474921, 5486.259354987105, 412.7523485908431, 430.29002146458595, 430.43827804715147, 438.3074741907778, 438.39939283182247, 3131.3893790710595, 3361.09250502363, 3581.3374525712825, 3627.147620309225, 3670.7614005089586, 9694.806103878023, 9931.0, 10108.646197383056, 10119.342242754197, 10162.39025658463, 10090.12431457046, 10101.646442374482, 10115.342502737445, 10116.24128190374, 10155.086042256233, 6058.333583305833, 6378.872422551616, 7728.381729461629, 7824.256695613793, 7877.7636670899965, 5152.458991805806, 5224.52979231871, 5228.712420816892, 5236.607254455855, 5277.261183434399, 9180.724578262663, 9240.214581760625, 9330.533473326172, 9350.251979841732, 9423.10480504351, 9206.125418085272, 9515.619375224913, 9564.187044101329, 9572.377795443273, 9606.231501479726, 6532.804015879531, 6687.0, 6714.0, 6759.188897332155, 7095.29047095307, 7839.686412543662, 7946.205379462239, 8033.156518565466, 8044.557549334842, 8048.919510804817, 7081.68132434052, 7095.787126386217, 7099.645017748989, 7140.6786694599905, 7191.101112360955, 6890.621015844176, 6954.130733658293, 6971.407430368476, 6985.930140698528, 7006.054182685272, 6443.806685799434, 6466.0, 6472.5145614080075, 6473.0, 6475.514336424692, 4503.852370422516, 4626.491085980472, 4661.300804879295, 4663.7201767892675, 4716.504766999416, 4509.940164061509, 4525.298578720303, 4631.235846085358, 4698.248280275139, 4779.06808172403], "value": 4221.436601590491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.469671030631, 306.0939618728563, 307.35608899355844, 317.577621763055, 319.02060673731654, 4317.596781046157, 5178.689278643279, 5197.090509160891, 5216.321878155839, 5230.2416149658275, 4272.978635106821, 4896.828610998616, 5162.948370516303, 5184.066867963765, 5219.5041471060285, 3773.264213478366, 3884.6892248620184, 3888.786116763577, 3927.1163988102735, 3941.586133455989, 3652.8904132875923, 3778.8474515272833, 3949.4273330367078, 3949.9210015799667, 3992.341263691502, 3929.646331830135, 3954.4266081418177, 3964.4846169998004, 3978.244133614604, 3980.2039592081555, 3443.6728510791436, 3518.1204698825295, 3838.808059597009, 3928.960710392888, 3954.189391174802, 2619.0, 3179.0780673604627, 3467.4798780182923, 3487.424574945131, 3496.35317466267, 4661.82995563017, 5023.497650234984, 5026.648134630577, 5032.4212715537815, 5077.64456488046, 4399.868003959887, 4495.258282383403, 4499.942513509322, 4528.932066019012, 4602.401687780567, 5356.018273238888, 5379.973100134474, 5387.703676297802, 5443.727813609304, 5470.972645136789, 3829.859515197539, 3831.490373805162, 3838.5777564467885, 3854.9421758673643, 3865.4588357629955, 5388.568914486832, 5680.687562184078, 5708.5433165347085, 5721.427857214246, 5755.158349328217, 3274.804696285886, 3829.4447305140598, 3857.0, 3862.6480731743663, 3893.9415908761393, 3919.7256192066284, 3942.3100957332354, 3945.763254204757, 3950.4074388841905, 3951.4072889066297, 4505.43682039745, 4511.571400716926, 4525.728456292633, 4542.318652202196, 4546.681732278708, 5018.749062546858, 5067.974660126676, 5322.361316642027, 5470.671759694431, 5600.60795744294, 1111.5276007696696, 1236.1717649175075, 1236.2568778022944, 1239.1387985350275, 1248.5005997600852, 735.9632018399059, 807.7899746066065, 843.8860753798282, 857.0058731871125, 861.6424183963585, 4932.585336124149, 5066.771995260222, 5096.0, 5107.538963211467, 5161.74191290434, 5041.697498150123, 5238.5023422774775, 5250.527452529291, 5264.5782939848095, 5360.437154098841, 4570.291604801261, 4808.519148085164, 5112.539871411591, 5124.590032797368, 5164.354455693038, 2165.375968023982, 2448.747152619594, 2763.72362763722, 2800.2719292983566, 2820.8448535330754, 4670.0, 4835.468098509161, 5171.844844654666, 5215.965773348397, 5562.638428502134, 4003.079291762853, 4922.0, 5354.759035843396, 5394.595405344615, 5593.552515798727, 4765.904681906342, 5194.3766747990485, 5454.7272636368025, 5532.640378375473, 5589.077802162597, 4464.821407143808, 5055.368078990126, 5286.233496143114, 5393.0, 5435.994341046919, 4435.756033418193, 5147.6911385317, 5262.657927234717, 5325.547328477122, 5440.020796256712, 4421.09367579639, 4881.609471242221, 5861.648301101947, 5899.823005309848, 5900.675462849585, 3804.619538046173, 3845.134844659929, 3862.613738626227, 3876.2053778974678, 3880.80595970206, 4655.650826187982, 4957.454679985127, 5570.916436253378, 5774.036827478677, 5808.477237048686, 4804.5195480451675, 5241.816536421207, 5433.755481003285, 5456.645318054314, 5498.945010549844, 4585.9541404585525, 5443.265159203615, 5464.453554644504, 5465.426130256265, 5531.419200984, 4545.727256364628, 5135.87160320995, 5413.431589683184, 5427.371788463524, 5496.560275178056, 4284.243460181436, 4953.529414705597, 5113.514216149609, 5187.236339644388, 5457.399686034612, 4486.371907932958, 4782.508768598873, 5259.316288882421, 5318.0, 5427.0], "value": 3934.3460890653887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.597869321021, 769.55750443495, 776.378896882494, 782.5539442517763, 796.5499492786579, 11378.431078446076, 15762.605934851621, 16437.0, 16442.67114657706, 16451.930624509412, 15092.698146037073, 15195.0, 15215.0, 15216.163111028916, 15226.847731522681, 830.4809494066209, 857.0957639690156, 859.3511898516642, 861.9094995025526, 862.6333808131519, 669.3841665667574, 692.8233300508389, 696.1785093589588, 698.7903628911332, 699.6991293743688, 722.0901663903467, 858.2318824651933, 883.3330835219432, 886.3485338276362, 896.3456676626067, 882.898466676334, 883.7746374674449, 884.6196135661663, 884.8186121845006, 886.5877367024365, 658.5094104891838, 658.9077529145924, 658.9176352955881, 661.206552137437, 661.8113837556274, 11802.94098529502, 12304.323262220574, 13686.384112714952, 14155.716885662332, 14282.714345713131, 12930.54743083997, 13025.934870325587, 13254.072214944958, 13378.86621133786, 13485.865141348657, 10974.0, 11076.11391088711, 11079.113670906308, 11428.485718142703, 11569.884301156964, 3622.873199438033, 3625.8549658013912, 3647.726420518445, 3654.945175822365, 3751.6998640108727, 86334.13665863324, 87811.12188878158, 88153.0, 90149.09850901473, 91687.0, 10252.897471025195, 10254.179665626882, 10274.897251027394, 10377.169826413869, 10642.787144257072, 19178.945158016442, 19544.706829397284, 19754.802451975585, 19813.405597832087, 19856.404307870787, 7310.4517161213125, 7340.229275926058, 7405.851882962418, 7493.625318734042, 7555.320021198118, 4162.666986641061, 4219.599138081878, 4246.596573325529, 4344.218040752695, 4393.582609652078, 3144.371125774854, 3231.1114443528218, 3242.9946716517957, 3245.2860370718404, 3253.577034985437, 595.2767387624058, 596.2993482657946, 607.8662694207268, 616.6669998201011, 616.7995401494533, 572.6277919352455, 609.1471939284947, 625.6954250387901, 636.3699937062275, 651.9576227545289, 9021.413608115452, 9049.592768325441, 9135.675327077537, 9309.44143351401, 9497.0, 515.4458956621646, 528.3870709976409, 545.1305168256624, 559.3018643395429, 681.5399605266425, 3882.9223415531533, 4419.734815911055, 4539.3271890321175, 4576.0, 4611.677182597253, 70778.23054423681, 88796.5560172195, 114623.0, 115339.0, 123104.38447807703, 83433.58283208667, 96097.0, 98702.50648746711, 99341.00658993462, 103674.0, 90608.54695726479, 91213.54393227858, 93158.06841931494, 95003.52498237464, 96272.0, 7311.451641127043, 8068.687492836672, 8594.226519613265, 9044.50255235942, 9060.909390906007, 51705.7414712924, 51847.0, 54335.91328173335, 55834.44165558292, 55967.16049259346, 57242.0, 66639.0, 75368.62315688387, 78937.0, 82273.0, 11912.225705329125, 12006.519739210335, 12033.518659253532, 12257.570985015482, 12712.555060572835, 13696.911773489948, 13748.65628359299, 14102.929485352508, 14455.204963726675, 14847.703045939237, 13028.218306901616, 13209.735805284034, 13214.735705286033, 13348.666283342605, 13707.588772336845, 12818.0, 13078.411471483616, 13183.14309569875, 13221.603351899459, 13757.587272381845, 12678.0, 12977.416016279101, 13125.081244312807, 13356.0, 13387.409872434924, 10572.84140737905, 10858.728531786768, 11014.284071535325, 11057.723556911142, 11265.267757596057, 10515.842262365917, 11137.498812553293, 11214.607488737855, 11280.570075057138, 11362.375069371265], "value": 7233.661097964723, "unit": "score"}], "name": "dromaeo_css", "value": 6986.325347531667, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 110.0, 147.0, 113.0, 112.0, 126.0, 110.0, 141.0, 105.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 187.0, 184.0, 184.0, 185.0, 183.0, 184.0, 181.0, 183.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 88.0, 60.0, 59.0, 57.0, 57.0, 83.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 71.0, 69.0, 70.0, 90.0, 67.0, 70.0, 94.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 90.0, 130.0, 128.0, 84.0, 87.0, 84.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 80.0, 79.0, 83.0, 83.0, 85.0, 83.0, 81.0, 84.0], "value": 82.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 55.0, 55.0, 55.0, 54.0, 54.0, 53.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 73.0, 75.0, 72.0, 69.0, 72.0, 72.0, 72.0, 74.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 91.0, 90.0, 89.0, 86.0, 82.0, 85.0, 86.0, 89.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 148.0, 151.0, 154.0, 152.0, 157.0, 150.0, 146.0, 189.0, 189.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 175.0, 175.0, 171.0, 174.0, 173.0, 174.0, 174.0, 174.0, 172.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 67.0, 67.0, 66.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1447.0000000000002, "alertThreshold": 2.0}]} 07:08:21 INFO - Return code: 0 07:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:08:21 INFO - # TBPL SUCCESS # 07:08:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:08:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:08:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:08:21 INFO - 2016-11-14 07:08:21.480 screenresolution[29396:271681] starting screenresolution argv=screenresolution get 07:08:21 INFO - 2016-11-14 07:08:21.483 screenresolution[29396:271681] Display 0: 1600x1200x32@60 07:08:21 INFO - 2016-11-14 07:08:21.489 screenresolution[29397:271684] starting screenresolution argv=screenresolution list 07:08:21 INFO - Available Modes on Display 0 07:08:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:08:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:08:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:08:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:08:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:08:21 INFO - Intel Iris: 07:08:21 INFO - Chipset Model: Intel Iris 07:08:21 INFO - Type: GPU 07:08:21 INFO - Bus: Built-In 07:08:21 INFO - VRAM (Dynamic, Max): 1536 MB 07:08:21 INFO - Vendor: Intel (0x8086) 07:08:21 INFO - Device ID: 0x0a2e 07:08:21 INFO - Revision ID: 0x0009 07:08:21 INFO - Displays: 07:08:21 INFO - Display: 07:08:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:08:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:08:21 INFO - Display Serial Number: 1600x1200 60 07:08:21 INFO - Main Display: Yes 07:08:21 INFO - Mirror: Off 07:08:21 INFO - Online: Yes 07:08:21 INFO - Rotation: Supported 07:08:21 INFO - Return code: 0 07:08:21 INFO - Running post-action listener: _resource_record_post_action 07:08:21 INFO - [mozharness: 2016-11-14 15:08:21.731147Z] Finished run-tests step (success) 07:08:21 INFO - Running post-run listener: _resource_record_post_run 07:08:21 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 30227456; Write bytes: 701066240; Read time: 179; Write time: 2029 07:08:21 INFO - TinderboxPrint: CPU usage
54.0% 07:08:21 INFO - TinderboxPrint: I/O read bytes / time
30,227,456 / 179 07:08:21 INFO - TinderboxPrint: I/O write bytes / time
701,066,240 / 2,029 07:08:21 INFO - TinderboxPrint: CPU idle
2,232.2 (46.0%) 07:08:21 INFO - TinderboxPrint: CPU system
981.3 (20.2%) 07:08:21 INFO - TinderboxPrint: CPU user
1,640.3 (33.8%) 07:08:21 INFO - TinderboxPrint: Swap in / out
423,268,352 / 0 07:08:21 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 393765376; Write bytes: 388429312; Read time: 29639; Write time: 842 07:08:21 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29953024; Write bytes: 298317312; Read time: 175; Write time: 1140 07:08:22 INFO - Running post-run listener: _upload_blobber_files 07:08:22 INFO - Blob upload gear active. 07:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:22 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 07:08:22 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'] 07:08:22 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 07:08:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:23 INFO - (blobuploader) - INFO - Done attempting. 07:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:24 INFO - (blobuploader) - INFO - Done attempting. 07:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:27 INFO - (blobuploader) - INFO - Done attempting. 07:08:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:27 INFO - Return code: 0 07:08:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac076ca6f3085ce41ee82768b4874d070dc02821a447d6e63d5542965d915a84eb86b6192d581484418de676468ff6581c5cfa4ee607c9b2d09706302c8af432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2af62719166b85dec48ec603bdff287ed8dff2c94e25043fbb9efa36adfe026eb2a90bb997a0fac34f171cbf03e42da26a1970c1a2642c91fdd8545b8a84846c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162ba5701f9577090f2b9f6f172dcc7cb95cb3b6fa38db1bdefaa7bc194adcbb45f62d1be079d0e741430d55bba66a8a1825b7315132d63211c940e670e36d6a"} 07:08:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:27 INFO - Contents: 07:08:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac076ca6f3085ce41ee82768b4874d070dc02821a447d6e63d5542965d915a84eb86b6192d581484418de676468ff6581c5cfa4ee607c9b2d09706302c8af432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2af62719166b85dec48ec603bdff287ed8dff2c94e25043fbb9efa36adfe026eb2a90bb997a0fac34f171cbf03e42da26a1970c1a2642c91fdd8545b8a84846c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162ba5701f9577090f2b9f6f172dcc7cb95cb3b6fa38db1bdefaa7bc194adcbb45f62d1be079d0e741430d55bba66a8a1825b7315132d63211c940e670e36d6a"} 07:08:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:27 INFO - Copying logs to upload dir... 07:08:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.737082 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 07:08:27.459363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:08:27.465409) ========= 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.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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/ac076ca6f3085ce41ee82768b4874d070dc02821a447d6e63d5542965d915a84eb86b6192d581484418de676468ff6581c5cfa4ee607c9b2d09706302c8af432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2af62719166b85dec48ec603bdff287ed8dff2c94e25043fbb9efa36adfe026eb2a90bb997a0fac34f171cbf03e42da26a1970c1a2642c91fdd8545b8a84846c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162ba5701f9577090f2b9f6f172dcc7cb95cb3b6fa38db1bdefaa7bc194adcbb45f62d1be079d0e741430d55bba66a8a1825b7315132d63211c940e670e36d6a"} build_url:https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011027 build_url: 'https://queue.taskcluster.net/v1/task/Kc1nacDcTSqPETfIU7L0-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac076ca6f3085ce41ee82768b4874d070dc02821a447d6e63d5542965d915a84eb86b6192d581484418de676468ff6581c5cfa4ee607c9b2d09706302c8af432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2af62719166b85dec48ec603bdff287ed8dff2c94e25043fbb9efa36adfe026eb2a90bb997a0fac34f171cbf03e42da26a1970c1a2642c91fdd8545b8a84846c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162ba5701f9577090f2b9f6f172dcc7cb95cb3b6fa38db1bdefaa7bc194adcbb45f62d1be079d0e741430d55bba66a8a1825b7315132d63211c940e670e36d6a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:08:27.497664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:08:27.498005) ========= 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.6ggeB47Xfd/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.0n2RAEekXF/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.005346 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:08:27.546885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:08:27.547221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:08:27.547584) ========= ========= Total master_lag: 0.20 =========