builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1478904145.14 results: success (0) buildid: 20161111122119 builduid: 658fa4b43b4e4b5f8263dfe6b73452bb revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.141465) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.141914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.142206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.203074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.203429) ========= 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.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-11 14:42:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.58M=0.001s 2016-11-11 14:42:25 (9.58 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.320305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.320607) ========= 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.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.027533 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:25.371875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-11 14:42:25.372235) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --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 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-11 14:42:25,452 truncating revision to first 12 chars 2016-11-11 14:42:25,452 Setting DEBUG logging. 2016-11-11 14:42:25,452 attempt 1/10 2016-11-11 14:42:25,452 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d1c54f240d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 14:42:27,323 unpacking tar archive at: mozilla-central-5d1c54f240d0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.135463 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-11 14:42:27.533461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:27.533763) ========= script_repo_revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:27.534154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:27.534415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 14:42:27.555585) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-11 14:42:27.556171) ========= /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.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:42:27 INFO - MultiFileLogger online at 20161111 14:42:27 in /builds/slave/test 14:42:27 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 14:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:42:27 INFO - {'append_to_log': False, 14:42:27 INFO - 'base_work_dir': '/builds/slave/test', 14:42:27 INFO - 'blob_upload_branch': 'Firefox', 14:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:42:27 INFO - 'branch': 'Firefox', 14:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:42:27 INFO - 'config_files': ('talos/mac_config.py',), 14:42:27 INFO - 'default_actions': ('clobber', 14:42:27 INFO - 'read-buildbot-config', 14:42:27 INFO - 'download-and-extract', 14:42:27 INFO - 'populate-webroot', 14:42:27 INFO - 'create-virtualenv', 14:42:27 INFO - 'install', 14:42:27 INFO - 'run-tests'), 14:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:42:27 INFO - 'download_minidump_stackwalk': True, 14:42:27 INFO - 'download_symbols': 'ondemand', 14:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:42:27 INFO - 'installer_path': 'installer.exe', 14:42:27 INFO - 'log_level': 'info', 14:42:27 INFO - 'log_name': 'talos', 14:42:27 INFO - 'log_to_console': True, 14:42:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:42:27 INFO - 'opt_config_files': (), 14:42:27 INFO - 'pip_index': False, 14:42:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:42:27 INFO - 'cmd': ('bash', 14:42:27 INFO - '-c', 14:42:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:42:27 INFO - 'enabled': True, 14:42:27 INFO - 'halt_on_failure': False, 14:42:27 INFO - 'name': 'check_screen_resolution'},), 14:42:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:42:27 INFO - 'cmd': ('bash', 14:42:27 INFO - '-c', 14:42:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:42:27 INFO - 'enabled': True, 14:42:27 INFO - 'halt_on_failure': False, 14:42:27 INFO - 'name': 'check_screen_resolution'},), 14:42:27 INFO - 'run_cmd_checks_enabled': True, 14:42:27 INFO - 'sps_profile': False, 14:42:27 INFO - 'sps_profile_interval': 0, 14:42:27 INFO - 'suite': 'dromaeojs', 14:42:27 INFO - 'system_bits': '32', 14:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:42:27 INFO - 'title': 't-yosemite-r7-0084', 14:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:42:27 INFO - 'use_talos_json': True, 14:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:42:27 INFO - 'work_dir': 'build'} 14:42:27 INFO - [mozharness: 2016-11-11 22:42:27.768140Z] Running clobber step. 14:42:27 INFO - Running pre-action listener: _resource_record_pre_action 14:42:27 INFO - Running main action method: clobber 14:42:27 INFO - rmtree: /builds/slave/test/build 14:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:42:30 INFO - Running post-action listener: _resource_record_post_action 14:42:30 INFO - [mozharness: 2016-11-11 22:42:30.084515Z] Finished clobber step (success) 14:42:30 INFO - [mozharness: 2016-11-11 22:42:30.084643Z] Running read-buildbot-config step. 14:42:30 INFO - Running pre-action listener: _resource_record_pre_action 14:42:30 INFO - Running main action method: read_buildbot_config 14:42:30 INFO - Using buildbot properties: 14:42:30 INFO - { 14:42:30 INFO - "project": "", 14:42:30 INFO - "product": "firefox", 14:42:30 INFO - "script_repo_revision": "production", 14:42:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:42:30 INFO - "repository": "", 14:42:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:42:30 INFO - "buildid": "20161111122119", 14:42:30 INFO - "pgo_build": "False", 14:42:30 INFO - "basedir": "/builds/slave/test", 14:42:30 INFO - "buildnumber": 5, 14:42:30 INFO - "slavename": "t-yosemite-r7-0084", 14:42:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:42:30 INFO - "platform": "yosemite_r7", 14:42:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:42:30 INFO - "branch": "mozilla-central", 14:42:30 INFO - "repo_path": "mozilla-central", 14:42:30 INFO - "revision": "5d1c54f240d077b6b8e141fd44b52a3b694a5dfd", 14:42:30 INFO - "stage_platform": "macosx64", 14:42:30 INFO - "builduid": "658fa4b43b4e4b5f8263dfe6b73452bb", 14:42:30 INFO - "slavebuilddir": "test" 14:42:30 INFO - } 14:42:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:42:30 INFO - Running post-action listener: _resource_record_post_action 14:42:30 INFO - [mozharness: 2016-11-11 22:42:30.087979Z] Finished read-buildbot-config step (success) 14:42:30 INFO - [mozharness: 2016-11-11 22:42:30.088090Z] Running download-and-extract step. 14:42:30 INFO - Running pre-action listener: _resource_record_pre_action 14:42:30 INFO - Running main action method: download_and_extract 14:42:30 INFO - mkdir: /builds/slave/test/build/tests 14:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:30 INFO - trying https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:42:30 INFO - Downloading https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:42:31 INFO - Downloaded 1199 bytes. 14:42:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:42:31 INFO - Using the following test package requirements: 14:42:31 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:42:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:42:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:42:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'jsshell-mac.zip'], 14:42:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:42:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:42:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:42:31 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:42:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:42:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:42:31 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:42:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:42:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:42:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:42:31 INFO - Fetch https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:42:32 INFO - Http code: 200 14:42:32 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 14:42:32 INFO - x-amz-cf-id: M5P5srGzOJH8jHW3CMv1ndrymbp6EtD-IueUtpo3PghXntCsVNaUiQ== 14:42:32 INFO - x-amz-version-id: q7p2XC1sqvYq8szf0kLZV1qBbbI9F0kY 14:42:32 INFO - Expected file size: 16328577 14:42:32 INFO - Obtained file size: 16328577 14:42:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:42:39 INFO - Http code: 200 14:42:39 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 14:42:39 INFO - x-amz-cf-id: 2cQiF6VCjsxyvNs4ndDzRzXqs7Gw1IdZcCF87-_S5NcCQRLmcXIO5A== 14:42:39 INFO - x-amz-version-id: q7p2XC1sqvYq8szf0kLZV1qBbbI9F0kY 14:42:39 INFO - Expected file size: 16328577 14:42:39 INFO - Obtained file size: 16328577 14:42:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:42:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:42:46 INFO - Fetch https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:42:46 INFO - Http code: 200 14:42:46 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 14:42:46 INFO - x-amz-cf-id: 7BkfiX4NDuDKKOIizijeXiokoem-G27C_2B2tLmTPykDtdMvW5xusg== 14:42:46 INFO - x-amz-version-id: IK.yl9NKomQStBqKspt0WL7ic0wF_Dro 14:42:47 INFO - Expected file size: 14409038 14:42:47 INFO - Obtained file size: 14409038 14:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:47 INFO - trying https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:42:50 INFO - Downloaded 110998128 bytes. 14:42:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:42:50 INFO - mkdir: /builds/slave/test/properties 14:42:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:42:50 INFO - Writing to file /builds/slave/test/properties/build_url 14:42:50 INFO - Contents: 14:42:50 INFO - build_url:https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:42:51 INFO - Running post-action listener: _resource_record_post_action 14:42:51 INFO - Running post-action listener: set_extra_try_arguments 14:42:51 INFO - [mozharness: 2016-11-11 22:42:51.048094Z] Finished download-and-extract step (success) 14:42:51 INFO - [mozharness: 2016-11-11 22:42:51.048218Z] Running populate-webroot step. 14:42:51 INFO - Running pre-action listener: _resource_record_pre_action 14:42:51 INFO - Running main action method: populate_webroot 14:42:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:42:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:42:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:42:51 INFO - '--tppagecycles', 14:42:51 INFO - '7'], 14:42:51 INFO - 'tests': ['tsvgm']}}, 14:42:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:42:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:42:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:42:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:42:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['damp', 'tps']}, 14:42:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'tests': ['damp', 'tps']}, 14:42:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['dromaeo_dom']}, 14:42:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:42:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['basic_compositor_video']}, 14:42:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:42:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['a11yr', 14:42:51 INFO - 'ts_paint', 14:42:51 INFO - 'tpaint', 14:42:51 INFO - 'sessionrestore', 14:42:51 INFO - 'sessionrestore_no_auto_restore', 14:42:51 INFO - 'tabpaint']}, 14:42:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['tsvgx', 14:42:51 INFO - 'tsvgr_opacity', 14:42:51 INFO - 'tart', 14:42:51 INFO - 'tscrollx', 14:42:51 INFO - 'cart']}, 14:42:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:42:51 INFO - 'tsvgr_opacity', 14:42:51 INFO - 'tart', 14:42:51 INFO - 'tscrollx', 14:42:51 INFO - 'cart']}, 14:42:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'talos_options': ['--disable-e10s'], 14:42:51 INFO - 'tests': ['tp5o']}, 14:42:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'tests': ['tp5o']}, 14:42:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'talos_options': ['--disable-e10s', 14:42:51 INFO - '--xperf_path', 14:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:51 INFO - 'tests': ['tp5n']}, 14:42:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:51 INFO - 'talos_options': ['--xperf_path', 14:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:51 INFO - 'tests': ['tp5n']}}, 14:42:51 INFO - 'talos.zip': {'path': '', 14:42:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:42:51 INFO - Running post-action listener: _resource_record_post_action 14:42:51 INFO - [mozharness: 2016-11-11 22:42:51.067382Z] Finished populate-webroot step (success) 14:42:51 INFO - [mozharness: 2016-11-11 22:42:51.067515Z] Running create-virtualenv step. 14:42:51 INFO - Running pre-action listener: _resource_record_pre_action 14:42:51 INFO - Running main action method: create_virtualenv 14:42:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:42:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:42:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:42:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:42:51 INFO - Using real prefix '/tools/python27' 14:42:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:42:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:42:54 INFO - Installing pip.................done. 14:42:54 INFO - Return code: 0 14:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:42:55 INFO - Reading from file tmpfile_stdout 14:42:55 INFO - Output received: 14:42:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:42:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:55 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:42:55 INFO - 'HOME': '/Users/cltbld', 14:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:42:55 INFO - 'LOGNAME': 'cltbld', 14:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:55 INFO - 'MOZ_NO_REMOTE': '1', 14:42:55 INFO - 'NO_EM_RESTART': '1', 14:42:55 INFO - 'PAGER': '/bin/cat', 14:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:55 INFO - 'PWD': '/builds/slave/test', 14:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:42:55 INFO - 'SHELL': '/bin/bash', 14:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:42:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:42:55 INFO - 'USER': 'cltbld', 14:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:55 INFO - 'XPC_FLAGS': '0x0', 14:42:55 INFO - 'XPC_SERVICE_NAME': '0', 14:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:42:55 INFO - Cleaning up... 14:42:55 INFO - Return code: 0 14:42:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:55 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:42:55 INFO - 'HOME': '/Users/cltbld', 14:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:42:55 INFO - 'LOGNAME': 'cltbld', 14:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:55 INFO - 'MOZ_NO_REMOTE': '1', 14:42:55 INFO - 'NO_EM_RESTART': '1', 14:42:55 INFO - 'PAGER': '/bin/cat', 14:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:55 INFO - 'PWD': '/builds/slave/test', 14:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:42:55 INFO - 'SHELL': '/bin/bash', 14:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:42:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:42:55 INFO - 'USER': 'cltbld', 14:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:55 INFO - 'XPC_FLAGS': '0x0', 14:42:55 INFO - 'XPC_SERVICE_NAME': '0', 14:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:55 INFO - Downloading/unpacking psutil>=3.1.1 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:42:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:58 INFO - Installing collected packages: psutil 14:42:58 INFO - Running setup.py install for psutil 14:42:59 INFO - building 'psutil._psutil_osx' extension 14:42:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:42:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:42:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:42:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:42:59 INFO - building 'psutil._psutil_posix' extension 14:42:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:42:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:42:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:42:59 INFO - ^ 14:43:00 INFO - 1 warning generated. 14:43:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:00 INFO - Successfully installed psutil 14:43:00 INFO - Cleaning up... 14:43:00 INFO - Return code: 0 14:43:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:43:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:00 INFO - 'HOME': '/Users/cltbld', 14:43:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:00 INFO - 'LOGNAME': 'cltbld', 14:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:00 INFO - 'MOZ_NO_REMOTE': '1', 14:43:00 INFO - 'NO_EM_RESTART': '1', 14:43:00 INFO - 'PAGER': '/bin/cat', 14:43:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:00 INFO - 'PWD': '/builds/slave/test', 14:43:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:00 INFO - 'SHELL': '/bin/bash', 14:43:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:00 INFO - 'USER': 'cltbld', 14:43:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:00 INFO - 'XPC_FLAGS': '0x0', 14:43:00 INFO - 'XPC_SERVICE_NAME': '0', 14:43:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:03 INFO - Installing collected packages: mozsystemmonitor 14:43:03 INFO - Running setup.py install for mozsystemmonitor 14:43:03 INFO - Successfully installed mozsystemmonitor 14:43:03 INFO - Cleaning up... 14:43:03 INFO - Return code: 0 14:43:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:03 INFO - 'HOME': '/Users/cltbld', 14:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:03 INFO - 'LOGNAME': 'cltbld', 14:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:03 INFO - 'MOZ_NO_REMOTE': '1', 14:43:03 INFO - 'NO_EM_RESTART': '1', 14:43:03 INFO - 'PAGER': '/bin/cat', 14:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:03 INFO - 'PWD': '/builds/slave/test', 14:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:03 INFO - 'SHELL': '/bin/bash', 14:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:03 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:03 INFO - 'USER': 'cltbld', 14:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:03 INFO - 'XPC_FLAGS': '0x0', 14:43:03 INFO - 'XPC_SERVICE_NAME': '0', 14:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:43: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 14:43: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 14:43: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 14:43: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 14:43: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 14:43: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 14:43:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:06 INFO - warning: no files found matching '*.txt' 14:43:06 INFO - no previously-included directories found matching 'build' 14:43:06 INFO - no previously-included directories found matching 'dist' 14:43:06 INFO - no previously-included directories found matching '.git*' 14:43:06 INFO - Installing collected packages: jsonschema, functools32 14:43:06 INFO - Running setup.py install for functools32 14:43:06 INFO - warning: no files found matching '*.txt' 14:43:06 INFO - no previously-included directories found matching 'build' 14:43:06 INFO - no previously-included directories found matching 'dist' 14:43:06 INFO - no previously-included directories found matching '.git*' 14:43:06 INFO - Successfully installed jsonschema functools32 14:43:06 INFO - Cleaning up... 14:43:06 INFO - Return code: 0 14:43:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:06 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:06 INFO - 'HOME': '/Users/cltbld', 14:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:06 INFO - 'LOGNAME': 'cltbld', 14:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:06 INFO - 'MOZ_NO_REMOTE': '1', 14:43:06 INFO - 'NO_EM_RESTART': '1', 14:43:06 INFO - 'PAGER': '/bin/cat', 14:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:06 INFO - 'PWD': '/builds/slave/test', 14:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:06 INFO - 'SHELL': '/bin/bash', 14:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:06 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:06 INFO - 'USER': 'cltbld', 14:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:06 INFO - 'XPC_FLAGS': '0x0', 14:43:06 INFO - 'XPC_SERVICE_NAME': '0', 14:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:43:07 INFO - Cleaning up... 14:43:07 INFO - Return code: 0 14:43:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43: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')]} 14:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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')]} 14:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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', '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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:43: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 blobuploader==1.2.4 14:43:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:07 INFO - 'HOME': '/Users/cltbld', 14:43:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:07 INFO - 'LOGNAME': 'cltbld', 14:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:07 INFO - 'MOZ_NO_REMOTE': '1', 14:43:07 INFO - 'NO_EM_RESTART': '1', 14:43:07 INFO - 'PAGER': '/bin/cat', 14:43:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:07 INFO - 'PWD': '/builds/slave/test', 14:43:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:07 INFO - 'SHELL': '/bin/bash', 14:43:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:07 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:07 INFO - 'USER': 'cltbld', 14:43:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:07 INFO - 'XPC_FLAGS': '0x0', 14:43:07 INFO - 'XPC_SERVICE_NAME': '0', 14:43:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:11 INFO - Downloading docopt-0.6.1.tar.gz 14:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:11 INFO - Running setup.py install for blobuploader 14:43:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:11 INFO - Running setup.py install for requests 14:43:11 INFO - Running setup.py install for docopt 14:43:12 INFO - Successfully installed blobuploader requests docopt 14:43:12 INFO - Cleaning up... 14:43:12 INFO - Return code: 0 14:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:12 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:12 INFO - 'HOME': '/Users/cltbld', 14:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:12 INFO - 'LOGNAME': 'cltbld', 14:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:12 INFO - 'MOZ_NO_REMOTE': '1', 14:43:12 INFO - 'NO_EM_RESTART': '1', 14:43:12 INFO - 'PAGER': '/bin/cat', 14:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:12 INFO - 'PWD': '/builds/slave/test', 14:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:12 INFO - 'SHELL': '/bin/bash', 14:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:12 INFO - 'USER': 'cltbld', 14:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:12 INFO - 'XPC_FLAGS': '0x0', 14:43:12 INFO - 'XPC_SERVICE_NAME': '0', 14:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Qt4ixT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-h2t8rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ismXZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5011EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qoEYRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FMNU5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UEA6Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZpdRnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uaifAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-2CFR2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LccgFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3fPYFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JHYrlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-7M7NIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-df8BYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jXFr2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TKMY99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:14 INFO - Running setup.py install for manifestparser 14:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:14 INFO - Running setup.py install for mozcrash 14:43:14 INFO - Running setup.py install for mozdebug 14:43:14 INFO - Running setup.py install for mozdevice 14:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:14 INFO - Running setup.py install for mozfile 14:43:14 INFO - Running setup.py install for mozhttpd 14:43:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Running setup.py install for mozinfo 14:43:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Running setup.py install for mozInstall 14:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Running setup.py install for mozleak 14:43:15 INFO - Running setup.py install for mozlog 14:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Running setup.py install for moznetwork 14:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:15 INFO - Running setup.py install for mozprocess 14:43:15 INFO - Running setup.py install for mozprofile 14:43:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:16 INFO - Running setup.py install for mozrunner 14:43:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:16 INFO - Running setup.py install for mozscreenshot 14:43:16 INFO - Running setup.py install for moztest 14:43:16 INFO - Running setup.py install for mozversion 14:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:16 INFO - Cleaning up... 14:43:16 INFO - Return code: 0 14:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:17 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:17 INFO - 'HOME': '/Users/cltbld', 14:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:17 INFO - 'LOGNAME': 'cltbld', 14:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:17 INFO - 'MOZ_NO_REMOTE': '1', 14:43:17 INFO - 'NO_EM_RESTART': '1', 14:43:17 INFO - 'PAGER': '/bin/cat', 14:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:17 INFO - 'PWD': '/builds/slave/test', 14:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:17 INFO - 'SHELL': '/bin/bash', 14:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:17 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:17 INFO - 'USER': 'cltbld', 14:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:17 INFO - 'XPC_FLAGS': '0x0', 14:43:17 INFO - 'XPC_SERVICE_NAME': '0', 14:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jd0ruH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pqrGVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jOIP3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YvfPRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-aWxQFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vMCtbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-HFQkKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-D15YtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Ni2DJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-7B3Kp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-yLZVPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5Eva46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:19 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MoyOG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:19 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cP2LLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:19 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RQGSrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:19 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_5CAx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:19 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)) 14:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:19 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RxPFyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:43:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:22 INFO - Downloading blessings-1.6.tar.gz 14:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:43:22 INFO - Installing collected packages: blessings 14:43:22 INFO - Running setup.py install for blessings 14:43:22 INFO - Successfully installed blessings 14:43:22 INFO - Cleaning up... 14:43:22 INFO - Return code: 0 14:43:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:23 INFO - Reading from file tmpfile_stdout 14:43:23 INFO - Current package versions: 14:43:23 INFO - blessings == 1.6 14:43:23 INFO - blobuploader == 1.2.4 14:43:23 INFO - docopt == 0.6.1 14:43:23 INFO - functools32 == 3.2.3-2 14:43:23 INFO - jsonschema == 2.5.1 14:43:23 INFO - manifestparser == 1.1 14:43:23 INFO - mozInstall == 1.12 14:43:23 INFO - mozcrash == 1.0 14:43:23 INFO - mozdebug == 0.1 14:43:23 INFO - mozdevice == 0.48 14:43:23 INFO - mozfile == 1.2 14:43:23 INFO - mozhttpd == 0.7 14:43:23 INFO - mozinfo == 0.9 14:43:23 INFO - mozleak == 0.1 14:43:23 INFO - mozlog == 3.4 14:43:23 INFO - moznetwork == 0.27 14:43:23 INFO - mozprocess == 0.23 14:43:23 INFO - mozprofile == 0.28 14:43:23 INFO - mozrunner == 6.13 14:43:23 INFO - mozscreenshot == 0.1 14:43:23 INFO - mozsystemmonitor == 0.3 14:43:23 INFO - moztest == 0.7 14:43:23 INFO - mozversion == 1.4 14:43:23 INFO - psutil == 3.1.1 14:43:23 INFO - requests == 1.2.3 14:43:23 INFO - wsgiref == 0.1.2 14:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:23 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:23 INFO - 'HOME': '/Users/cltbld', 14:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:23 INFO - 'LOGNAME': 'cltbld', 14:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:23 INFO - 'MOZ_NO_REMOTE': '1', 14:43:23 INFO - 'NO_EM_RESTART': '1', 14:43:23 INFO - 'PAGER': '/bin/cat', 14:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:23 INFO - 'PWD': '/builds/slave/test', 14:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:23 INFO - 'SHELL': '/bin/bash', 14:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:23 INFO - 'USER': 'cltbld', 14:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:23 INFO - 'XPC_FLAGS': '0x0', 14:43:23 INFO - 'XPC_SERVICE_NAME': '0', 14:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:43:23 INFO - Cleaning up... 14:43:23 INFO - Return code: 0 14:43:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:23 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 0x102a21490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102997570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1a59aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, '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.oHP5rqBKxw/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.Td4veI2K71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:23 INFO - 'HOME': '/Users/cltbld', 14:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:23 INFO - 'LOGNAME': 'cltbld', 14:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:23 INFO - 'MOZ_NO_REMOTE': '1', 14:43:23 INFO - 'NO_EM_RESTART': '1', 14:43:23 INFO - 'PAGER': '/bin/cat', 14:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:23 INFO - 'PWD': '/builds/slave/test', 14:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:23 INFO - 'SHELL': '/bin/bash', 14:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:23 INFO - 'USER': 'cltbld', 14:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:23 INFO - 'XPC_FLAGS': '0x0', 14:43:23 INFO - 'XPC_SERVICE_NAME': '0', 14:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:43:23 INFO - Cleaning up... 14:43:23 INFO - Return code: 0 14:43:23 INFO - Running post-action listener: _resource_record_post_action 14:43:23 INFO - Running post-action listener: _start_resource_monitoring 14:43:23 INFO - Starting resource monitoring. 14:43:23 INFO - [mozharness: 2016-11-11 22:43:23.657787Z] Finished create-virtualenv step (success) 14:43:23 INFO - [mozharness: 2016-11-11 22:43:23.658777Z] Running install step. 14:43:23 INFO - Running pre-action listener: _resource_record_pre_action 14:43:23 INFO - Running main action method: install 14:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:23 INFO - Reading from file tmpfile_stdout 14:43:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:43:24 INFO - Reading from file tmpfile_stdout 14:43:24 INFO - Output received: 14:43:24 INFO - Usage: mozinstall [options] installer 14:43:24 INFO - Options: 14:43:24 INFO - -h, --help show this help message and exit 14:43:24 INFO - -d DEST, --destination=DEST 14:43:24 INFO - Directory to install application into. [default: 14:43:24 INFO - "/builds/slave/test"] 14:43:24 INFO - --app=APP Application being installed. [default: firefox] 14:43:24 INFO - mkdir: /builds/slave/test/build/application 14:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:43:57 INFO - Reading from file tmpfile_stdout 14:43:57 INFO - Output received: 14:43:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:43:57 INFO - Running post-action listener: _resource_record_post_action 14:43:57 INFO - [mozharness: 2016-11-11 22:43:57.866017Z] Finished install step (success) 14:43:57 INFO - [mozharness: 2016-11-11 22:43:57.866145Z] Running run-tests step. 14:43:57 INFO - Running pre-action listener: _resource_record_pre_action 14:43:57 INFO - Running main action method: run_tests 14:43:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:43:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:43:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:43:57 INFO - 2016-11-11 14:43:57.880 screenresolution[1639:7589] starting screenresolution argv=screenresolution get 14:43:57 INFO - 2016-11-11 14:43:57.883 screenresolution[1639:7589] Display 0: 1600x1200x32@60 14:43:57 INFO - 2016-11-11 14:43:57.888 screenresolution[1640:7591] starting screenresolution argv=screenresolution list 14:43:57 INFO - Available Modes on Display 0 14:43:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:43:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:43:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:43:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:43:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:43:58 INFO - Intel Iris: 14:43:58 INFO - Chipset Model: Intel Iris 14:43:58 INFO - Type: GPU 14:43:58 INFO - Bus: Built-In 14:43:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:43:58 INFO - Vendor: Intel (0x8086) 14:43:58 INFO - Device ID: 0x0a2e 14:43:58 INFO - Revision ID: 0x0009 14:43:58 INFO - Displays: 14:43:58 INFO - Display: 14:43:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:43:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:43:58 INFO - Display Serial Number: 1600x1200 60 14:43:58 INFO - Main Display: Yes 14:43:58 INFO - Mirror: Off 14:43:58 INFO - Online: Yes 14:43:58 INFO - Rotation: Supported 14:43:58 INFO - Return code: 0 14:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:43:58 INFO - Python 2.7.3 14:43:58 INFO - Return code: 0 14:43:58 INFO - grabbing minidump binary from tooltool 14:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:58 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 0x102835d30>, '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 0x10265bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10282db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:43:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:43:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:43:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:43:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:43:58 INFO - Return code: 0 14:43:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:43:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:43:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:43:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:43:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:43:58 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/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 14:43:58 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/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 14:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHP5rqBKxw/Render', 14:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:58 INFO - 'HOME': '/Users/cltbld', 14:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:58 INFO - 'LOGNAME': 'cltbld', 14:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:58 INFO - 'MOZ_NO_REMOTE': '1', 14:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:43:58 INFO - 'NO_EM_RESTART': '1', 14:43:58 INFO - 'PAGER': '/bin/cat', 14:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:58 INFO - 'PWD': '/builds/slave/test', 14:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:58 INFO - 'SHELL': '/bin/bash', 14:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Td4veI2K71/Listeners', 14:43:58 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:58 INFO - 'USER': 'cltbld', 14:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:58 INFO - 'XPC_FLAGS': '0x0', 14:43:58 INFO - 'XPC_SERVICE_NAME': '0', 14:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:58 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/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 14:43:58 INFO - mozversion application_buildid: 20161111122119 14:43:58 INFO - mozversion application_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 14:43:58 INFO - mozversion application_display_name: Nightly 14:43:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:43:58 INFO - mozversion application_name: Firefox 14:43:58 INFO - mozversion application_remotingname: firefox 14:43:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:43:58 INFO - mozversion application_vendor: Mozilla 14:43:58 INFO - mozversion application_version: 52.0a1 14:43:58 INFO - mozversion platform_buildid: 20161111122119 14:43:58 INFO - mozversion platform_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 14:43:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:43:58 INFO - mozversion platform_version: 52.0a1 14:43:58 INFO - using testdate: 1478904238 14:43:58 INFO - actual date: 1478904238 14:43:58 INFO - starting webserver on 'localhost:49267' 14:43:58 INFO - SUITE-START | Running 2 tests 14:43:58 INFO - TEST-START | dromaeo_css 14:43:58 INFO - operating with platform_type : mac_ 14:43:58 INFO - Initialising browser for dromaeo_css test... 14:43:58 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp8HlU3l/profile http://localhost:49267/getInfo.html) 14:44:00 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 14:44:00 INFO - PROCESS | 1650 | colorDepth:24 14:44:00 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 14:44:00 INFO - PROCESS | 1650 | __metrics 14:44:00 INFO - PROCESS | 1650 | 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" 14:44:00 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:44:01 INFO - TEST-INFO | 1650: exit 0 14:44:01 INFO - Browser initialized. 14:44:01 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:01 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp8HlU3l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:13 INFO - PROCESS | 1652 | RSS: Main: 230617088 14:44:13 INFO - PROCESS | 1652 | 14:45:04 INFO - PROCESS | 1652 | 1478904304567 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] 14:47:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 14:47:19 INFO - PROCESS | 1652 | RSS: Main: 396124160 14:47:19 INFO - PROCESS | 1652 | 14:50:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 14:50:23 INFO - PROCESS | 1652 | RSS: Main: 372244480 14:50:23 INFO - PROCESS | 1652 | 14:53:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 14:53:26 INFO - PROCESS | 1652 | RSS: Main: 338423808 14:53:26 INFO - PROCESS | 1652 | 14:56:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 14:56:29 INFO - PROCESS | 1652 | RSS: Main: 338178048 14:56:29 INFO - PROCESS | 1652 | 14:59:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:59:33 INFO - PROCESS | 1652 | RSS: Main: 336277504 14:59:33 INFO - PROCESS | 1652 | 15:02:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 15:02:37 INFO - PROCESS | 1652 | RSS: Main: 379289600 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | __start_tp_report 15:02:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 15:02:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 15:02:37 INFO - PROCESS | 1652 | |i|pagename|runs| 15:02:37 INFO - PROCESS | 1652 | |0;dojo.html;3248.8700451981913;3262;3272.5745653065105;3292.489664102065;3307.9834600826994;5386.057439948013;5483.945160548394;5568.303962004749;5587.580931430144;5597.496225339719;5368.30212072431;5440.3743569489525;5467.316585426822;5484.177373393993;5519.668819870801;4989.750512474371;4999.425066117388;5002.424721157059;5067.619928505358;5076.84769456915;5023.196288593826;5104.259882317062;5129.999650068219;5153.458886816887;5156.664816786915;5117.283580298761;5126.333576635032;5137.332146820908;5155.252488389181;5201.141811601081;4964.478729733362;5012.298278241049;5020.874478138039;5024.84925452237;5067.391912970467;5051.545360917535;5056.367954005749;5070.543651071422;5104.846854594368;5126.5642420394315;5448.782048718046;5489.176623506506;5569.832905012856;5575.526080283181;5601.159826026129;5895.086261629454;5993.6104153230335;6001.459868611846;6065.181200537959;6071.939280607182;5045;6037.607555508878;6043.274807023141;6133.867031338107;6142.682951206343;5619.297587801525;5632.802851900164;5639;5653.57598180134;5657.179708942181;5905.645661260338;6188.783392581238;6198.659073750897;6215.378462153749;6219.689015549205;5693.202951586781;5711.485966263056;5716.599838011382;5770.16332631766;5785.074388097884;5913.319968203626;5917.940820591825;5923.763049477972;5931;5954.970225148846;5810.970945145247;5823.82528524145;5833.183354330397;5834.066549352084;5842.298924129047;5837.503812176013;5867.559933005042;5879.735411906475;5879.9710050741805;5888.5289176865745;4742.69172503793;4767.308740232646;4772.093302272627;4775.785089670973;4779.02030083832;4204.936925946114;4214.009707718745;4220.092680073799;4244.893877653083;4327.783610819446;5232.529072383504;5550.611457198038;5553.972230138905;5604.747786349624;5619.690916999604;6081.118237855486;6110.052941793941;6112.083187521907;6120;6123.9387606124255;5473.7263136843;5543.113101903676;5547.55619550435;5549.1676248563035;5603.7478313475995;5289.127293996525;5289.576833853283;5291.947080529222;5295.12630415977;5329.440408757102;6206.782762603378;6215.440610345;6222.595531290452;6229.688515574203;6236.18929539157;5653.886922261449;5914.911276330945;5983.34183239852;6009.909851352146;6067.211262535842;6048.36492168316;6115.785947491817;6139.277491147187;6155.47678447337;6158.815235542941;5852.648841069549;5957.702114894151;5961.91057134152;5981.671008094597;6006.669633170218;6069.211002569814;6071.119687645179;6085.4523092921845;6086.995645718584;6122.877542449215;5647.774089036392;5715.685637289989;5823.388544202967;5830.970845145747;5857.179994800646;5750.079987202028;5759.452851979056;5804.303483581828;5832.825015249549;5851.912221316598;5687.004774164422;5697.601167918206;5700.743466544099;5713.342965558848;5718.942810571841;5604.551635869202;5696.373398926197;5853.9121913172185;5870.295564532284;5870.618409803349;5605.915911261416;5703.315602127605;5715.142728590745;5717.42825717425;5717.714114294352 15:02:37 INFO - PROCESS | 1652 | |1;ext.html;477.50578151613075;493.86912468195914;496.43902390298956;519.3456245131135;523.9921401178985;30259.697403025963;38259.42610860836;39902;39913;39996.00009999752;41216.58783412165;41489;41595;41744.37383439251;41749.95625109374;8336.541490218036;9219.907800921988;9394.906050939471;9407.20038796703;9423.963364029985;8356.916430835674;10930.836037459445;11181;11187.4965626547;11348.773024539505;11166.274192177483;11232.719182020433;11239.157063220291;11256.606018789344;11278.774424511505;11097;11153.72115697114;11176.720581985515;11177.105831533458;11181.776364472746;11051.447427628586;11053.613123540637;11055.613053543088;11094.445277736162;11100.111991040698;38657.80671096655;38952;38988;38989.805050974566;39087.609123908966;3302.091924720697;3349.949750753741;3437.346904088215;3498.1954150545516;3621.4567814827724;28620.284492887637;29110.41779164405;29766.553501697494;29812.254693632614;29932;3140.6231252249877;3267.673232676737;3303.620083690382;3342.097633638928;3344.414727422691;460502;461273;461500;461967;463392.68303658604;58248.12627810586;58578.535536611926;58618.706906465195;58782.11826822515;58803.70598147067;61333.32000080009;61469;61526.69236653788;61550.38449615536;61565.69217153885;15493.535193944199;15787.28957196929;15798.447054353042;15809.683806323808;15810.288537015862;10911.56353745857;11247.775044499063;12207.267563946192;12265.57070502528;12274.447649855778;16144.919275403783;16585.336586536403;16606.086665233528;16959.91520042392;16965.066921319445;5626.437356264422;7049.3655570997835;7101.360877521048;7153.6780844862105;7176.641167941582;823.7322870067132;842.616609442702;933.9866245124116;1004.7086344960026;1041.3387498938077;26653.80057897399;28622.28444288868;28676.713232867405;29197.562036569467;29600.851995739882;937.1237892570468;1011.3527342500805;1042.489180301662;1069.8769641491328;1087.244365166202;14015.85984140166;14690.26548672562;14730.263486825615;14861.256937153099;15053.247337633074;623821;625728;626398;630656;827881;46529.76735116303;54197;56297;56344.591385215695;59335.70332148398;1317.0714646174424;1331.9400626971615;1358.0900796466392;1359.232033900843;1367.7401293754156;29536.704632953395;29918;30137.547936780527;30144.397112058075;30298.5237401226;49298.75350623224;49905;50025.74987125041;50115;50144;536650.5339786365;540348;540702;540873;541331.5866841282;25518.362040949123;25934.74065259323;25936.20180266657;25949.481010380063;26003;43958.56041439545;44349.77825110854;44584.331235030855;44910.87722806825;45591.54408456005;37288.44067339046;37336.81331593324;38131.237375252895;39016.219675606895;39059;36869.44695829511;37323.440148397254;38198.80900595479;38301.80849095848;38584.6141538581;36823.44764828476;37035.6296437043;37232.62767372291;37686.62313376831;37831.24337513289;31872.840635797602;33118.337633246716;33264.83367583244;33402;33550.32899342048;20835.791642083386;24062.51874962456;24305.392365190306;24320.756792432556;24849 15:02:37 INFO - PROCESS | 1652 | |2;jquery.html;319.5574129830186;347.66971377191675;367.0658174944765;368.7160886117688;404.1532988389325;14531.564053078399;14893.255337233135;15695.764563531542;19647.214111435525;20117.497062573442;16173.919130404362;19302.4209273722;19936.800631993676;20197.697034544457;20263.797362026413;5477.287952566161;5874.911876321838;5883.235179426669;5887.1463637772495;5900.967330717129;5476.58925580581;5646.802361917313;5676.858078548049;5729.312482502085;5746.655200687972;4824.252240902648;5697.6866272355;5705.400932902048;5710.200571919934;5717.542596592283;5499.697516636564;5700.572457065737;5788.5369170466265;5853.970730146365;5906.173135760997;5461.1262198048125;5683.715814209273;5697.1739097831;5697.6011679182475;5714.657120572779;23750.881245593835;23945.521089578284;24401.633975490382;24494.877525612435;24661.506769864503;2156.3962090614655;2234.9776502235095;2253.6844841722173;2301.689271948282;2314.4329639238495;9141.542922853898;10083.848742268872;10122.746931326703;14450.566483005421;15095.622609434742;1822.6354729054242;1824.708046712533;1833.8441232495254;1879.1919474625906;1901.2585091814203;86158.84602884915;98056;109206;112244.19389515246;113937.01220457327;10948.781024379468;11027.117830573696;11119.277246979082;11232.943835280772;11326;13976.790348144787;13978;13997;14003.159810411407;14006;8009.599520023976;8167.305779008851;8171.836563268701;8189.385796065319;8321.625526851307;6866.828329291808;8000.799980000546;8141.796455088552;8170.673173073129;8185.058718247358;4356.324769660708;4372.060007098426;4389.758563279051;4442.690195804146;4506.977465112719;1830.514913547911;1838.1544489534963;1888.8016758240462;1891.810818918097;1920.9519762005782;853.1511146409363;884.3234925282164;884.4472204871955;907.3920473282916;932.4917919733762;19505.609887802166;20852.478688032617;20895.26866559663;20921;21193.682094768592;874.3442418186361;884.540039179623;886.2909672262293;891.2869704236584;895.7178488776015;7694.807629809187;8217.83564328722;10569.418681972411;10640.946795265974;10889.945550272198;538942;540921;547425;552066;554479;95251;111373;122648.38675806564;138291;142382;971.961121555144;1003.2174903575223;1006.1095930101912;1006.119645310368;1026.1124127629696;18711.906440467712;18968.905155474135;19154.7126793101;19203.32788352401;19245.615087698447;52726.736366319456;57188.71405642945;57596;58623;58864.411355885895;80754;82086;83821;84899.00068011358;85018;6527.281998980204;7792.259735325135;8058.516489010443;8108.270255677017;8337.916620833957;9841;10218.437985910847;10517.316374435637;11772.882271177179;12922.160059596095;11294.887051129384;11447.542098315975;11631.127665424958;11701.88298117008;11824.40877956116;9993.400395976265;10310.948445257725;10421.426821524585;11119.83320250213;11270.549178032787;11276.041536469493;11343.432828358715;11692.47383867711;11806.645800625995;11809.468573914022;6996.930030699627;7312.634368281671;7329.1937886833475;7541.622918854145;7884.21157884207;9334.906650933404;11435.59975400857;11518.07855371585;11559.075273977893;11591.24656897299 15:02:37 INFO - PROCESS | 1652 | |3;mootools.html;1470.1179292424547;1502.9849701502985;1656.5610113319972;1805.151578757985;1829.0488945748202;7930.960345198273;8198.46709963852;8200.42597018209;8207.548584827831;8312.459690120138;7414.258574142583;7680.807979800507;7909.762707118782;8133;8183.549904755236;2286.8399212055206;2318.6174281243575;2319.536092781442;2322.0479603362623;2326.569584626841;1973.2994786850677;2286.325533967484;2290.1869836208157;2322.036354912709;2342.508073304608;2274.5792028474784;2284.0635339510804;2299.034405549665;2306.5617532668825;2310.560993411255;2259.062489067035;2261.819054475646;2279.441536823489;2287.9199228026937;2292.16336037346;2266.614675505152;2289.3132060381986;2291.7937385635205;2294.4952110535655;2297.8161747060194;8185.386096042821;8234.588270586506;8287.337013038943;8290.253877151024;8324.334053275723;5015.39815222172;5176.249443830623;5176.844694659167;5178.275041494194;5180.8963820723375;3063.5711000459955;3131.3111115554543;3309.834508274601;3313.784604000756;3314.685104915029;1041.2242879055152;1048.2180293500994;1077.4343469678404;1090.939998300093;1091.4706367411877;10623.043926046694;10764.784704305948;10814.675559733221;10817.080548153417;10832.458377081115;4395.846145384896;4493.7977790999485;4582.266837306015;4591.874990627251;4601.7699115044115;9080.954595226982;9263.008453182598;9281.39670921388;9294.488803115893;9299;5177.275181474596;5178.378594568676;5183.559397451183;5184.766685499161;5185.377754669388;4223.176480586256;4385.9912220189535;4433.623142032963;4623.56076172763;4676.158291507561;2946.896858609938;3680.7975561343846;3730;3764.3976963685677;3775.9433608495897;1227.613301809927;1246.5823948977013;1248.3570960955115;1257.459292504232;1261.8738126187309;833.7748807821854;840.4621042532784;891.505214605887;893.1470445724318;922.276013329533;5363.410024897258;5444.003540491918;5708.429157084258;5712;5819.272590926134;759.4266328921628;877.972771856929;905.6422713028448;921.9400738952081;986.7730422002979;3466.913327166841;3692.8736735295993;3822.0444888777806;3901.3367727486398;4025.6175663311938;9898.752531186634;9902.851457228147;10132.037456441627;10137.949310253402;10171.23715721309;10074.445905475122;10107.343022703648;10109.443980581138;10120.949395252977;10123.088921996909;7347.926520734831;7679;7687.807804804925;7748.302652761278;7763.417743669134;4905.847125925333;5476.945230547643;5557.609119154414;5656.095024796013;5704.657720536781;8157.3881958852135;9024.729258122266;9161.77095572616;9208.217301529445;9297.907020929704;9359.719208423758;9396.107369799858;9437.811243775224;9460.668876589287;9575.90424095778;6053.394660534088;6541.803745887631;6773.491988100814;6902.792916212522;7023.648817558999;7709.421793365408;7875.409344299086;7907.169747176694;7920.920790792018;7933.206679332021;6985.755498557526;7057.929420705727;7079.1505019398;7133;7260.237675044044;6966.059581956371;6990.790276291719;6994.965025175045;6997.160340759141;7074.151101867808;6556.442702370352;6593.736250549924;6660.83347916306;6664.766733164316;6705.899411508929;4748.762561871962;4778.187708089564;4824.107540105092;4844.636652251166;4942.57988071018;4727.881802954954;4813.470518243061;4828.927566086441;4884.780184891617;4948.418603257731 15:02:37 INFO - PROCESS | 1652 | |4;prototype.html;297.3028248756665;297.96424429068514;309.11438728044146;310.9875604975801;313.26382999950107;4740.786664600093;4889.902201955959;4957.3059771632;5132.640715149941;5239.318888544489;3721.8139093045306;4223.7465752054895;4396.7361958282445;4980.534635355504;5065.772040258188;3889.3193691104016;3972.503437070366;3972.6623237024887;3979.7214195006363;3980.084580546476;3279.9016029519153;3440.1743581540377;3740.6259374062647;3982.701297402692;3999.2601368746873;3570.9465707616314;3933.252681990413;3935.429362742401;3948.2300951314505;3988.8803335899825;3083.691630836921;3904.570497245301;3932.429797679349;3942.5071866016747;3943;2839.361143742662;3429.4567444649756;3451.620321764604;3471.7743346682387;3496.965030349689;4721.598664113554;5010.774515146827;5042.621803364726;5054.721990290533;5060.974695126538;4039.6162364575316;4214.630245170332;4494.460664720222;4498.482674492442;4519.751413672247;4486.730796152241;5432.75552600134;5459.754311055973;5460.624628286669;5465.316835395575;3361.596608407007;3488.023353461035;3513.91215219619;3743.2887751327435;3753.1555400035045;4634.907301853944;4890.070886531583;5486.451354864522;5689.544836413118;5693.306693306693;3143.0570828751283;3763.1344790697744;3822.6559609635265;3829.5213098362706;3830.540335159799;3719.795411252407;3808.562015368268;3824.617538246209;3880.165764360676;3883.475730776309;4419.801108950105;4438.578335058164;4455.532169122261;4458.9331160032625;4500.819967201341;4772.5227477252;4773.761311934459;5036.992601479646;5476.58925580583;5544.889102217933;1135.9659210223706;1154.440096553171;1232.2175418609247;1248.4070066718236;1252.5741247975732;724.6594100772734;773.9264769846856;842.6643769625213;853.7481442974338;862.607513581319;3922.607739226112;4128.947118484767;4477.910441791146;4842.782074806642;4866.926996095061;4717.528247175255;5274;5285.550728188147;5293.682379057269;5364.30264065669;4779.139754844092;4796.098360491852;5245.370555533361;5255.842324730264;5322.92015619766;2293.9311820645407;2721.700612932576;2819.6737691404674;2827.3073097091346;2837.3615936414553;4578.496365399803;5276;5514.476124768141;5540.889182216333;5556.638818476786;5475.7262136893;5475.863103422366;5502.532284755761;5513.889722205614;5543.586385471679;4643.003508491313;5440.06236632222;5475.890482190334;5527.8894422112135;5554.861128471821;4571.725696458223;5320.574354051744;5335.359756829205;5341.839744807662;5356.919646205232;4288.292431748727;4669.953300466952;4735.242361222326;4773.44378438052;5338.386085600206;5007.524285192901;5384.626920135341;5499.7250137492165;5503.752331145028;5536.422119695867;3165.857536410821;3464.636213197679;3565.5899571549603;3581.6060233373787;3614.4759009942886;5124.769385377593;5175.792968281377;5257.106291930305;5298.761555729924;5342.530804028923;4067.877963661095;4436.95731503103;4932.950670493393;5222.451642577626;5225.451327610698;4768.76156192196;4922.704637721748;5059.974700126476;5151.536361727312;5174.6119041071315;4277.401163837128;4423.6239919605905;5011.141421105655;5047.4952504749235;5284.524392804512;4443.844465443694;5343.706096164593;5506.504414602545;5507.228987941611;5535.201059655547;5112.463191364853;5355.491228333302;5361.651492652965;5374.823196605381;5383.7846486140115 15:02:37 INFO - PROCESS | 1652 | |5;yui.html;693.2997672350925;696.1472196559213;719.8452332748458;744.5346658338539;789.5539020453446;14057;14596.124232546055;14608.70782584349;14612.561623151323;14620.634484137901;12957.157784743986;13073.738525229513;13085.21488710678;13091.738165236713;13092.47630094795;596.836169469534;625.9655718935456;636.1761518833122;783.9412044096687;792.2829838995718;800.671724592917;800.7077416742906;813.7518056992615;813.9593020348989;814.1573471457043;865.1002956924791;878.9033206347297;880.4365206267994;882.8013696918206;884.5798245833209;681.2948598200887;703.8240439889976;839.7774589733725;869.6695255802817;870.277669534285;617.8609812792131;639.2999665366416;642.2742301199661;642.3961476212345;642.7204166187723;13083.672908177277;13270.800937985938;13313.733725325439;13415.86584134156;13433.86566134336;12480.126391152622;12512.687182820411;12772.680682982907;12798.744025119538;12879.356032198446;11844.631073785278;11882.168248222628;11899.107566932515;11915.2255103418;12314.876851231462;4280.657547396201;4289.4852617685765;4356.825726970949;4473.664475164375;4484.260097083978;80464;81116.18883811204;81165.59417202877;81368.59315703443;82104.30530626077;10182.18542516597;10226.488675566192;10231.181505479544;10275.948620256851;10432.217583681255;18378.724319135225;18403.81596184048;19083.80916190848;19087.713684294748;19101.713474297896;7112.288771122846;7337.779866604011;7423.220561840929;7461.030066091374;7477.962610186914;3664.029032306441;4030.9596904031173;4200.180964711913;4316.201502722007;4323.135372925428;3074.461969155389;3167.4298626247037;3188.85650145744;3226.3386005868742;3246.2858171202297;613.4601550635413;621.183144165421;622.0668996505242;640.2061443809642;642.293477175113;491.3514161307112;568.7923907773633;594.4887396838715;610.7251736718495;637.9585326953733;8382.287505562095;8562.315014798802;8926.910730892738;8988.146126118008;9008.324375671851;576.6280748916926;592.8754961458142;647.970841312142;654.1136759690646;666.4601672645173;3953.011747063234;4022.316206244887;4055.0982865290466;4059.91880162401;4171.49942006955;68407;70922;76534;103807.48096259471;122206;47933.28100078501;57379;63727;85830.57084714537;88069.23861522862;55465.44534554683;56029.43970560324;73405;73671.63164184253;78101;8075.394345423999;8280;8994.38912399399;9712.852188340192;9760.869673722571;37982.43026354552;41368.51788892676;47189.29216061693;49295;52159;63672;73500.52998940098;77661;79140;79520.60239698764;10421.322614030063;10555.655099643767;10719.14246860265;11201.71995700114;11227.438628068727;11566.47950842231;12034;12148.514059437524;12310.384480776105;12483.31341776211;10970.232083754061;11102.222844401138;11147.554097835995;11450.599229026944;11486.368249746343;11397.829032564352;11629.418529073682;11753.647390578297;11990.040796736415;12016.33910134951;11057;11350.262232954832;11448.427578621202;11634.883651163718;11853.288802671867;8125.553094579618;8228.094909559824;8858.867116993122;8875.73372798817;8883.24492418126;8912.019677835562;9358.953205234202;9481.336306458481;9542.618295268112;9578.395374986307 15:02:37 INFO - PROCESS | 1652 | __end_tp_report 15:02:37 INFO - PROCESS | 1652 | __start_cc_report 15:02:37 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1654 15:02:37 INFO - PROCESS | 1652 | __end_cc_report 15:02:37 INFO - PROCESS | 1652 | __startTimestamp1478905357243__endTimestamp 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | ------- Summary: start ------- 15:02:37 INFO - PROCESS | 1652 | Number of tests: 6 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5537.92 Median:5696.37 stddev:602.53 (10.6%) stddev-sans-first:577.00 15:02:37 INFO - PROCESS | 1652 | Values: 3248.9 3262.0 3272.6 3292.5 3308.0 5386.1 5483.9 5568.3 5587.6 5597.5 5368.3 5440.4 5467.3 5484.2 5519.7 4989.8 4999.4 5002.4 5067.6 5076.8 5023.2 5104.3 5130.0 5153.5 5156.7 5117.3 5126.3 5137.3 5155.3 5201.1 4964.5 5012.3 5020.9 5024.8 5067.4 5051.5 5056.4 5070.5 5104.8 5126.6 5448.8 5489.2 5569.8 5575.5 5601.2 5895.1 5993.6 6001.5 6065.2 6071.9 5045.0 6037.6 6043.3 6133.9 6142.7 5619.3 5632.8 5639.0 5653.6 5657.2 5905.6 6188.8 6198.7 6215.4 6219.7 5693.2 5711.5 5716.6 5770.2 5785.1 5913.3 5917.9 5923.8 5931.0 5955.0 5811.0 5823.8 5833.2 5834.1 5842.3 5837.5 5867.6 5879.7 5880.0 5888.5 4742.7 4767.3 4772.1 4775.8 4779.0 4204.9 4214.0 4220.1 4244.9 4327.8 5232.5 5550.6 5554.0 5604.7 5619.7 6081.1 6110.1 6112.1 6120.0 6123.9 5473.7 5543.1 5547.6 5549.2 5603.7 5289.1 5289.6 5291.9 5295.1 5329.4 6206.8 6215.4 6222.6 6229.7 6236.2 5653.9 5914.9 5983.3 6009.9 6067.2 6048.4 6115.8 6139.3 6155.5 6158.8 5852.6 5957.7 5961.9 5981.7 6006.7 6069.2 6071.1 6085.5 6087.0 6122.9 5647.8 5715.7 5823.4 5831.0 5857.2 5750.1 5759.5 5804.3 5832.8 5851.9 5687.0 5697.6 5700.7 5713.3 5718.9 5604.6 5696.4 5853.9 5870.3 5870.6 5605.9 5703.3 5715.1 5717.4 5717.7 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:68592.41 Median:20222.45 stddev:151041.14 (746.9%) stddev-sans-first:151378.27 15:02:37 INFO - PROCESS | 1652 | Values: 477.5 493.9 496.4 519.3 524.0 30259.7 38259.4 39902.0 39913.0 39996.0 41216.6 41489.0 41595.0 41744.4 41750.0 8336.5 9219.9 9394.9 9407.2 9424.0 8356.9 10930.8 11181.0 11187.5 11348.8 11166.3 11232.7 11239.2 11256.6 11278.8 11097.0 11153.7 11176.7 11177.1 11181.8 11051.4 11053.6 11055.6 11094.4 11100.1 38657.8 38952.0 38988.0 38989.8 39087.6 3302.1 3349.9 3437.3 3498.2 3621.5 28620.3 29110.4 29766.6 29812.3 29932.0 3140.6 3267.7 3303.6 3342.1 3344.4 460502.0 461273.0 461500.0 461967.0 463392.7 58248.1 58578.5 58618.7 58782.1 58803.7 61333.3 61469.0 61526.7 61550.4 61565.7 15493.5 15787.3 15798.4 15809.7 15810.3 10911.6 11247.8 12207.3 12265.6 12274.4 16144.9 16585.3 16606.1 16959.9 16965.1 5626.4 7049.4 7101.4 7153.7 7176.6 823.7 842.6 934.0 1004.7 1041.3 26653.8 28622.3 28676.7 29197.6 29600.9 937.1 1011.4 1042.5 1069.9 1087.2 14015.9 14690.3 14730.3 14861.3 15053.2 623821.0 625728.0 626398.0 630656.0 827881.0 46529.8 54197.0 56297.0 56344.6 59335.7 1317.1 1331.9 1358.1 1359.2 1367.7 29536.7 29918.0 30137.5 30144.4 30298.5 49298.8 49905.0 50025.7 50115.0 50144.0 536650.5 540348.0 540702.0 540873.0 541331.6 25518.4 25934.7 25936.2 25949.5 26003.0 43958.6 44349.8 44584.3 44910.9 45591.5 37288.4 37336.8 38131.2 39016.2 39059.0 36869.4 37323.4 38198.8 38301.8 38584.6 36823.4 37035.6 37232.6 37686.6 37831.2 31872.8 33118.3 33264.8 33402.0 33550.3 20835.8 24062.5 24305.4 24320.8 24849.0 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33019.71 Median:333.61 stddev:91496.09 (27425.8%) stddev-sans-first:91719.82 15:02:37 INFO - PROCESS | 1652 | Values: 319.6 347.7 367.1 368.7 404.2 14531.6 14893.3 15695.8 19647.2 20117.5 16173.9 19302.4 19936.8 20197.7 20263.8 5477.3 5874.9 5883.2 5887.1 5901.0 5476.6 5646.8 5676.9 5729.3 5746.7 4824.3 5697.7 5705.4 5710.2 5717.5 5499.7 5700.6 5788.5 5854.0 5906.2 5461.1 5683.7 5697.2 5697.6 5714.7 23750.9 23945.5 24401.6 24494.9 24661.5 2156.4 2235.0 2253.7 2301.7 2314.4 9141.5 10083.8 10122.7 14450.6 15095.6 1822.6 1824.7 1833.8 1879.2 1901.3 86158.8 98056.0 109206.0 112244.2 113937.0 10948.8 11027.1 11119.3 11232.9 11326.0 13976.8 13978.0 13997.0 14003.2 14006.0 8009.6 8167.3 8171.8 8189.4 8321.6 6866.8 8000.8 8141.8 8170.7 8185.1 4356.3 4372.1 4389.8 4442.7 4507.0 1830.5 1838.2 1888.8 1891.8 1921.0 853.2 884.3 884.4 907.4 932.5 19505.6 20852.5 20895.3 20921.0 21193.7 874.3 884.5 886.3 891.3 895.7 7694.8 8217.8 10569.4 10640.9 10889.9 538942.0 540921.0 547425.0 552066.0 554479.0 95251.0 111373.0 122648.4 138291.0 142382.0 972.0 1003.2 1006.1 1006.1 1026.1 18711.9 18968.9 19154.7 19203.3 19245.6 52726.7 57188.7 57596.0 58623.0 58864.4 80754.0 82086.0 83821.0 84899.0 85018.0 6527.3 7792.3 8058.5 8108.3 8337.9 9841.0 10218.4 10517.3 11772.9 12922.2 11294.9 11447.5 11631.1 11701.9 11824.4 9993.4 10310.9 10421.4 11119.8 11270.5 11276.0 11343.4 11692.5 11806.6 11809.5 6996.9 7312.6 7329.2 7541.6 7884.2 9334.9 11435.6 11518.1 11559.1 11591.2 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5378.10 Median:5176.55 stddev:2949.57 (57.0%) stddev-sans-first:2943.22 15:02:37 INFO - PROCESS | 1652 | Values: 1470.1 1503.0 1656.6 1805.2 1829.0 7931.0 8198.5 8200.4 8207.5 8312.5 7414.3 7680.8 7909.8 8133.0 8183.5 2286.8 2318.6 2319.5 2322.0 2326.6 1973.3 2286.3 2290.2 2322.0 2342.5 2274.6 2284.1 2299.0 2306.6 2310.6 2259.1 2261.8 2279.4 2287.9 2292.2 2266.6 2289.3 2291.8 2294.5 2297.8 8185.4 8234.6 8287.3 8290.3 8324.3 5015.4 5176.2 5176.8 5178.3 5180.9 3063.6 3131.3 3309.8 3313.8 3314.7 1041.2 1048.2 1077.4 1090.9 1091.5 10623.0 10764.8 10814.7 10817.1 10832.5 4395.8 4493.8 4582.3 4591.9 4601.8 9081.0 9263.0 9281.4 9294.5 9299.0 5177.3 5178.4 5183.6 5184.8 5185.4 4223.2 4386.0 4433.6 4623.6 4676.2 2946.9 3680.8 3730.0 3764.4 3775.9 1227.6 1246.6 1248.4 1257.5 1261.9 833.8 840.5 891.5 893.1 922.3 5363.4 5444.0 5708.4 5712.0 5819.3 759.4 878.0 905.6 921.9 986.8 3466.9 3692.9 3822.0 3901.3 4025.6 9898.8 9902.9 10132.0 10137.9 10171.2 10074.4 10107.3 10109.4 10120.9 10123.1 7347.9 7679.0 7687.8 7748.3 7763.4 4905.8 5476.9 5557.6 5656.1 5704.7 8157.4 9024.7 9161.8 9208.2 9297.9 9359.7 9396.1 9437.8 9460.7 9575.9 6053.4 6541.8 6773.5 6902.8 7023.6 7709.4 7875.4 7907.2 7920.9 7933.2 6985.8 7057.9 7079.2 7133.0 7260.2 6966.1 6990.8 6995.0 6997.2 7074.2 6556.4 6593.7 6660.8 6664.8 6705.9 4748.8 4778.2 4824.1 4844.6 4942.6 4727.9 4813.5 4828.9 4884.8 4948.4 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4269.72 Median:4738.01 stddev:1305.38 (27.6%) stddev-sans-first:1274.54 15:02:37 INFO - PROCESS | 1652 | Values: 297.3 298.0 309.1 311.0 313.3 4740.8 4889.9 4957.3 5132.6 5239.3 3721.8 4223.7 4396.7 4980.5 5065.8 3889.3 3972.5 3972.7 3979.7 3980.1 3279.9 3440.2 3740.6 3982.7 3999.3 3570.9 3933.3 3935.4 3948.2 3988.9 3083.7 3904.6 3932.4 3942.5 3943.0 2839.4 3429.5 3451.6 3471.8 3497.0 4721.6 5010.8 5042.6 5054.7 5061.0 4039.6 4214.6 4494.5 4498.5 4519.8 4486.7 5432.8 5459.8 5460.6 5465.3 3361.6 3488.0 3513.9 3743.3 3753.2 4634.9 4890.1 5486.5 5689.5 5693.3 3143.1 3763.1 3822.7 3829.5 3830.5 3719.8 3808.6 3824.6 3880.2 3883.5 4419.8 4438.6 4455.5 4458.9 4500.8 4772.5 4773.8 5037.0 5476.6 5544.9 1136.0 1154.4 1232.2 1248.4 1252.6 724.7 773.9 842.7 853.7 862.6 3922.6 4128.9 4477.9 4842.8 4866.9 4717.5 5274.0 5285.6 5293.7 5364.3 4779.1 4796.1 5245.4 5255.8 5322.9 2293.9 2721.7 2819.7 2827.3 2837.4 4578.5 5276.0 5514.5 5540.9 5556.6 5475.7 5475.9 5502.5 5513.9 5543.6 4643.0 5440.1 5475.9 5527.9 5554.9 4571.7 5320.6 5335.4 5341.8 5356.9 4288.3 4670.0 4735.2 4773.4 5338.4 5007.5 5384.6 5499.7 5503.8 5536.4 3165.9 3464.6 3565.6 3581.6 3614.5 5124.8 5175.8 5257.1 5298.8 5342.5 4067.9 4437.0 4933.0 5222.5 5225.5 4768.8 4922.7 5060.0 5151.5 5174.6 4277.4 4423.6 5011.1 5047.5 5284.5 4443.8 5343.7 5506.5 5507.2 5535.2 5112.5 5355.5 5361.7 5374.8 5383.8 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:17860.80 Median:28299.12 stddev:25400.28 (89.8%) stddev-sans-first:25438.82 15:02:37 INFO - PROCESS | 1652 | Values: 693.3 696.1 719.8 744.5 789.6 14057.0 14596.1 14608.7 14612.6 14620.6 12957.2 13073.7 13085.2 13091.7 13092.5 596.8 626.0 636.2 783.9 792.3 800.7 800.7 813.8 814.0 814.2 865.1 878.9 880.4 882.8 884.6 681.3 703.8 839.8 869.7 870.3 617.9 639.3 642.3 642.4 642.7 13083.7 13270.8 13313.7 13415.9 13433.9 12480.1 12512.7 12772.7 12798.7 12879.4 11844.6 11882.2 11899.1 11915.2 12314.9 4280.7 4289.5 4356.8 4473.7 4484.3 80464.0 81116.2 81165.6 81368.6 82104.3 10182.2 10226.5 10231.2 10275.9 10432.2 18378.7 18403.8 19083.8 19087.7 19101.7 7112.3 7337.8 7423.2 7461.0 7478.0 3664.0 4031.0 4200.2 4316.2 4323.1 3074.5 3167.4 3188.9 3226.3 3246.3 613.5 621.2 622.1 640.2 642.3 491.4 568.8 594.5 610.7 638.0 8382.3 8562.3 8926.9 8988.1 9008.3 576.6 592.9 648.0 654.1 666.5 3953.0 4022.3 4055.1 4059.9 4171.5 68407.0 70922.0 76534.0 103807.5 122206.0 47933.3 57379.0 63727.0 85830.6 88069.2 55465.4 56029.4 73405.0 73671.6 78101.0 8075.4 8280.0 8994.4 9712.9 9760.9 37982.4 41368.5 47189.3 49295.0 52159.0 63672.0 73500.5 77661.0 79140.0 79520.6 10421.3 10555.7 10719.1 11201.7 11227.4 11566.5 12034.0 12148.5 12310.4 12483.3 10970.2 11102.2 11147.6 11450.6 11486.4 11397.8 11629.4 11753.6 11990.0 12016.3 11057.0 11350.3 11448.4 11634.9 11853.3 8125.6 8228.1 8858.9 8875.7 8883.2 8912.0 9359.0 9481.3 9542.6 9578.4 15:02:37 INFO - PROCESS | 1652 | -------- Summary: end -------- 15:02:37 INFO - PROCESS | 1652 | 15:02:37 INFO - TEST-INFO | 1652: exit 0 15:02:37 INFO - TEST-OK | dromaeo_css | took 1119445ms 15:02:37 INFO - TEST-START | kraken 15:02:37 INFO - operating with platform_type : mac_ 15:02:37 INFO - Initialising browser for kraken test... 15:02:37 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpPot0fL/profile http://localhost:49267/getInfo.html) 15:02:40 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 15:02:40 INFO - PROCESS | 1661 | colorDepth:24 15:02:40 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 15:02:40 INFO - PROCESS | 1661 | __metrics 15:02:40 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:02:40 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:41 INFO - TEST-INFO | 1661: exit 0 15:02:41 INFO - Browser initialized. 15:02:41 INFO - Running cycle 1/1 for kraken test... 15:02:41 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpPot0fL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:53 INFO - PROCESS | 1662 | RSS: Main: 238092288 15:02:53 INFO - PROCESS | 1662 | 15:02:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 15:02:56 INFO - PROCESS | 1662 | RSS: Main: 288526336 15:02:56 INFO - PROCESS | 1662 | 15:02:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 15:02:59 INFO - PROCESS | 1662 | RSS: Main: 288731136 15:02:59 INFO - PROCESS | 1662 | 15:03:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 15:03:04 INFO - PROCESS | 1662 | RSS: Main: 381440000 15:03:04 INFO - PROCESS | 1662 | 15:03:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 15:03:06 INFO - PROCESS | 1662 | RSS: Main: 282423296 15:03:06 INFO - PROCESS | 1662 | 15:03:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:09 INFO - PROCESS | 1662 | RSS: Main: 287494144 15:03:09 INFO - PROCESS | 1662 | 15:03:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:12 INFO - PROCESS | 1662 | RSS: Main: 322785280 15:03:12 INFO - PROCESS | 1662 | 15:03:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:16 INFO - PROCESS | 1662 | RSS: Main: 324067328 15:03:16 INFO - PROCESS | 1662 | 15:03:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 15:03:19 INFO - PROCESS | 1662 | RSS: Main: 322048000 15:03:19 INFO - PROCESS | 1662 | 15:03:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:21 INFO - PROCESS | 1662 | RSS: Main: 301420544 15:03:21 INFO - PROCESS | 1662 | 15:03:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:03:24 INFO - PROCESS | 1662 | RSS: Main: 301867008 15:03:24 INFO - PROCESS | 1662 | 15:03:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:03:27 INFO - PROCESS | 1662 | RSS: Main: 309035008 15:03:27 INFO - PROCESS | 1662 | 15:03:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:03:31 INFO - PROCESS | 1662 | RSS: Main: 322056192 15:03:31 INFO - PROCESS | 1662 | 15:03:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:03:34 INFO - PROCESS | 1662 | RSS: Main: 316104704 15:03:34 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 15:03:36 INFO - PROCESS | 1662 | RSS: Main: 359952384 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | __start_tp_report 15:03:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 15:03:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 15:03:36 INFO - PROCESS | 1662 | |i|pagename|runs| 15:03:36 INFO - PROCESS | 1662 | |0;ai-astar;113;113;113;112;112;113;112;110;110;112 15:03:36 INFO - PROCESS | 1662 | |1;audio-beat-detection;150;117;113;151;112;113;115;111;143;111 15:03:36 INFO - PROCESS | 1662 | |2;audio-dft;182;188;188;182;185;185;224;177;183;185 15:03:36 INFO - PROCESS | 1662 | |3;audio-fft;82;58;57;87;61;59;62;58;85;75 15:03:36 INFO - PROCESS | 1662 | |4;audio-oscillator;83;71;92;72;54;66;102;98;99;113 15:03:36 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;83;87;85;87;85;90;83;87;84 15:03:36 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;91;93;92;93;93;93;93;92;93 15:03:36 INFO - PROCESS | 1662 | |7;imaging-desaturate;84;83;82;82;84;90;84;84;83;90 15:03:36 INFO - PROCESS | 1662 | |8;json-parse-financial;56;55;54;55;54;55;54;56;55;53 15:03:36 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;72;68;66;76;73;69;69;71;70;73 15:03:36 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;87;84;86;94;91;85;88;90;92;87 15:03:36 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;153;156;149;149;147;145;147;159;217;175 15:03:36 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;172;172;170;174;169;173;173;174;172;172 15:03:36 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;68;66;68;67;66;66;66;67;66 15:03:36 INFO - PROCESS | 1662 | __end_tp_report 15:03:36 INFO - PROCESS | 1662 | __start_cc_report 15:03:36 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2000 15:03:36 INFO - PROCESS | 1662 | __end_cc_report 15:03:36 INFO - PROCESS | 1662 | __startTimestamp1478905416493__endTimestamp 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | ------- Summary: start ------- 15:03:36 INFO - PROCESS | 1662 | Number of tests: 14 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:1.15 (1.0%) stddev-sans-first:1.17 15:03:36 INFO - PROCESS | 1662 | Values: 113.0 113.0 113.0 112.0 112.0 113.0 112.0 110.0 110.0 112.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:116.00 stddev:17.06 (14.7%) stddev-sans-first:15.18 15:03:36 INFO - PROCESS | 1662 | Values: 150.0 117.0 113.0 151.0 112.0 113.0 115.0 111.0 143.0 111.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:187.90 Median:185.00 stddev:13.08 (7.1%) stddev-sans-first:13.70 15:03:36 INFO - PROCESS | 1662 | Values: 182.0 188.0 188.0 182.0 185.0 185.0 224.0 177.0 183.0 185.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:68.40 Median:68.50 stddev:12.38 (18.1%) stddev-sans-first:12.12 15:03:36 INFO - PROCESS | 1662 | Values: 82.0 58.0 57.0 87.0 61.0 59.0 62.0 58.0 85.0 75.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:77.50 stddev:18.79 (24.2%) stddev-sans-first:19.92 15:03:36 INFO - PROCESS | 1662 | Values: 83.0 71.0 92.0 72.0 54.0 66.0 102.0 98.0 99.0 113.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:2.20 (2.5%) stddev-sans-first:2.29 15:03:36 INFO - PROCESS | 1662 | Values: 87.0 83.0 87.0 85.0 87.0 85.0 90.0 83.0 87.0 84.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 15:03:36 INFO - PROCESS | 1662 | Values: 93.0 91.0 93.0 92.0 93.0 93.0 93.0 93.0 92.0 93.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.00 stddev:2.95 (3.5%) stddev-sans-first:3.12 15:03:36 INFO - PROCESS | 1662 | Values: 84.0 83.0 82.0 82.0 84.0 90.0 84.0 84.0 83.0 90.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 15:03:36 INFO - PROCESS | 1662 | Values: 56.0 55.0 54.0 55.0 54.0 55.0 54.0 56.0 55.0 53.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.50 stddev:2.91 (4.1%) stddev-sans-first:3.05 15:03:36 INFO - PROCESS | 1662 | Values: 72.0 68.0 66.0 76.0 73.0 69.0 69.0 71.0 70.0 73.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:3.24 (3.6%) stddev-sans-first:3.40 15:03:36 INFO - PROCESS | 1662 | Values: 87.0 84.0 86.0 94.0 91.0 85.0 88.0 90.0 92.0 87.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:154.50 stddev:21.97 (14.2%) stddev-sans-first:23.17 15:03:36 INFO - PROCESS | 1662 | Values: 153.0 156.0 149.0 149.0 147.0 145.0 147.0 159.0 217.0 175.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:1.60 (0.9%) stddev-sans-first:1.69 15:03:36 INFO - PROCESS | 1662 | Values: 172.0 172.0 170.0 174.0 169.0 173.0 173.0 174.0 172.0 172.0 15:03:36 INFO - PROCESS | 1662 | 15:03:36 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 15:03:36 INFO - PROCESS | 1662 | Values: 68.0 68.0 66.0 68.0 67.0 66.0 66.0 66.0 67.0 66.0 15:03:36 INFO - PROCESS | 1662 | -------- Summary: end -------- 15:03:36 INFO - PROCESS | 1662 | 15:03:37 INFO - TEST-INFO | 1662: exit 0 15:03:37 INFO - TEST-OK | kraken | took 59494ms 15:03:37 INFO - SUITE-END | took 1178s 15:03:37 INFO - Completed test suite (00:19:39) 15:03:37 INFO - javascript benchmark 15:03:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.8700451981913, 3262.0, 3272.5745653065105, 3292.489664102065, 3307.9834600826994, 5386.057439948013, 5483.945160548394, 5568.303962004749, 5587.580931430144, 5597.496225339719, 5368.30212072431, 5440.3743569489525, 5467.316585426822, 5484.177373393993, 5519.668819870801, 4989.750512474371, 4999.425066117388, 5002.424721157059, 5067.619928505358, 5076.84769456915, 5023.196288593826, 5104.259882317062, 5129.999650068219, 5153.458886816887, 5156.664816786915, 5117.283580298761, 5126.333576635032, 5137.332146820908, 5155.252488389181, 5201.141811601081, 4964.478729733362, 5012.298278241049, 5020.874478138039, 5024.84925452237, 5067.391912970467, 5051.545360917535, 5056.367954005749, 5070.543651071422, 5104.846854594368, 5126.5642420394315, 5448.782048718046, 5489.176623506506, 5569.832905012856, 5575.526080283181, 5601.159826026129, 5895.086261629454, 5993.6104153230335, 6001.459868611846, 6065.181200537959, 6071.939280607182, 5045.0, 6037.607555508878, 6043.274807023141, 6133.867031338107, 6142.682951206343, 5619.297587801525, 5632.802851900164, 5639.0, 5653.57598180134, 5657.179708942181, 5905.645661260338, 6188.783392581238, 6198.659073750897, 6215.378462153749, 6219.689015549205, 5693.202951586781, 5711.485966263056, 5716.599838011382, 5770.16332631766, 5785.074388097884, 5913.319968203626, 5917.940820591825, 5923.763049477972, 5931.0, 5954.970225148846, 5810.970945145247, 5823.82528524145, 5833.183354330397, 5834.066549352084, 5842.298924129047, 5837.503812176013, 5867.559933005042, 5879.735411906475, 5879.9710050741805, 5888.5289176865745, 4742.69172503793, 4767.308740232646, 4772.093302272627, 4775.785089670973, 4779.02030083832, 4204.936925946114, 4214.009707718745, 4220.092680073799, 4244.893877653083, 4327.783610819446, 5232.529072383504, 5550.611457198038, 5553.972230138905, 5604.747786349624, 5619.690916999604, 6081.118237855486, 6110.052941793941, 6112.083187521907, 6120.0, 6123.9387606124255, 5473.7263136843, 5543.113101903676, 5547.55619550435, 5549.1676248563035, 5603.7478313475995, 5289.127293996525, 5289.576833853283, 5291.947080529222, 5295.12630415977, 5329.440408757102, 6206.782762603378, 6215.440610345, 6222.595531290452, 6229.688515574203, 6236.18929539157, 5653.886922261449, 5914.911276330945, 5983.34183239852, 6009.909851352146, 6067.211262535842, 6048.36492168316, 6115.785947491817, 6139.277491147187, 6155.47678447337, 6158.815235542941, 5852.648841069549, 5957.702114894151, 5961.91057134152, 5981.671008094597, 6006.669633170218, 6069.211002569814, 6071.119687645179, 6085.4523092921845, 6086.995645718584, 6122.877542449215, 5647.774089036392, 5715.685637289989, 5823.388544202967, 5830.970845145747, 5857.179994800646, 5750.079987202028, 5759.452851979056, 5804.303483581828, 5832.825015249549, 5851.912221316598, 5687.004774164422, 5697.601167918206, 5700.743466544099, 5713.342965558848, 5718.942810571841, 5604.551635869202, 5696.373398926197, 5853.9121913172185, 5870.295564532284, 5870.618409803349, 5605.915911261416, 5703.315602127605, 5715.142728590745, 5717.42825717425, 5717.714114294352], "value": 5499.974016764893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.50578151613075, 493.86912468195914, 496.43902390298956, 519.3456245131135, 523.9921401178985, 30259.697403025963, 38259.42610860836, 39902.0, 39913.0, 39996.00009999752, 41216.58783412165, 41489.0, 41595.0, 41744.37383439251, 41749.95625109374, 8336.541490218036, 9219.907800921988, 9394.906050939471, 9407.20038796703, 9423.963364029985, 8356.916430835674, 10930.836037459445, 11181.0, 11187.4965626547, 11348.773024539505, 11166.274192177483, 11232.719182020433, 11239.157063220291, 11256.606018789344, 11278.774424511505, 11097.0, 11153.72115697114, 11176.720581985515, 11177.105831533458, 11181.776364472746, 11051.447427628586, 11053.613123540637, 11055.613053543088, 11094.445277736162, 11100.111991040698, 38657.80671096655, 38952.0, 38988.0, 38989.805050974566, 39087.609123908966, 3302.091924720697, 3349.949750753741, 3437.346904088215, 3498.1954150545516, 3621.4567814827724, 28620.284492887637, 29110.41779164405, 29766.553501697494, 29812.254693632614, 29932.0, 3140.6231252249877, 3267.673232676737, 3303.620083690382, 3342.097633638928, 3344.414727422691, 460502.0, 461273.0, 461500.0, 461967.0, 463392.68303658604, 58248.12627810586, 58578.535536611926, 58618.706906465195, 58782.11826822515, 58803.70598147067, 61333.32000080009, 61469.0, 61526.69236653788, 61550.38449615536, 61565.69217153885, 15493.535193944199, 15787.28957196929, 15798.447054353042, 15809.683806323808, 15810.288537015862, 10911.56353745857, 11247.775044499063, 12207.267563946192, 12265.57070502528, 12274.447649855778, 16144.919275403783, 16585.336586536403, 16606.086665233528, 16959.91520042392, 16965.066921319445, 5626.437356264422, 7049.3655570997835, 7101.360877521048, 7153.6780844862105, 7176.641167941582, 823.7322870067132, 842.616609442702, 933.9866245124116, 1004.7086344960026, 1041.3387498938077, 26653.80057897399, 28622.28444288868, 28676.713232867405, 29197.562036569467, 29600.851995739882, 937.1237892570468, 1011.3527342500805, 1042.489180301662, 1069.8769641491328, 1087.244365166202, 14015.85984140166, 14690.26548672562, 14730.263486825615, 14861.256937153099, 15053.247337633074, 623821.0, 625728.0, 626398.0, 630656.0, 827881.0, 46529.76735116303, 54197.0, 56297.0, 56344.591385215695, 59335.70332148398, 1317.0714646174424, 1331.9400626971615, 1358.0900796466392, 1359.232033900843, 1367.7401293754156, 29536.704632953395, 29918.0, 30137.547936780527, 30144.397112058075, 30298.5237401226, 49298.75350623224, 49905.0, 50025.74987125041, 50115.0, 50144.0, 536650.5339786365, 540348.0, 540702.0, 540873.0, 541331.5866841282, 25518.362040949123, 25934.74065259323, 25936.20180266657, 25949.481010380063, 26003.0, 43958.56041439545, 44349.77825110854, 44584.331235030855, 44910.87722806825, 45591.54408456005, 37288.44067339046, 37336.81331593324, 38131.237375252895, 39016.219675606895, 39059.0, 36869.44695829511, 37323.440148397254, 38198.80900595479, 38301.80849095848, 38584.6141538581, 36823.44764828476, 37035.6296437043, 37232.62767372291, 37686.62313376831, 37831.24337513289, 31872.840635797602, 33118.337633246716, 33264.83367583244, 33402.0, 33550.32899342048, 20835.791642083386, 24062.51874962456, 24305.392365190306, 24320.756792432556, 24849.0], "value": 19664.214212659044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5574129830186, 347.66971377191675, 367.0658174944765, 368.7160886117688, 404.1532988389325, 14531.564053078399, 14893.255337233135, 15695.764563531542, 19647.214111435525, 20117.497062573442, 16173.919130404362, 19302.4209273722, 19936.800631993676, 20197.697034544457, 20263.797362026413, 5477.287952566161, 5874.911876321838, 5883.235179426669, 5887.1463637772495, 5900.967330717129, 5476.58925580581, 5646.802361917313, 5676.858078548049, 5729.312482502085, 5746.655200687972, 4824.252240902648, 5697.6866272355, 5705.400932902048, 5710.200571919934, 5717.542596592283, 5499.697516636564, 5700.572457065737, 5788.5369170466265, 5853.970730146365, 5906.173135760997, 5461.1262198048125, 5683.715814209273, 5697.1739097831, 5697.6011679182475, 5714.657120572779, 23750.881245593835, 23945.521089578284, 24401.633975490382, 24494.877525612435, 24661.506769864503, 2156.3962090614655, 2234.9776502235095, 2253.6844841722173, 2301.689271948282, 2314.4329639238495, 9141.542922853898, 10083.848742268872, 10122.746931326703, 14450.566483005421, 15095.622609434742, 1822.6354729054242, 1824.708046712533, 1833.8441232495254, 1879.1919474625906, 1901.2585091814203, 86158.84602884915, 98056.0, 109206.0, 112244.19389515246, 113937.01220457327, 10948.781024379468, 11027.117830573696, 11119.277246979082, 11232.943835280772, 11326.0, 13976.790348144787, 13978.0, 13997.0, 14003.159810411407, 14006.0, 8009.599520023976, 8167.305779008851, 8171.836563268701, 8189.385796065319, 8321.625526851307, 6866.828329291808, 8000.799980000546, 8141.796455088552, 8170.673173073129, 8185.058718247358, 4356.324769660708, 4372.060007098426, 4389.758563279051, 4442.690195804146, 4506.977465112719, 1830.514913547911, 1838.1544489534963, 1888.8016758240462, 1891.810818918097, 1920.9519762005782, 853.1511146409363, 884.3234925282164, 884.4472204871955, 907.3920473282916, 932.4917919733762, 19505.609887802166, 20852.478688032617, 20895.26866559663, 20921.0, 21193.682094768592, 874.3442418186361, 884.540039179623, 886.2909672262293, 891.2869704236584, 895.7178488776015, 7694.807629809187, 8217.83564328722, 10569.418681972411, 10640.946795265974, 10889.945550272198, 538942.0, 540921.0, 547425.0, 552066.0, 554479.0, 95251.0, 111373.0, 122648.38675806564, 138291.0, 142382.0, 971.961121555144, 1003.2174903575223, 1006.1095930101912, 1006.119645310368, 1026.1124127629696, 18711.906440467712, 18968.905155474135, 19154.7126793101, 19203.32788352401, 19245.615087698447, 52726.736366319456, 57188.71405642945, 57596.0, 58623.0, 58864.411355885895, 80754.0, 82086.0, 83821.0, 84899.00068011358, 85018.0, 6527.281998980204, 7792.259735325135, 8058.516489010443, 8108.270255677017, 8337.916620833957, 9841.0, 10218.437985910847, 10517.316374435637, 11772.882271177179, 12922.160059596095, 11294.887051129384, 11447.542098315975, 11631.127665424958, 11701.88298117008, 11824.40877956116, 9993.400395976265, 10310.948445257725, 10421.426821524585, 11119.83320250213, 11270.549178032787, 11276.041536469493, 11343.432828358715, 11692.47383867711, 11806.645800625995, 11809.468573914022, 6996.930030699627, 7312.634368281671, 7329.1937886833475, 7541.622918854145, 7884.21157884207, 9334.906650933404, 11435.59975400857, 11518.07855371585, 11559.075273977893, 11591.24656897299], "value": 9282.434874993201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.1179292424547, 1502.9849701502985, 1656.5610113319972, 1805.151578757985, 1829.0488945748202, 7930.960345198273, 8198.46709963852, 8200.42597018209, 8207.548584827831, 8312.459690120138, 7414.258574142583, 7680.807979800507, 7909.762707118782, 8133.0, 8183.549904755236, 2286.8399212055206, 2318.6174281243575, 2319.536092781442, 2322.0479603362623, 2326.569584626841, 1973.2994786850677, 2286.325533967484, 2290.1869836208157, 2322.036354912709, 2342.508073304608, 2274.5792028474784, 2284.0635339510804, 2299.034405549665, 2306.5617532668825, 2310.560993411255, 2259.062489067035, 2261.819054475646, 2279.441536823489, 2287.9199228026937, 2292.16336037346, 2266.614675505152, 2289.3132060381986, 2291.7937385635205, 2294.4952110535655, 2297.8161747060194, 8185.386096042821, 8234.588270586506, 8287.337013038943, 8290.253877151024, 8324.334053275723, 5015.39815222172, 5176.249443830623, 5176.844694659167, 5178.275041494194, 5180.8963820723375, 3063.5711000459955, 3131.3111115554543, 3309.834508274601, 3313.784604000756, 3314.685104915029, 1041.2242879055152, 1048.2180293500994, 1077.4343469678404, 1090.939998300093, 1091.4706367411877, 10623.043926046694, 10764.784704305948, 10814.675559733221, 10817.080548153417, 10832.458377081115, 4395.846145384896, 4493.7977790999485, 4582.266837306015, 4591.874990627251, 4601.7699115044115, 9080.954595226982, 9263.008453182598, 9281.39670921388, 9294.488803115893, 9299.0, 5177.275181474596, 5178.378594568676, 5183.559397451183, 5184.766685499161, 5185.377754669388, 4223.176480586256, 4385.9912220189535, 4433.623142032963, 4623.56076172763, 4676.158291507561, 2946.896858609938, 3680.7975561343846, 3730.0, 3764.3976963685677, 3775.9433608495897, 1227.613301809927, 1246.5823948977013, 1248.3570960955115, 1257.459292504232, 1261.8738126187309, 833.7748807821854, 840.4621042532784, 891.505214605887, 893.1470445724318, 922.276013329533, 5363.410024897258, 5444.003540491918, 5708.429157084258, 5712.0, 5819.272590926134, 759.4266328921628, 877.972771856929, 905.6422713028448, 921.9400738952081, 986.7730422002979, 3466.913327166841, 3692.8736735295993, 3822.0444888777806, 3901.3367727486398, 4025.6175663311938, 9898.752531186634, 9902.851457228147, 10132.037456441627, 10137.949310253402, 10171.23715721309, 10074.445905475122, 10107.343022703648, 10109.443980581138, 10120.949395252977, 10123.088921996909, 7347.926520734831, 7679.0, 7687.807804804925, 7748.302652761278, 7763.417743669134, 4905.847125925333, 5476.945230547643, 5557.609119154414, 5656.095024796013, 5704.657720536781, 8157.3881958852135, 9024.729258122266, 9161.77095572616, 9208.217301529445, 9297.907020929704, 9359.719208423758, 9396.107369799858, 9437.811243775224, 9460.668876589287, 9575.90424095778, 6053.394660534088, 6541.803745887631, 6773.491988100814, 6902.792916212522, 7023.648817558999, 7709.421793365408, 7875.409344299086, 7907.169747176694, 7920.920790792018, 7933.206679332021, 6985.755498557526, 7057.929420705727, 7079.1505019398, 7133.0, 7260.237675044044, 6966.059581956371, 6990.790276291719, 6994.965025175045, 6997.160340759141, 7074.151101867808, 6556.442702370352, 6593.736250549924, 6660.83347916306, 6664.766733164316, 6705.899411508929, 4748.762561871962, 4778.187708089564, 4824.107540105092, 4844.636652251166, 4942.57988071018, 4727.881802954954, 4813.470518243061, 4828.927566086441, 4884.780184891617, 4948.418603257731], "value": 4364.319358275731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.3028248756665, 297.96424429068514, 309.11438728044146, 310.9875604975801, 313.26382999950107, 4740.786664600093, 4889.902201955959, 4957.3059771632, 5132.640715149941, 5239.318888544489, 3721.8139093045306, 4223.7465752054895, 4396.7361958282445, 4980.534635355504, 5065.772040258188, 3889.3193691104016, 3972.503437070366, 3972.6623237024887, 3979.7214195006363, 3980.084580546476, 3279.9016029519153, 3440.1743581540377, 3740.6259374062647, 3982.701297402692, 3999.2601368746873, 3570.9465707616314, 3933.252681990413, 3935.429362742401, 3948.2300951314505, 3988.8803335899825, 3083.691630836921, 3904.570497245301, 3932.429797679349, 3942.5071866016747, 3943.0, 2839.361143742662, 3429.4567444649756, 3451.620321764604, 3471.7743346682387, 3496.965030349689, 4721.598664113554, 5010.774515146827, 5042.621803364726, 5054.721990290533, 5060.974695126538, 4039.6162364575316, 4214.630245170332, 4494.460664720222, 4498.482674492442, 4519.751413672247, 4486.730796152241, 5432.75552600134, 5459.754311055973, 5460.624628286669, 5465.316835395575, 3361.596608407007, 3488.023353461035, 3513.91215219619, 3743.2887751327435, 3753.1555400035045, 4634.907301853944, 4890.070886531583, 5486.451354864522, 5689.544836413118, 5693.306693306693, 3143.0570828751283, 3763.1344790697744, 3822.6559609635265, 3829.5213098362706, 3830.540335159799, 3719.795411252407, 3808.562015368268, 3824.617538246209, 3880.165764360676, 3883.475730776309, 4419.801108950105, 4438.578335058164, 4455.532169122261, 4458.9331160032625, 4500.819967201341, 4772.5227477252, 4773.761311934459, 5036.992601479646, 5476.58925580583, 5544.889102217933, 1135.9659210223706, 1154.440096553171, 1232.2175418609247, 1248.4070066718236, 1252.5741247975732, 724.6594100772734, 773.9264769846856, 842.6643769625213, 853.7481442974338, 862.607513581319, 3922.607739226112, 4128.947118484767, 4477.910441791146, 4842.782074806642, 4866.926996095061, 4717.528247175255, 5274.0, 5285.550728188147, 5293.682379057269, 5364.30264065669, 4779.139754844092, 4796.098360491852, 5245.370555533361, 5255.842324730264, 5322.92015619766, 2293.9311820645407, 2721.700612932576, 2819.6737691404674, 2827.3073097091346, 2837.3615936414553, 4578.496365399803, 5276.0, 5514.476124768141, 5540.889182216333, 5556.638818476786, 5475.7262136893, 5475.863103422366, 5502.532284755761, 5513.889722205614, 5543.586385471679, 4643.003508491313, 5440.06236632222, 5475.890482190334, 5527.8894422112135, 5554.861128471821, 4571.725696458223, 5320.574354051744, 5335.359756829205, 5341.839744807662, 5356.919646205232, 4288.292431748727, 4669.953300466952, 4735.242361222326, 4773.44378438052, 5338.386085600206, 5007.524285192901, 5384.626920135341, 5499.7250137492165, 5503.752331145028, 5536.422119695867, 3165.857536410821, 3464.636213197679, 3565.5899571549603, 3581.6060233373787, 3614.4759009942886, 5124.769385377593, 5175.792968281377, 5257.106291930305, 5298.761555729924, 5342.530804028923, 4067.877963661095, 4436.95731503103, 4932.950670493393, 5222.451642577626, 5225.451327610698, 4768.76156192196, 4922.704637721748, 5059.974700126476, 5151.536361727312, 5174.6119041071315, 4277.401163837128, 4423.6239919605905, 5011.141421105655, 5047.4952504749235, 5284.524392804512, 4443.844465443694, 5343.706096164593, 5506.504414602545, 5507.228987941611, 5535.201059655547, 5112.463191364853, 5355.491228333302, 5361.651492652965, 5374.823196605381, 5383.7846486140115], "value": 3855.998667731372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.2997672350925, 696.1472196559213, 719.8452332748458, 744.5346658338539, 789.5539020453446, 14057.0, 14596.124232546055, 14608.70782584349, 14612.561623151323, 14620.634484137901, 12957.157784743986, 13073.738525229513, 13085.21488710678, 13091.738165236713, 13092.47630094795, 596.836169469534, 625.9655718935456, 636.1761518833122, 783.9412044096687, 792.2829838995718, 800.671724592917, 800.7077416742906, 813.7518056992615, 813.9593020348989, 814.1573471457043, 865.1002956924791, 878.9033206347297, 880.4365206267994, 882.8013696918206, 884.5798245833209, 681.2948598200887, 703.8240439889976, 839.7774589733725, 869.6695255802817, 870.277669534285, 617.8609812792131, 639.2999665366416, 642.2742301199661, 642.3961476212345, 642.7204166187723, 13083.672908177277, 13270.800937985938, 13313.733725325439, 13415.86584134156, 13433.86566134336, 12480.126391152622, 12512.687182820411, 12772.680682982907, 12798.744025119538, 12879.356032198446, 11844.631073785278, 11882.168248222628, 11899.107566932515, 11915.2255103418, 12314.876851231462, 4280.657547396201, 4289.4852617685765, 4356.825726970949, 4473.664475164375, 4484.260097083978, 80464.0, 81116.18883811204, 81165.59417202877, 81368.59315703443, 82104.30530626077, 10182.18542516597, 10226.488675566192, 10231.181505479544, 10275.948620256851, 10432.217583681255, 18378.724319135225, 18403.81596184048, 19083.80916190848, 19087.713684294748, 19101.713474297896, 7112.288771122846, 7337.779866604011, 7423.220561840929, 7461.030066091374, 7477.962610186914, 3664.029032306441, 4030.9596904031173, 4200.180964711913, 4316.201502722007, 4323.135372925428, 3074.461969155389, 3167.4298626247037, 3188.85650145744, 3226.3386005868742, 3246.2858171202297, 613.4601550635413, 621.183144165421, 622.0668996505242, 640.2061443809642, 642.293477175113, 491.3514161307112, 568.7923907773633, 594.4887396838715, 610.7251736718495, 637.9585326953733, 8382.287505562095, 8562.315014798802, 8926.910730892738, 8988.146126118008, 9008.324375671851, 576.6280748916926, 592.8754961458142, 647.970841312142, 654.1136759690646, 666.4601672645173, 3953.011747063234, 4022.316206244887, 4055.0982865290466, 4059.91880162401, 4171.49942006955, 68407.0, 70922.0, 76534.0, 103807.48096259471, 122206.0, 47933.28100078501, 57379.0, 63727.0, 85830.57084714537, 88069.23861522862, 55465.44534554683, 56029.43970560324, 73405.0, 73671.63164184253, 78101.0, 8075.394345423999, 8280.0, 8994.38912399399, 9712.852188340192, 9760.869673722571, 37982.43026354552, 41368.51788892676, 47189.29216061693, 49295.0, 52159.0, 63672.0, 73500.52998940098, 77661.0, 79140.0, 79520.60239698764, 10421.322614030063, 10555.655099643767, 10719.14246860265, 11201.71995700114, 11227.438628068727, 11566.47950842231, 12034.0, 12148.514059437524, 12310.384480776105, 12483.31341776211, 10970.232083754061, 11102.222844401138, 11147.554097835995, 11450.599229026944, 11486.368249746343, 11397.829032564352, 11629.418529073682, 11753.647390578297, 11990.040796736415, 12016.33910134951, 11057.0, 11350.262232954832, 11448.427578621202, 11634.883651163718, 11853.288802671867, 8125.553094579618, 8228.094909559824, 8858.867116993122, 8875.73372798817, 8883.24492418126, 8912.019677835562, 9358.953205234202, 9481.336306458481, 9542.618295268112, 9578.395374986307], "value": 6757.142514068677, "unit": "score"}], "name": "dromaeo_css", "value": 6965.104274348031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 110.0, 110.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 113.0, 151.0, 112.0, 113.0, 115.0, 111.0, 143.0, 111.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 188.0, 182.0, 185.0, 185.0, 224.0, 177.0, 183.0, 185.0], "value": 187.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 57.0, 87.0, 61.0, 59.0, 62.0, 58.0, 85.0, 75.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 92.0, 72.0, 54.0, 66.0, 102.0, 98.0, 99.0, 113.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 85.0, 87.0, 85.0, 90.0, 83.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 82.0, 84.0, 90.0, 84.0, 84.0, 83.0, 90.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 56.0, 55.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 66.0, 76.0, 73.0, 69.0, 69.0, 71.0, 70.0, 73.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 94.0, 91.0, 85.0, 88.0, 90.0, 92.0, 87.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 149.0, 149.0, 147.0, 145.0, 147.0, 159.0, 217.0, 175.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 170.0, 174.0, 169.0, 173.0, 173.0, 174.0, 172.0, 172.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 68.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1452.3, "alertThreshold": 2.0}]} 15:03:37 INFO - Return code: 0 15:03:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:03:37 INFO - # TBPL SUCCESS # 15:03:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:03:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:03:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:03:37 INFO - 2016-11-11 15:03:37.833 screenresolution[1666:10152] starting screenresolution argv=screenresolution get 15:03:37 INFO - 2016-11-11 15:03:37.836 screenresolution[1666:10152] Display 0: 1600x1200x32@60 15:03:37 INFO - 2016-11-11 15:03:37.842 screenresolution[1667:10155] starting screenresolution argv=screenresolution list 15:03:37 INFO - Available Modes on Display 0 15:03:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:03:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:03:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:03:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:03:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:03:38 INFO - Intel Iris: 15:03:38 INFO - Chipset Model: Intel Iris 15:03:38 INFO - Type: GPU 15:03:38 INFO - Bus: Built-In 15:03:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:03:38 INFO - Vendor: Intel (0x8086) 15:03:38 INFO - Device ID: 0x0a2e 15:03:38 INFO - Revision ID: 0x0009 15:03:38 INFO - Displays: 15:03:38 INFO - Display: 15:03:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:03:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:03:38 INFO - Display Serial Number: 1600x1200 60 15:03:38 INFO - Main Display: Yes 15:03:38 INFO - Mirror: Off 15:03:38 INFO - Online: Yes 15:03:38 INFO - Rotation: Supported 15:03:38 INFO - Return code: 0 15:03:38 INFO - Running post-action listener: _resource_record_post_action 15:03:38 INFO - [mozharness: 2016-11-11 23:03:38.077390Z] Finished run-tests step (success) 15:03:38 INFO - Running post-run listener: _resource_record_post_run 15:03:38 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38827008; Write bytes: 699408384; Read time: 380; Write time: 1904 15:03:38 INFO - TinderboxPrint: CPU usage
53.7% 15:03:38 INFO - TinderboxPrint: I/O read bytes / time
38,827,008 / 380 15:03:38 INFO - TinderboxPrint: I/O write bytes / time
699,408,384 / 1,904 15:03:38 INFO - TinderboxPrint: CPU idle
2,249.0 (46.3%) 15:03:38 INFO - TinderboxPrint: CPU system
970.5 (20.0%) 15:03:38 INFO - TinderboxPrint: CPU user
1,634.3 (33.7%) 15:03:38 INFO - TinderboxPrint: Swap in / out
436,543,488 / 0 15:03:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397914624; Write bytes: 391923712; Read time: 29523; Write time: 741 15:03:38 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34624512; Write bytes: 297342976; Read time: 347; Write time: 1128 15:03:38 INFO - Running post-run listener: _upload_blobber_files 15:03:38 INFO - Blob upload gear active. 15:03:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:03:38 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 15:03:38 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'] 15:03:38 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 15:03:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:40 INFO - (blobuploader) - INFO - Done attempting. 15:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:44 INFO - (blobuploader) - INFO - Done attempting. 15:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:46 INFO - (blobuploader) - INFO - Done attempting. 15:03:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:03:46 INFO - Return code: 0 15:03:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:03:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:03:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6e691545af074552cc8ab700973d396480705c81421628fa75b1d3e2721a5fc52ade1f3f28983ce45e5660d8033c29c439b8d0c90bf69d0fd724838906cb0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e46457fe92ffbf59a1e9ed073d50987b99b49ee8b11641f39732b07e04c3bf0e3a2ae9865a22eaed16a01b4b7d9275c39538f80e664c8f248e17080a3ae698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b99896154539f9b25c4b92c08420584a7efee2cdcae5f2c1dc1027899c2c80166bfeeae8af16f15eecea65e3c706c35c99b3072a15378c83e62e3085268fb5"} 15:03:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:03:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:03:46 INFO - Contents: 15:03:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6e691545af074552cc8ab700973d396480705c81421628fa75b1d3e2721a5fc52ade1f3f28983ce45e5660d8033c29c439b8d0c90bf69d0fd724838906cb0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e46457fe92ffbf59a1e9ed073d50987b99b49ee8b11641f39732b07e04c3bf0e3a2ae9865a22eaed16a01b4b7d9275c39538f80e664c8f248e17080a3ae698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b99896154539f9b25c4b92c08420584a7efee2cdcae5f2c1dc1027899c2c80166bfeeae8af16f15eecea65e3c706c35c99b3072a15378c83e62e3085268fb5"} 15:03:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:03:46 INFO - Copying logs to upload dir... 15:03:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:03:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.891541 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-11 15:03:46.490538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 15:03:46.494434) ========= 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.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/f6e691545af074552cc8ab700973d396480705c81421628fa75b1d3e2721a5fc52ade1f3f28983ce45e5660d8033c29c439b8d0c90bf69d0fd724838906cb0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e46457fe92ffbf59a1e9ed073d50987b99b49ee8b11641f39732b07e04c3bf0e3a2ae9865a22eaed16a01b4b7d9275c39538f80e664c8f248e17080a3ae698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b99896154539f9b25c4b92c08420584a7efee2cdcae5f2c1dc1027899c2c80166bfeeae8af16f15eecea65e3c706c35c99b3072a15378c83e62e3085268fb5"} build_url:https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/dkiZPSNkRMimM_nctMeCpw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6e691545af074552cc8ab700973d396480705c81421628fa75b1d3e2721a5fc52ade1f3f28983ce45e5660d8033c29c439b8d0c90bf69d0fd724838906cb0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e46457fe92ffbf59a1e9ed073d50987b99b49ee8b11641f39732b07e04c3bf0e3a2ae9865a22eaed16a01b4b7d9275c39538f80e664c8f248e17080a3ae698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b99896154539f9b25c4b92c08420584a7efee2cdcae5f2c1dc1027899c2c80166bfeeae8af16f15eecea65e3c706c35c99b3072a15378c83e62e3085268fb5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 15:03:46.532641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 15:03:46.533424) ========= 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.oHP5rqBKxw/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.Td4veI2K71/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005078 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 15:03:46.582901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 15:03:46.583242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 15:03:46.583581) ========= ========= Total master_lag: 0.19 =========