builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1476789482.83 results: success (0) buildid: 20161018013948 builduid: b23bebc0b8db44b5b4ff2aea4e592213 revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.833333) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.834054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.834399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.859401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.859760) ========= 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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-18 04:18:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.1M=0s 2016-10-18 04:18:02 (56.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.976973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:02.977282) ========= 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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.027078 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:03.026840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-18 04:18:03.027433) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dc89484d4b45abf442162e5ea2dd46f9de40197d --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 dc89484d4b45abf442162e5ea2dd46f9de40197d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-18 04:18:03,098 truncating revision to first 12 chars 2016-10-18 04:18:03,098 Setting DEBUG logging. 2016-10-18 04:18:03,098 attempt 1/10 2016-10-18 04:18:03,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc89484d4b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 04:18:04,435 unpacking tar archive at: mozilla-central-dc89484d4b45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.588860 ========= master_lag: 2.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-18 04:18:07.055900) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:07.056224) ========= script_repo_revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:07.056622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:07.059897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:18:07.081623) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-18 04:18:07.082026) ========= /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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:07 INFO - MultiFileLogger online at 20161018 04:18:07 in /builds/slave/test 04:18:07 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 04:18:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:07 INFO - {'append_to_log': False, 04:18:07 INFO - 'base_work_dir': '/builds/slave/test', 04:18:07 INFO - 'blob_upload_branch': 'Firefox', 04:18:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:07 INFO - 'branch': 'Firefox', 04:18:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:07 INFO - 'config_files': ('talos/mac_config.py',), 04:18:07 INFO - 'default_actions': ('clobber', 04:18:07 INFO - 'read-buildbot-config', 04:18:07 INFO - 'download-and-extract', 04:18:07 INFO - 'populate-webroot', 04:18:07 INFO - 'create-virtualenv', 04:18:07 INFO - 'install', 04:18:07 INFO - 'run-tests'), 04:18:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:07 INFO - 'download_minidump_stackwalk': True, 04:18:07 INFO - 'download_symbols': 'ondemand', 04:18:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:07 INFO - 'installer_path': 'installer.exe', 04:18:07 INFO - 'log_level': 'info', 04:18:07 INFO - 'log_name': 'talos', 04:18:07 INFO - 'log_to_console': True, 04:18:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:18:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:18:07 INFO - 'opt_config_files': (), 04:18:07 INFO - 'pip_index': False, 04:18:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:18:07 INFO - 'cmd': ('bash', 04:18:07 INFO - '-c', 04:18:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:18:07 INFO - 'enabled': True, 04:18:07 INFO - 'halt_on_failure': False, 04:18:07 INFO - 'name': 'check_screen_resolution'},), 04:18:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:18:07 INFO - 'cmd': ('bash', 04:18:07 INFO - '-c', 04:18:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:18:07 INFO - 'enabled': True, 04:18:07 INFO - 'halt_on_failure': False, 04:18:07 INFO - 'name': 'check_screen_resolution'},), 04:18:07 INFO - 'run_cmd_checks_enabled': True, 04:18:07 INFO - 'sps_profile': False, 04:18:07 INFO - 'sps_profile_interval': 0, 04:18:07 INFO - 'suite': 'dromaeojs', 04:18:07 INFO - 'system_bits': '32', 04:18:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:07 INFO - 'title': 't-yosemite-r7-0085', 04:18:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:07 INFO - 'use_talos_json': True, 04:18:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:07 INFO - 'work_dir': 'build'} 04:18:07 INFO - [mozharness: 2016-10-18 11:18:07.284877Z] Running clobber step. 04:18:07 INFO - Running pre-action listener: _resource_record_pre_action 04:18:07 INFO - Running main action method: clobber 04:18:07 INFO - rmtree: /builds/slave/test/build 04:18:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:09 INFO - Running post-action listener: _resource_record_post_action 04:18:09 INFO - [mozharness: 2016-10-18 11:18:09.463768Z] Finished clobber step (success) 04:18:09 INFO - [mozharness: 2016-10-18 11:18:09.463894Z] Running read-buildbot-config step. 04:18:09 INFO - Running pre-action listener: _resource_record_pre_action 04:18:09 INFO - Running main action method: read_buildbot_config 04:18:09 INFO - Using buildbot properties: 04:18:09 INFO - { 04:18:09 INFO - "project": "", 04:18:09 INFO - "product": "firefox", 04:18:09 INFO - "script_repo_revision": "production", 04:18:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:18:09 INFO - "repository": "", 04:18:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:18:09 INFO - "buildid": "20161018013948", 04:18:09 INFO - "pgo_build": "False", 04:18:09 INFO - "basedir": "/builds/slave/test", 04:18:09 INFO - "buildnumber": 12, 04:18:09 INFO - "slavename": "t-yosemite-r7-0085", 04:18:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:18:09 INFO - "platform": "yosemite_r7", 04:18:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:18:09 INFO - "branch": "mozilla-central", 04:18:09 INFO - "repo_path": "mozilla-central", 04:18:09 INFO - "revision": "dc89484d4b45abf442162e5ea2dd46f9de40197d", 04:18:09 INFO - "stage_platform": "macosx64", 04:18:09 INFO - "builduid": "b23bebc0b8db44b5b4ff2aea4e592213", 04:18:09 INFO - "slavebuilddir": "test" 04:18:09 INFO - } 04:18:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:18:09 INFO - Running post-action listener: _resource_record_post_action 04:18:09 INFO - [mozharness: 2016-10-18 11:18:09.467182Z] Finished read-buildbot-config step (success) 04:18:09 INFO - [mozharness: 2016-10-18 11:18:09.467287Z] Running download-and-extract step. 04:18:09 INFO - Running pre-action listener: _resource_record_pre_action 04:18:09 INFO - Running main action method: download_and_extract 04:18:09 INFO - mkdir: /builds/slave/test/build/tests 04:18:09 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')]} 04:18:09 INFO - trying https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:18:09 INFO - Downloading https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/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 04:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/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 04:18:10 INFO - Downloaded 1199 bytes. 04:18:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:18:10 INFO - Using the following test package requirements: 04:18:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:18:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:18:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:18:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'jsshell-mac.zip'], 04:18:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:18:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:18:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:18:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:18:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:18:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:18:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:18:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:18:10 INFO - Fetch https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:18:11 INFO - Http code: 200 04:18:11 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 04:18:11 INFO - x-amz-cf-id: MzJyNNS4_vNbGb-AvHUrEZa9QHxut6oFDmV9604PpIfTuVqeJiQlhw== 04:18:11 INFO - x-amz-version-id: r9trN7B8ZF7vURSzSQBZ3CPZ_rth4Hhn 04:18:11 INFO - Expected file size: 16483715 04:18:11 INFO - Obtained file size: 16483715 04:18:18 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 04:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:18:18 INFO - Http code: 200 04:18:18 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 04:18:18 INFO - x-amz-cf-id: l6d3JpFqaZXBcI1uDSww-GMCAiaSruenUfcYhKHkku8S8ARq2pEjjQ== 04:18:18 INFO - x-amz-version-id: r9trN7B8ZF7vURSzSQBZ3CPZ_rth4Hhn 04:18:19 INFO - Expected file size: 16483715 04:18:19 INFO - Obtained file size: 16483715 04:18:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:18:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:18:25 INFO - Fetch https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:18:26 INFO - Http code: 200 04:18:26 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 04:18:26 INFO - x-amz-cf-id: ioqsjZMGbJzJ1cKbt4F89WVHNBtJeH-KXq2obNLE_uVkx4m43waxGQ== 04:18:26 INFO - x-amz-version-id: uklBvolccHBogk7Bz_f4h8LXV50t__pe 04:18:26 INFO - Expected file size: 14409028 04:18:26 INFO - Obtained file size: 14409028 04:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:27 INFO - trying https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/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 04:18:30 INFO - Downloaded 111624046 bytes. 04:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:18:30 INFO - mkdir: /builds/slave/test/properties 04:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:30 INFO - Contents: 04:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:18:30 INFO - Running post-action listener: _resource_record_post_action 04:18:30 INFO - Running post-action listener: set_extra_try_arguments 04:18:30 INFO - [mozharness: 2016-10-18 11:18:30.624950Z] Finished download-and-extract step (success) 04:18:30 INFO - [mozharness: 2016-10-18 11:18:30.625065Z] Running populate-webroot step. 04:18:30 INFO - Running pre-action listener: _resource_record_pre_action 04:18:30 INFO - Running main action method: populate_webroot 04:18:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:30 INFO - '--tppagecycles', 04:18:30 INFO - '7'], 04:18:30 INFO - 'tests': ['tsvgm']}}, 04:18:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:18:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:18:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['damp', 'tps']}, 04:18:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'tests': ['damp', 'tps']}, 04:18:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['dromaeo_dom']}, 04:18:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['basic_compositor_video']}, 04:18:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:18:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'other-e10s': {'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['a11yr', 04:18:30 INFO - 'ts_paint', 04:18:30 INFO - 'tpaint', 04:18:30 INFO - 'sessionrestore', 04:18:30 INFO - 'sessionrestore_no_auto_restore', 04:18:30 INFO - 'tabpaint']}, 04:18:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['tsvgx', 04:18:30 INFO - 'tsvgr_opacity', 04:18:30 INFO - 'tart', 04:18:30 INFO - 'tscrollx', 04:18:30 INFO - 'cart']}, 04:18:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:18:30 INFO - 'tsvgr_opacity', 04:18:30 INFO - 'tart', 04:18:30 INFO - 'tscrollx', 04:18:30 INFO - 'cart']}, 04:18:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'talos_options': ['--disable-e10s'], 04:18:30 INFO - 'tests': ['tp5o']}, 04:18:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'tests': ['tp5o']}, 04:18:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'talos_options': ['--disable-e10s', 04:18:30 INFO - '--xperf_path', 04:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:30 INFO - 'tests': ['tp5n']}, 04:18:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:30 INFO - 'talos_options': ['--xperf_path', 04:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:30 INFO - 'tests': ['tp5n']}}, 04:18:30 INFO - 'talos.zip': {'path': '', 04:18:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:30 INFO - Running post-action listener: _resource_record_post_action 04:18:30 INFO - [mozharness: 2016-10-18 11:18:30.643593Z] Finished populate-webroot step (success) 04:18:30 INFO - [mozharness: 2016-10-18 11:18:30.643700Z] Running create-virtualenv step. 04:18:30 INFO - Running pre-action listener: _resource_record_pre_action 04:18:30 INFO - Running main action method: create_virtualenv 04:18:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:30 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 04:18:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:30 INFO - Using real prefix '/tools/python27' 04:18:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:34 INFO - Installing pip.................done. 04:18:34 INFO - Return code: 0 04:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:18:34 INFO - Reading from file tmpfile_stdout 04:18:34 INFO - Output received: 04:18:34 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) 04:18:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:34 INFO - 'HOME': '/Users/cltbld', 04:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:34 INFO - 'LOGNAME': 'cltbld', 04:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:34 INFO - 'MOZ_NO_REMOTE': '1', 04:18:34 INFO - 'NO_EM_RESTART': '1', 04:18:34 INFO - 'PAGER': '/bin/cat', 04:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:34 INFO - 'PWD': '/builds/slave/test', 04:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:34 INFO - 'SHELL': '/bin/bash', 04:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:34 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:34 INFO - 'USER': 'cltbld', 04:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:34 INFO - 'XPC_FLAGS': '0x0', 04:18:34 INFO - 'XPC_SERVICE_NAME': '0', 04:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:34 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 04:18:34 INFO - Cleaning up... 04:18:34 INFO - Return code: 0 04:18:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:34 INFO - 'HOME': '/Users/cltbld', 04:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:34 INFO - 'LOGNAME': 'cltbld', 04:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:34 INFO - 'MOZ_NO_REMOTE': '1', 04:18:34 INFO - 'NO_EM_RESTART': '1', 04:18:34 INFO - 'PAGER': '/bin/cat', 04:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:34 INFO - 'PWD': '/builds/slave/test', 04:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:34 INFO - 'SHELL': '/bin/bash', 04:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:34 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:34 INFO - 'USER': 'cltbld', 04:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:34 INFO - 'XPC_FLAGS': '0x0', 04:18:34 INFO - 'XPC_SERVICE_NAME': '0', 04:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:35 INFO - Downloading/unpacking psutil>=3.1.1 04:18:35 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 04:18:35 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 04:18:35 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 04:18:35 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 04:18:35 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 04:18:35 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 04:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:38 INFO - Installing collected packages: psutil 04:18:38 INFO - Running setup.py install for psutil 04:18:38 INFO - building 'psutil._psutil_osx' extension 04:18:38 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 04:18:39 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 04:18:39 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 04:18:39 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 04:18:39 INFO - building 'psutil._psutil_posix' extension 04:18:39 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 04:18:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:18:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:18:39 INFO - ^ 04:18:39 INFO - 1 warning generated. 04:18:39 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 04:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:39 INFO - Successfully installed psutil 04:18:39 INFO - Cleaning up... 04:18:39 INFO - Return code: 0 04:18:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:39 INFO - 'HOME': '/Users/cltbld', 04:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:39 INFO - 'LOGNAME': 'cltbld', 04:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:39 INFO - 'MOZ_NO_REMOTE': '1', 04:18:39 INFO - 'NO_EM_RESTART': '1', 04:18:39 INFO - 'PAGER': '/bin/cat', 04:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:39 INFO - 'PWD': '/builds/slave/test', 04:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:39 INFO - 'SHELL': '/bin/bash', 04:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:39 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:39 INFO - 'USER': 'cltbld', 04:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:39 INFO - 'XPC_FLAGS': '0x0', 04:18:39 INFO - 'XPC_SERVICE_NAME': '0', 04:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:18:42 INFO - Installing collected packages: mozsystemmonitor 04:18:42 INFO - Running setup.py install for mozsystemmonitor 04:18:42 INFO - Successfully installed mozsystemmonitor 04:18:42 INFO - Cleaning up... 04:18:42 INFO - Return code: 0 04:18:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:42 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:42 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 04:18:42 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 04:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:42 INFO - 'HOME': '/Users/cltbld', 04:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:42 INFO - 'LOGNAME': 'cltbld', 04:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:42 INFO - 'MOZ_NO_REMOTE': '1', 04:18:42 INFO - 'NO_EM_RESTART': '1', 04:18:42 INFO - 'PAGER': '/bin/cat', 04:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:42 INFO - 'PWD': '/builds/slave/test', 04:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:42 INFO - 'SHELL': '/bin/bash', 04:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:42 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:42 INFO - 'USER': 'cltbld', 04:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:42 INFO - 'XPC_FLAGS': '0x0', 04:18:42 INFO - 'XPC_SERVICE_NAME': '0', 04:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:18:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:18:46 INFO - warning: no files found matching '*.txt' 04:18:46 INFO - no previously-included directories found matching 'build' 04:18:46 INFO - no previously-included directories found matching 'dist' 04:18:46 INFO - no previously-included directories found matching '.git*' 04:18:46 INFO - Installing collected packages: jsonschema, functools32 04:18:46 INFO - Running setup.py install for functools32 04:18:46 INFO - warning: no files found matching '*.txt' 04:18:46 INFO - no previously-included directories found matching 'build' 04:18:46 INFO - no previously-included directories found matching 'dist' 04:18:46 INFO - no previously-included directories found matching '.git*' 04:18:46 INFO - Successfully installed jsonschema functools32 04:18:46 INFO - Cleaning up... 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:18:46 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')]} 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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')]} 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:46 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 04:18:46 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 04:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:46 INFO - 'HOME': '/Users/cltbld', 04:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PAGER': '/bin/cat', 04:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:46 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - 'XPC_FLAGS': '0x0', 04:18:46 INFO - 'XPC_SERVICE_NAME': '0', 04:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:18:46 INFO - Cleaning up... 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:46 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')]} 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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')]} 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:46 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 04:18:46 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 04:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:46 INFO - 'HOME': '/Users/cltbld', 04:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PAGER': '/bin/cat', 04:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:46 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - 'XPC_FLAGS': '0x0', 04:18:46 INFO - 'XPC_SERVICE_NAME': '0', 04:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:49 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 04:18:49 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 04:18:49 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 04:18:49 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 04:18:49 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 04:18:49 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 04:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 INFO - Downloading docopt-0.6.1.tar.gz 04:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:50 INFO - Running setup.py install for blobuploader 04:18:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:50 INFO - Running setup.py install for requests 04:18:51 INFO - Running setup.py install for docopt 04:18:51 INFO - Successfully installed blobuploader requests docopt 04:18:51 INFO - Cleaning up... 04:18:51 INFO - Return code: 0 04:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:51 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:51 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 04:18:51 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 04:18:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:51 INFO - 'HOME': '/Users/cltbld', 04:18:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:51 INFO - 'LOGNAME': 'cltbld', 04:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:51 INFO - 'MOZ_NO_REMOTE': '1', 04:18:51 INFO - 'NO_EM_RESTART': '1', 04:18:51 INFO - 'PAGER': '/bin/cat', 04:18:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:51 INFO - 'PWD': '/builds/slave/test', 04:18:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:51 INFO - 'SHELL': '/bin/bash', 04:18:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:51 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:51 INFO - 'USER': 'cltbld', 04:18:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:51 INFO - 'XPC_FLAGS': '0x0', 04:18:51 INFO - 'XPC_SERVICE_NAME': '0', 04:18:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:51 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-DC0uVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:51 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-LDB2iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:51 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ukzg68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-8E9aOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-QCrn09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-goRV0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bcM3Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-YZx4YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-tPUCn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-QlKv9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-I8EjV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:52 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-S5NV78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:53 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-sJuYDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:53 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-PMEUjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:53 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wbFo6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:53 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zslVLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:53 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-sC_BwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:53 INFO - Running setup.py install for manifestparser 04:18:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:53 INFO - Running setup.py install for mozcrash 04:18:53 INFO - Running setup.py install for mozdebug 04:18:53 INFO - Running setup.py install for mozdevice 04:18:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozfile 04:18:54 INFO - Running setup.py install for mozhttpd 04:18:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozinfo 04:18:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozInstall 04:18:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:54 INFO - Running setup.py install for mozleak 04:18:54 INFO - Running setup.py install for mozlog 04:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Running setup.py install for moznetwork 04:18:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Running setup.py install for mozprocess 04:18:55 INFO - Running setup.py install for mozprofile 04:18:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Running setup.py install for mozrunner 04:18:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:55 INFO - Running setup.py install for mozscreenshot 04:18:55 INFO - Running setup.py install for moztest 04:18:55 INFO - Running setup.py install for mozversion 04:18:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:56 INFO - Cleaning up... 04:18:56 INFO - Return code: 0 04:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:56 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')]} 04:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:56 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')]} 04:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:56 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:18:56 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 04:18:56 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 04:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:56 INFO - 'HOME': '/Users/cltbld', 04:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:56 INFO - 'LOGNAME': 'cltbld', 04:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:56 INFO - 'MOZ_NO_REMOTE': '1', 04:18:56 INFO - 'NO_EM_RESTART': '1', 04:18:56 INFO - 'PAGER': '/bin/cat', 04:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:56 INFO - 'PWD': '/builds/slave/test', 04:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:56 INFO - 'SHELL': '/bin/bash', 04:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:18:56 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:56 INFO - 'USER': 'cltbld', 04:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:56 INFO - 'XPC_FLAGS': '0x0', 04:18:56 INFO - 'XPC_SERVICE_NAME': '0', 04:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_Ubavt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:56 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)) 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-lz3kQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-a1vvvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:56 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)) 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-3ZsOdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:56 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)) 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-vBemRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:56 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)) 04:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bg6XXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-rK38uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-F7EHpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-D9qdTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_Z42c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-eubgfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-XHNIkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hqB3HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:57 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)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-gYG6CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Uw2CFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:58 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)) 04:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:58 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-luuiEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:58 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)) 04:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:58 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jaHnmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:58 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)) 04:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:58 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)) 04:18:58 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)) 04:18:58 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)) 04:18:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:58 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 04:18:58 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 04:18:58 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 04:18:58 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 04:18:58 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 04:18:58 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 04:19:00 INFO - Downloading blessings-1.6.tar.gz 04:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:00 INFO - Installing collected packages: blessings 04:19:00 INFO - Running setup.py install for blessings 04:19:01 INFO - Successfully installed blessings 04:19:01 INFO - Cleaning up... 04:19:01 INFO - Return code: 0 04:19:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:01 INFO - Reading from file tmpfile_stdout 04:19:01 INFO - Current package versions: 04:19:01 INFO - blessings == 1.6 04:19:01 INFO - blobuploader == 1.2.4 04:19:01 INFO - docopt == 0.6.1 04:19:01 INFO - functools32 == 3.2.3-2 04:19:01 INFO - jsonschema == 2.5.1 04:19:01 INFO - manifestparser == 1.1 04:19:01 INFO - mozInstall == 1.12 04:19:01 INFO - mozcrash == 0.17 04:19:01 INFO - mozdebug == 0.1 04:19:01 INFO - mozdevice == 0.48 04:19:01 INFO - mozfile == 1.2 04:19:01 INFO - mozhttpd == 0.7 04:19:01 INFO - mozinfo == 0.9 04:19:01 INFO - mozleak == 0.1 04:19:01 INFO - mozlog == 3.4 04:19:01 INFO - moznetwork == 0.27 04:19:01 INFO - mozprocess == 0.23 04:19:01 INFO - mozprofile == 0.28 04:19:01 INFO - mozrunner == 6.12 04:19:01 INFO - mozscreenshot == 0.1 04:19:01 INFO - mozsystemmonitor == 0.3 04:19:01 INFO - moztest == 0.7 04:19:01 INFO - mozversion == 1.4 04:19:01 INFO - psutil == 3.1.1 04:19:01 INFO - requests == 1.2.3 04:19:01 INFO - wsgiref == 0.1.2 04:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:02 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:19:02 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 04:19:02 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 04:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:02 INFO - 'HOME': '/Users/cltbld', 04:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:02 INFO - 'LOGNAME': 'cltbld', 04:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:02 INFO - 'MOZ_NO_REMOTE': '1', 04:19:02 INFO - 'NO_EM_RESTART': '1', 04:19:02 INFO - 'PAGER': '/bin/cat', 04:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:02 INFO - 'PWD': '/builds/slave/test', 04:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:02 INFO - 'SHELL': '/bin/bash', 04:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:19:02 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:02 INFO - 'USER': 'cltbld', 04:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:02 INFO - 'XPC_FLAGS': '0x0', 04:19:02 INFO - 'XPC_SERVICE_NAME': '0', 04:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 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)) 04:19:02 INFO - Cleaning up... 04:19:02 INFO - Return code: 0 04:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19:02 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')]} 04:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:02 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')]} 04:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:02 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 0x10b3b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b329570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe55a5a71b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, '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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 04:19:02 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 04:19:02 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 04:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:02 INFO - 'HOME': '/Users/cltbld', 04:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:02 INFO - 'LOGNAME': 'cltbld', 04:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:02 INFO - 'MOZ_NO_REMOTE': '1', 04:19:02 INFO - 'NO_EM_RESTART': '1', 04:19:02 INFO - 'PAGER': '/bin/cat', 04:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:02 INFO - 'PWD': '/builds/slave/test', 04:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:02 INFO - 'SHELL': '/bin/bash', 04:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:19:02 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:02 INFO - 'USER': 'cltbld', 04:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:02 INFO - 'XPC_FLAGS': '0x0', 04:19:02 INFO - 'XPC_SERVICE_NAME': '0', 04:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:19:03 INFO - Cleaning up... 04:19:03 INFO - Return code: 0 04:19:03 INFO - Running post-action listener: _resource_record_post_action 04:19:03 INFO - Running post-action listener: _start_resource_monitoring 04:19:03 INFO - Starting resource monitoring. 04:19:03 INFO - [mozharness: 2016-10-18 11:19:03.155838Z] Finished create-virtualenv step (success) 04:19:03 INFO - [mozharness: 2016-10-18 11:19:03.156633Z] Running install step. 04:19:03 INFO - Running pre-action listener: _resource_record_pre_action 04:19:03 INFO - Running main action method: install 04:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:03 INFO - Reading from file tmpfile_stdout 04:19:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:03 INFO - Reading from file tmpfile_stdout 04:19:03 INFO - Output received: 04:19:03 INFO - Usage: mozinstall [options] installer 04:19:03 INFO - Options: 04:19:03 INFO - -h, --help show this help message and exit 04:19:03 INFO - -d DEST, --destination=DEST 04:19:03 INFO - Directory to install application into. [default: 04:19:03 INFO - "/builds/slave/test"] 04:19:03 INFO - --app=APP Application being installed. [default: firefox] 04:19:03 INFO - mkdir: /builds/slave/test/build/application 04:19:03 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'] 04:19:03 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 04:19:37 INFO - Reading from file tmpfile_stdout 04:19:37 INFO - Output received: 04:19:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:19:37 INFO - Running post-action listener: _resource_record_post_action 04:19:37 INFO - [mozharness: 2016-10-18 11:19:37.784763Z] Finished install step (success) 04:19:37 INFO - [mozharness: 2016-10-18 11:19:37.784912Z] Running run-tests step. 04:19:37 INFO - Running pre-action listener: _resource_record_pre_action 04:19:37 INFO - Running main action method: run_tests 04:19:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:37 INFO - 2016-10-18 04:19:37.799 screenresolution[1641:7575] starting screenresolution argv=screenresolution get 04:19:37 INFO - 2016-10-18 04:19:37.801 screenresolution[1641:7575] Display 0: 1600x1200x32@60 04:19:37 INFO - 2016-10-18 04:19:37.807 screenresolution[1642:7577] starting screenresolution argv=screenresolution list 04:19:37 INFO - Available Modes on Display 0 04:19:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:38 INFO - Intel Iris: 04:19:38 INFO - Chipset Model: Intel Iris 04:19:38 INFO - Type: GPU 04:19:38 INFO - Bus: Built-In 04:19:38 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:38 INFO - Vendor: Intel (0x8086) 04:19:38 INFO - Device ID: 0x0a2e 04:19:38 INFO - Revision ID: 0x0009 04:19:38 INFO - Displays: 04:19:38 INFO - Display: 04:19:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:38 INFO - Display Serial Number: 1600x1200 60 04:19:38 INFO - Main Display: Yes 04:19:38 INFO - Mirror: Off 04:19:38 INFO - Online: Yes 04:19:38 INFO - Rotation: Supported 04:19:38 INFO - Return code: 0 04:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:19:38 INFO - Python 2.7.3 04:19:38 INFO - Return code: 0 04:19:38 INFO - grabbing minidump binary from tooltool 04:19:38 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')]} 04:19:38 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 0x10b1c7d30>, '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 0x10afeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:19:38 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 04:19:38 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 04:19:38 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 04:19:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:38 INFO - Return code: 0 04:19:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:19:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:19:38 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/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 04:19:38 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/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 04:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QzqUGRRLZV/Render', 04:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:38 INFO - 'HOME': '/Users/cltbld', 04:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:38 INFO - 'LOGNAME': 'cltbld', 04:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:38 INFO - 'MOZ_NO_REMOTE': '1', 04:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:38 INFO - 'NO_EM_RESTART': '1', 04:19:38 INFO - 'PAGER': '/bin/cat', 04:19:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:38 INFO - 'PWD': '/builds/slave/test', 04:19:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:38 INFO - 'SHELL': '/bin/bash', 04:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5oEEdeb9Zr/Listeners', 04:19:38 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:38 INFO - 'USER': 'cltbld', 04:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:38 INFO - 'XPC_FLAGS': '0x0', 04:19:38 INFO - 'XPC_SERVICE_NAME': '0', 04:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:38 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/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 04:19:38 INFO - mozversion application_buildid: 20161018013948 04:19:38 INFO - mozversion application_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:19:38 INFO - mozversion application_display_name: Nightly 04:19:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:38 INFO - mozversion application_name: Firefox 04:19:38 INFO - mozversion application_remotingname: firefox 04:19:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:19:38 INFO - mozversion application_vendor: Mozilla 04:19:38 INFO - mozversion application_version: 52.0a1 04:19:38 INFO - mozversion platform_buildid: 20161018013948 04:19:38 INFO - mozversion platform_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:19:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:19:38 INFO - mozversion platform_version: 52.0a1 04:19:38 INFO - using testdate: 1476789578 04:19:38 INFO - actual date: 1476789578 04:19:38 INFO - starting webserver on 'localhost:49266' 04:19:38 INFO - SUITE-START | Running 2 tests 04:19:38 INFO - TEST-START | dromaeo_css 04:19:38 INFO - operating with platform_type : mac_ 04:19:38 INFO - Initialising browser for dromaeo_css test... 04:19:38 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpE6c8fc/profile http://localhost:49266/getInfo.html) 04:19:40 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:19:40 INFO - PROCESS | 1652 | colorDepth:24 04:19:40 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:19:40 INFO - PROCESS | 1652 | __metrics 04:19:40 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:19:40 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:19:41 INFO - TEST-INFO | 1652: exit 0 04:19:41 INFO - Browser initialized. 04:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:41 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpE6c8fc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:53 INFO - PROCESS | 1654 | RSS: Main: 231661568 04:19:53 INFO - PROCESS | 1654 | 04:20:45 INFO - PROCESS | 1654 | 1476789645099 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] 04:22:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 04:23:00 INFO - PROCESS | 1654 | RSS: Main: 394162176 04:23:00 INFO - PROCESS | 1654 | 04:26:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 04:26:03 INFO - PROCESS | 1654 | RSS: Main: 374538240 04:26:03 INFO - PROCESS | 1654 | 04:29:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 04:29:06 INFO - PROCESS | 1654 | RSS: Main: 337289216 04:29:06 INFO - PROCESS | 1654 | 04:32:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 04:32:09 INFO - PROCESS | 1654 | RSS: Main: 353542144 04:32:09 INFO - PROCESS | 1654 | 04:35:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 04:35:13 INFO - PROCESS | 1654 | RSS: Main: 332509184 04:35:13 INFO - PROCESS | 1654 | 04:38:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 04:38:17 INFO - PROCESS | 1654 | RSS: Main: 432099328 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | __start_tp_report 04:38:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 04:38:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 04:38:17 INFO - PROCESS | 1654 | |i|pagename|runs| 04:38:17 INFO - PROCESS | 1654 | |0;dojo.html;2930.2088436122244;3339.7328213742903;3367.3770352484776;3368.3936891359554;3390.8813191538284;5600.6079574429805;5670.518005969492;5721.971390143054;5800.216970708953;5817.592768506201;5683.8010669626465;5738.56960727945;5750.338711048231;5759.769609215637;5768.480836724694;5199.766010529516;5226.660267082647;5240.371155461331;5273.894522109575;5282;5254.080535906221;5284.128118860383;5285.841424757264;5312.654677445954;5329.987302412529;5345.839624811262;5350.117230656937;5351;5357.624966252364;5384.6769193848495;4397.164538737629;5361.678299302054;5378.381486129106;5386.380566234855;5418.674879507203;3905.5703872573995;4974.253861920741;5111.744412779346;5239.659422137549;5304.9734751326;5693.373728889819;5719.542436605103;5729.598928075036;5751.194832723422;5812.099124635688;6277.623342599459;6288.088227207029;6301.747930082791;6309.116723658692;6313.179286692746;6166.876662466726;6196.752129914798;6233.501319894398;6243.37566243372;6250.34371391002;5811.27359080115;5879.353271140171;5926.555508336892;5934.37689042653;5935.792247271324;6251.718672659741;6273.654948977759;6297.2128483939505;6300.117983482316;6300.873982520416;5217.426083130853;5709.0865461525955;5890.793822216202;6231.563790534619;6234.937650623527;6193.318734939153;6208.534359923024;6224.470919971763;6259.342769009279;6300.873982520324;6230.7819226326865;6256.749730010749;6268.749250030039;6274.905876411857;6295.527835412362;6243.344448832898;6291.276503202191;6294.748210071637;6296.181496405529;6302.558820882494;4841.588464980516;4890.144224760653;4894.3147959285725;4932.53140951609;4948.455669876311;4429.512753597101;4431.534688857688;4445.088756804847;4498.302763071729;4529.773511324421;5874.559408044413;5877.764889404376;5880.26496687914;5886.3230728465915;5894.115882617642;6105.308121371101;6230.719617617218;6247.812565623039;6266.874662506724;6282.905756413657;5755.251817263729;5800.651960882361;5805.071188609802;5812.6221795584;5914.201582786355;5430.402655707869;5432.158015507603;5436.266104075899;5447;5461.535769459561;6243.875122497434;6307.463865571386;6321.399467050623;6341.460975817107;6344.270408902943;6179.227596550431;6256.655883926245;6296.992481202986;6300.684965751602;6305.274893387319;5531.695756733418;6261.56169068179;6293.402126797947;6300.464460520907;6369.936300636934;6217.253929528486;6256.280527739368;6280.0265958774635;6286.9626511625065;6299.905501417574;6078.696065196634;6249.437550620466;6282.528810339151;6349.238091428873;6360.363963603602;6036.3058248302;6089.908651370321;6112.480439162543;6114.6636934969;6163.691815409122;5171.456997015259;6143.788236235041;6192;6197.845053873509;6201.348858369806;5988.670623115596;6077.179580756718;6084.269887613515;6104.053871649901;6112.938870611415;6044.818655440344;6106.297775755667;6130.233720784902;6189.102580125947;6210.937890621036;4901.803927842989;5872.882542349043;5913.349531551612;6087.634741915322;6102.786402475892 04:38:17 INFO - PROCESS | 1654 | |1;ext.html;498.6384870968548;503.76828653941106;512.2367672168469;514.4289838279511;532.4116850879777;28555;30410.239744006383;31112.377752444936;39534.80232598833;40451.78644640658;41201.793991030005;41681.791591042005;41689.332426702895;41851.581484185146;41867;9398.62405503779;9583.472908990003;9585.233181345511;9591.760205994837;9596.616135354578;8616.956915215447;8841;11337.716557086056;11611.535538578446;11634.941825290862;11419.086473082176;11502;11507.59723409681;11531.711707207303;11531.884681153208;8594.398392112555;9705.660301889471;11424.371659558721;11484.966353028267;11506.252093613972;7436.590987495686;8619.827603447897;8737.126287371275;8746.212840844355;11148.442577871156;39171.41242881359;39234.019149521206;39239.50646909435;39261;39289.41065884014;3304.2895777407734;3338.565986421774;3358.22760765023;3573.6605022522817;3762.9651845742364;29321;29499.410011799642;29672.258193545335;30035.399292014037;30088.24779380533;3102.115896969353;3149.700778426046;3152.3695260947675;3192.7260854724746;3227.5481432599454;473803;474962;475418;478051;481953;47838.28242576364;49569.752151239736;49736.50263497391;52683.73658131685;52738;58442.83114337774;59765.70117149474;59913;63394.68302658457;63639.045414318825;14507.274636268145;14641;14646.194459304841;14654.047486913316;14674.853251467563;10256.282060255711;10455.84316235257;11198.776024479464;11279.154063445274;11295.378754168436;13918.633832248543;15240.009399389226;15322.70561829212;15648.2958266876;15713.528594142193;7094.787156385317;7187.5687458752645;7189;7190.928090719026;7219.422446204291;871.6164887449502;888.0852721696663;936.1901954809041;1020.0105897279627;1060.3213943076437;28721.56917646237;29189;29212.561811572843;29413.55879661807;29853.552196717068;1052.1687866585464;1101.5263436722125;1133.3143448213877;1146.358039497884;1173.12015988009;14608.34262458192;14771.704565908836;14878.645981379408;15005.474808381654;15081.47214847497;180420.0978995123;181171;181263;181319;182275;55688.72155639196;55965.440345596835;55991.720041400346;56073.7196314024;56160.43839561634;1352.8241328627216;1381.9930900345635;1400.4958215042577;1400.9229492377813;1401.488456713272;28551.857240713663;28791;28856.104425902235;29755.851220743756;29853.253668657588;47471.116688079346;47958.52041479541;47985.28022079602;47989.5201047999;48046.75976620094;463872;464654;465386;465932;467550;32881.506777398834;33798.15504612306;38905;39084.80457597694;39794;38741.61258387493;38823.611763882;44462.77768611136;45865.54134458613;48330;36937.63062369342;37612.811935940146;37740.81129594444;38722.838314850596;38863.611363886;37160.88517344484;37324;37334.43998339973;38344.61655383522;38346.0413489665;36630.450543242405;37538.87383378503;37674;37745.43381849329;37795.81102094472;30959.845200773852;33735.3252934935;33736.49395259122;33766.98699039033;33838.32323353568;21381.893090534446;24554.263372098867;24941.501169976862;25535.106271281158;26528.071517496795 04:38:17 INFO - PROCESS | 1654 | |2;jquery.html;370.29089294001983;370.94250391189377;379.9753016053957;385.9710521710869;398.5396866619056;11375.431228438587;16231.675366492664;18897.33859314924;21255.25606603769;21319.147234110635;15975.440859569917;17181.74227386587;20349.287774927845;20619.793802061973;20909.37271881846;5707.086866101425;5927.673977931212;5981.342052374235;5981.88036239275;5987.461128498434;5541.861453463675;5811.883762324751;5867.383924687889;5878.764849406019;5880.176775251447;4095.262852686515;4317.4819021717285;5872.941270587304;6139.201903752506;6468.2561505426775;5654.575906806965;6458.2895881453005;6490.383413575702;6490.610563366213;6490.837729056764;5736.541076713853;5824.650520968756;5847.386024467412;5856.472917437409;5857.414258574151;11183.608573699881;13569.660758481117;13622.659433514142;13771.724565508734;13796.172229666152;2073.523089689365;2119.162930642403;2142.635751922177;2633.2363614551755;2664.5203863304596;9814.754631134207;9927.354721943122;10324.328918620266;10396.16830653546;10540.156787456985;1708.897466152035;1833.5232839461703;1899.7435346228222;1928.4407521818655;1934.303650685752;109712;121409;124419.37790310991;125435.3728231353;126916;11279;11300.943495282636;11356.148288878367;11458.656240312805;11630.592929247436;12063.879361206451;14533.200673963034;14548.927255363868;14589.832813374904;14591.124532528082;7848.960755196187;8080.39397045224;8096;8220.712275070344;8240.093589705128;7823.843523129505;7856.135825059239;7868.055833299926;7985.5208687478935;7986.920130798734;4526.705764125387;4531.524189960007;4533.5013148553635;4554.544545545486;4609.262517997105;1867.8886062792617;1928.3732786844332;1933.497290704399;1934.6517626827024;1940.3596813051659;781.968721251155;843.5444859775653;879.2149795132018;882.2897567458258;921.9861702074475;19573.804261957484;19697.803021969885;19797.91111488882;20325;21025.89487052555;922.2207234886511;924.9768755781159;928.1924725488733;928.7538802217417;942.0955882352881;10549.789004219872;11130.888691112985;11139;11227.045701115496;11290.04034657047;541411;544283;545108;567899;580230;108788.4560577192;117908.41045794888;119634;123235;130237.69762302445;963.1957315641378;966.6423423333271;993.7416271769392;993.9006099390148;994.796066806303;18477.72283415777;18773.812261877752;18806.905965470087;18839;18914.52713682169;50832.74583627058;50878;50965;51536.22695659493;52228;66645;69070.65464672644;69903;70620;71600;7850.607469626381;7932.532481490943;8066.435349525477;8155.714549990722;8481.703140390056;9821.95089024579;10253.384796912209;12669.176503527242;12924.676883077998;13173.868261317264;9201.76995575116;10488.632897848538;10663.826979032456;10693.502909592507;10883.129349652167;10318.071373576415;10875.238733288594;11148.498317575566;11218.66344009681;11239.494222760159;11186.720331991766;11359.659210223706;11544;11701.88298117008;11821.468033938321;5908.409159084229;6908.930910690829;7437.107547094383;8070.5964701763505;8246.05170405387;10010.749731256778;11101.5559377624;11156.497957591766;11585;11953.342566158944 04:38:17 INFO - PROCESS | 1654 | |3;mootools.html;1330.042369493964;1411.505972909482;1507.8916996007936;1742.2072956804648;1954.8045195480463;6809.28502507237;8327.458715183517;8497.745067647966;8865.980412252593;8875.289976801856;8712.259457946066;8735.694250701226;8813.1627495388;8815.250703690179;8819.426737262074;2363.267387109993;2381.4403615150427;2389.6773935518745;2394.0543485323287;2400.2679182849224;2327.674125622414;2360.5986982213067;2374.7387787343378;2377.3818807110188;2377.500724847784;2317.513322202331;2332.2070496031347;2342.496363281894;2353.376355265856;2358.445765245166;2316.7683231676865;2338.83628146029;2344.9179278725164;2349.635806450003;2358.740538540759;2294.8852557372234;2323.8838058097026;2327.197116994634;2331.661909023182;2341.555104530134;8709.390342676015;8794.472331660121;8796;8815.118488151198;8828;5141.023205590963;5400.432954539756;5409.323834520685;5442.401335853053;5465.863353416196;3327.1183136468853;3466.861325546975;3543.0965103898343;3553.8223088845452;3560.4481305397703;1021.4331046269317;1050.448514529878;1054.973625659357;1069.096613361708;1079.6545105566222;9993.800123997553;11528.59649912249;11687.415629218505;11749.588764393206;11852.170348075639;4408.426904502394;4479.574440428154;4643.558861908114;4657.301404789308;4658.138244424725;9132.360734748636;9142.680006199751;9150.63397464094;9166.633334666538;9186.173244408035;5254.579633629301;5268.552173065333;5268.9736551317;5281.471852814688;5281.683099014072;4351.8694439166875;4449.243628583149;4562.201614717411;4687.7656117194;4912.214045752662;3217.533457648628;3699.5190625218547;3718.5537735471917;3821.2739579480367;3841.0589405595806;1144.6794897428733;1161.3380373187372;1172.2556176827604;1173.1729130962651;1176.8352430659716;896.7444278380631;911.1207684584408;914.7850255190025;939.4645052320112;944.7826999790087;5699.629524080921;5918.940810591925;5955.493783028404;6000;6076.966915624266;415.77340349508984;448.1149729284702;450.31776858060067;450.93236014597414;457.9335996280521;3800.201957588937;3974.364101743707;3992.720509564361;3993.6006399360413;3994.2211268802303;10412.32319899204;10449.84325235122;10735.141188705042;10825.945870270756;10895.782084358269;10579.629712960163;10708.08981236588;10822.621208257673;10823.350598964087;10829.24195306321;8080.636371363303;8165.591720413956;8259.132791056853;8272.586370681442;8358.540280284642;5729.197912292366;5763.827085187451;5862.750860484557;5932.733027013708;5939.762409503572;9613.903860961302;9787.070228328583;10019.949900250453;10089.596416143271;10212.897871021492;10006.249531285037;10214.54034568461;10275.897241027793;10288.897111029093;10383.532741026824;6957.095577574883;7057.117860267466;7072.292770722886;7119.75080872167;7160.749373771893;8245.711400100967;8359.958200209203;8373.120822313813;8380.497170169809;8381.078081411162;7424.257574242532;7482.588457634883;7512.32389084985;7586.582737949466;7695.307422332017;7020.262872398324;7364.631768411665;7369.668364923484;7412.444066695128;7421.035265415461;6933.583984960918;6938;7012.614306213207;7016.929830701832;7035.1909530404655;4968.478309777422;5004.17431123875;5048.091343558195;5060.165072762953;5123.897522049464;4561.589456948891;4927.901441971212;4938.728369939688;5186.4554221807675;5205.115130427761 04:38:17 INFO - PROCESS | 1654 | |4;prototype.html;263.19593641425445;292.146930961592;309.12209325515533;312.94679904416245;316.4493780821369;4382.868513944582;5300.443453437387;5330.680159190451;5351.170568561879;5377.542908852743;5103.209002604603;5234.528892399683;5253.3170687810625;5297.17893726473;5358.410574836775;4043.2115737431213;4049.2711311963835;4094.5905409458965;4116.917661646765;4125.463689720332;4126.112885729567;4141.875743727693;4143.513891665007;4146.419501269825;4162.43807086044;2881.7550508206828;3933.9968308081397;3991.0221995611114;4009.3384591542363;4022.537408198051;3659.743817932719;3982.2677135446174;4096.9795151024355;4104.302268614328;4109.465769449982;3125.687211371207;3542.291541691672;3549.698275646573;3557.51973483579;3563.394222982073;4819.6385271104455;4822.180229361017;4830.516948305177;5019.52314530119;5275.973620131913;4455.933161002587;4560.8859778505475;4596.4254468191475;4612.655824527191;4629.675922685414;5685.715714214314;5698.971505142447;5708.828735137952;5744.597878148531;5746.873656746989;3255.7790828439333;3550.668499312758;3817.541894972593;3827.349350610403;3833.5399752029934;5207.531322180984;5499.477549632778;5749.223854779593;5954.1244507979845;5989.610675306091;3715.6098609646137;3747.2880152770886;3891.703894702139;3893.7079719021185;3895.104126051024;3933.4296527003426;3940.581390699346;3946.3291240489184;3958.8614398495915;3960.9207815844097;3755.2864955658883;3888.6305800948867;4241.618254357123;4630.560096790799;4631.421072365954;4639.770460827884;5578.86052848682;5581.469760372758;5643.887122257532;5666.914996275059;1033.7674023344687;1307.9346032698327;1308.3196737696344;1315.316395014383;1323.8742319479634;755.2447552447552;805.3798575097143;812.5368539932182;818.8198596308803;823.2714048067503;3857.9035524112123;4053.91892162161;4399.956000440018;4477;4508.436445444319;4360.520342762294;4527.728336299832;4844.903101938012;4884.508900460791;4885.560299573055;4051.541445079769;4307.5261721210645;4413.762787723757;4435.161496642151;4445.444094566876;2127.9890503474376;2245.4498647831388;2298.6322188449767;2414.5291668124896;2588.120039186648;4833.347498087784;4996.800127994839;5014.674046186986;5050.974745126251;5095.745212739423;4529.84145554904;4608.308753686973;4807.687500312469;4990.650654454226;5002.849914502571;4297.376880352332;4400.69195156336;4668;4976.755811047238;5082.822101226439;4425.468943726773;4469.888252793706;4685.906281874275;4829.541193586604;4923.458419573915;3967.5635680074593;4495.505494395548;4678.836240731558;4830.95169048305;4853.272009198648;4017.6418232535843;4334.894601876501;4632.791524381343;4827.468978412302;5025.824096156617;2846.9715302847535;3138.8430578471443;3250.293595862191;3395.847186876547;3422.863085476553;4392.3411488277015;4755.072760811747;4775.307580400892;4895.583875370491;4922.7538623067985;4347.044010073054;4391.494978077434;4403.9119217614825;4405.625521830681;4670.5329467053025;4070.982254436391;4121.91756164869;4714.104320179292;4718.292256161603;4781.422130696931;4017.991004497751;4317.273090763594;4594.659370069417;4686.367340409138;4695.440984663435;3981.124152686404;4128.60778226068;4289.142171565637;4573.611243044245;4692.976535117303;3770.4155855842387;4281.046078206028;4341.435613370241;4559.658025648156;4584.977075114736 04:38:17 INFO - PROCESS | 1654 | |5;yui.html;653.9149910511633;655.51164382535;716.5306724095717;808.2200676347331;822.7860756203389;14971;15259.542213733577;15852.920735396321;15878.285477153528;16097.275622596982;14311.14133152009;14712.705745885076;14743.705125897475;14763.704725905476;14764.704705905875;709.6912842913323;724.9818754531126;892.9285657147445;894.9239314658262;896.66375109334;727.1601300497933;736.057845957173;863.5336918064238;887.5118684723409;898.3352319283748;937.194013148695;943.377370935183;944.7024187380987;945.5414124149781;948.080362048815;934.700895713372;935.6210734652443;935.822193783179;937.2829785214317;938.061938061938;555.5722093987607;571.5598988778659;687.7661595057655;702.8032150997677;711.0365454808712;15128.848711512854;15179.696406071927;15190;15198.848011519854;15228.619284517865;13712;13980.300984950814;14146.221957792317;14168.574942751733;14368.856311436857;12400.937995310056;12557.560485382968;12651.620451386472;12670.49318027287;12973.221606703533;4462.553744625544;4537.137943790669;4585.358049873021;4635.397398338228;4771.33201351811;113801.4309928445;115431;116805;117189;121041.39479302635;10905.345679259111;10991.725206869733;11198.272112312674;11257.380844053656;11287.097032237401;21998.34004979853;22436;22484.775152248596;22491;22499.987500562514;6871.587704737732;7321.121465424183;7912.960435197787;7966.163552826985;7977.960110199412;4210.536840947493;4339.717918335298;4395.692301538926;4409.757463339547;4410.316400957857;3407.982960085233;3437.415639341318;3493;3497;3529.576450825917;610.8472881779555;638.084348959245;649.5777744466135;650.7169381319142;651.5146216068964;593.2702775586054;606.9332373438918;610.6305685060563;637.0953246390137;646.4666650013758;7887.763367098882;8015.47899386538;8280.337572994145;8866.157715017063;8893.232347911036;606.7633622887078;619.2661695890384;621.5245337316957;636.8089573128043;646.1083704487777;4213.367994800743;4253.659707223414;4325.134973005349;4390.670699697535;4518.2319005769095;107827;122747.77252227542;132964;138131;144020.27989860193;131945;132209;137199;137926;138047;117917.99999999828;119551.20673190083;119731;120290;122457;5905.645661260338;7252.202257751748;8145.104038555873;8174;8544.607509897238;59496.95752495624;63300;64162.358376415636;67477.66261168662;68260;88747.55626221828;96066;97537.51231243799;99690.50464243187;100588;11538.403963894025;11670.358130302575;11690.357030363071;11800.409979500819;12303.077269204667;10323;12563.623091307276;12599.118061735591;12638.620841374774;12736;11600.94199528997;11897.583584574499;11962.70093247641;12022.398880056136;12318.692032699255;10148.340357876714;11667;12115.636530904087;12294.385280736105;12349.506019759108;11354.829677554679;11491.253068550517;11591.594294199662;11699;12113.69715757113;9921.851172232278;9949.602015919281;10080.798384032132;10089.848652270075;10270.6405275815;8560.070627316152;8961.731148065568;9137.862932055892;10041.682266317235;10099.495025248854 04:38:17 INFO - PROCESS | 1654 | __end_tp_report 04:38:17 INFO - PROCESS | 1654 | __start_cc_report 04:38:17 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1751 04:38:17 INFO - PROCESS | 1654 | __end_cc_report 04:38:17 INFO - PROCESS | 1654 | __startTimestamp1476790697103__endTimestamp 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | ------- Summary: start ------- 04:38:17 INFO - PROCESS | 1654 | Number of tests: 6 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5754.16 Median:5935.79 stddev:674.04 (11.4%) stddev-sans-first:638.67 04:38:17 INFO - PROCESS | 1654 | Values: 2930.2 3339.7 3367.4 3368.4 3390.9 5600.6 5670.5 5722.0 5800.2 5817.6 5683.8 5738.6 5750.3 5759.8 5768.5 5199.8 5226.7 5240.4 5273.9 5282.0 5254.1 5284.1 5285.8 5312.7 5330.0 5345.8 5350.1 5351.0 5357.6 5384.7 4397.2 5361.7 5378.4 5386.4 5418.7 3905.6 4974.3 5111.7 5239.7 5305.0 5693.4 5719.5 5729.6 5751.2 5812.1 6277.6 6288.1 6301.7 6309.1 6313.2 6166.9 6196.8 6233.5 6243.4 6250.3 5811.3 5879.4 5926.6 5934.4 5935.8 6251.7 6273.7 6297.2 6300.1 6300.9 5217.4 5709.1 5890.8 6231.6 6234.9 6193.3 6208.5 6224.5 6259.3 6300.9 6230.8 6256.7 6268.7 6274.9 6295.5 6243.3 6291.3 6294.7 6296.2 6302.6 4841.6 4890.1 4894.3 4932.5 4948.5 4429.5 4431.5 4445.1 4498.3 4529.8 5874.6 5877.8 5880.3 5886.3 5894.1 6105.3 6230.7 6247.8 6266.9 6282.9 5755.3 5800.7 5805.1 5812.6 5914.2 5430.4 5432.2 5436.3 5447.0 5461.5 6243.9 6307.5 6321.4 6341.5 6344.3 6179.2 6256.7 6297.0 6300.7 6305.3 5531.7 6261.6 6293.4 6300.5 6369.9 6217.3 6256.3 6280.0 6287.0 6299.9 6078.7 6249.4 6282.5 6349.2 6360.4 6036.3 6089.9 6112.5 6114.7 6163.7 5171.5 6143.8 6192.0 6197.8 6201.3 5988.7 6077.2 6084.3 6104.1 6112.9 6044.8 6106.3 6130.2 6189.1 6210.9 4901.8 5872.9 5913.3 6087.6 6102.8 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:53262.79 Median:37242.44 stddev:106253.65 (285.3%) stddev-sans-first:106477.87 04:38:17 INFO - PROCESS | 1654 | Values: 498.6 503.8 512.2 514.4 532.4 28555.0 30410.2 31112.4 39534.8 40451.8 41201.8 41681.8 41689.3 41851.6 41867.0 9398.6 9583.5 9585.2 9591.8 9596.6 8617.0 8841.0 11337.7 11611.5 11634.9 11419.1 11502.0 11507.6 11531.7 11531.9 8594.4 9705.7 11424.4 11485.0 11506.3 7436.6 8619.8 8737.1 8746.2 11148.4 39171.4 39234.0 39239.5 39261.0 39289.4 3304.3 3338.6 3358.2 3573.7 3763.0 29321.0 29499.4 29672.3 30035.4 30088.2 3102.1 3149.7 3152.4 3192.7 3227.5 473803.0 474962.0 475418.0 478051.0 481953.0 47838.3 49569.8 49736.5 52683.7 52738.0 58442.8 59765.7 59913.0 63394.7 63639.0 14507.3 14641.0 14646.2 14654.0 14674.9 10256.3 10455.8 11198.8 11279.2 11295.4 13918.6 15240.0 15322.7 15648.3 15713.5 7094.8 7187.6 7189.0 7190.9 7219.4 871.6 888.1 936.2 1020.0 1060.3 28721.6 29189.0 29212.6 29413.6 29853.6 1052.2 1101.5 1133.3 1146.4 1173.1 14608.3 14771.7 14878.6 15005.5 15081.5 180420.1 181171.0 181263.0 181319.0 182275.0 55688.7 55965.4 55991.7 56073.7 56160.4 1352.8 1382.0 1400.5 1400.9 1401.5 28551.9 28791.0 28856.1 29755.9 29853.3 47471.1 47958.5 47985.3 47989.5 48046.8 463872.0 464654.0 465386.0 465932.0 467550.0 32881.5 33798.2 38905.0 39084.8 39794.0 38741.6 38823.6 44462.8 45865.5 48330.0 36937.6 37612.8 37740.8 38722.8 38863.6 37160.9 37324.0 37334.4 38344.6 38346.0 36630.5 37538.9 37674.0 37745.4 37795.8 30959.8 33735.3 33736.5 33767.0 33838.3 21381.9 24554.3 24941.5 25535.1 26528.1 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:32889.91 Median:1517.41 stddev:93083.99 (6134.4%) stddev-sans-first:93313.09 04:38:17 INFO - PROCESS | 1654 | Values: 370.3 370.9 380.0 386.0 398.5 11375.4 16231.7 18897.3 21255.3 21319.1 15975.4 17181.7 20349.3 20619.8 20909.4 5707.1 5927.7 5981.3 5981.9 5987.5 5541.9 5811.9 5867.4 5878.8 5880.2 4095.3 4317.5 5872.9 6139.2 6468.3 5654.6 6458.3 6490.4 6490.6 6490.8 5736.5 5824.7 5847.4 5856.5 5857.4 11183.6 13569.7 13622.7 13771.7 13796.2 2073.5 2119.2 2142.6 2633.2 2664.5 9814.8 9927.4 10324.3 10396.2 10540.2 1708.9 1833.5 1899.7 1928.4 1934.3 109712.0 121409.0 124419.4 125435.4 126916.0 11279.0 11300.9 11356.1 11458.7 11630.6 12063.9 14533.2 14548.9 14589.8 14591.1 7849.0 8080.4 8096.0 8220.7 8240.1 7823.8 7856.1 7868.1 7985.5 7986.9 4526.7 4531.5 4533.5 4554.5 4609.3 1867.9 1928.4 1933.5 1934.7 1940.4 782.0 843.5 879.2 882.3 922.0 19573.8 19697.8 19797.9 20325.0 21025.9 922.2 925.0 928.2 928.8 942.1 10549.8 11130.9 11139.0 11227.0 11290.0 541411.0 544283.0 545108.0 567899.0 580230.0 108788.5 117908.4 119634.0 123235.0 130237.7 963.2 966.6 993.7 993.9 994.8 18477.7 18773.8 18806.9 18839.0 18914.5 50832.7 50878.0 50965.0 51536.2 52228.0 66645.0 69070.7 69903.0 70620.0 71600.0 7850.6 7932.5 8066.4 8155.7 8481.7 9822.0 10253.4 12669.2 12924.7 13173.9 9201.8 10488.6 10663.8 10693.5 10883.1 10318.1 10875.2 11148.5 11218.7 11239.5 11186.7 11359.7 11544.0 11701.9 11821.5 5908.4 6908.9 7437.1 8070.6 8246.1 10010.7 11101.6 11156.5 11585.0 11953.3 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5640.78 Median:4672.95 stddev:3189.64 (68.3%) stddev-sans-first:3182.13 04:38:17 INFO - PROCESS | 1654 | Values: 1330.0 1411.5 1507.9 1742.2 1954.8 6809.3 8327.5 8497.7 8866.0 8875.3 8712.3 8735.7 8813.2 8815.3 8819.4 2363.3 2381.4 2389.7 2394.1 2400.3 2327.7 2360.6 2374.7 2377.4 2377.5 2317.5 2332.2 2342.5 2353.4 2358.4 2316.8 2338.8 2344.9 2349.6 2358.7 2294.9 2323.9 2327.2 2331.7 2341.6 8709.4 8794.5 8796.0 8815.1 8828.0 5141.0 5400.4 5409.3 5442.4 5465.9 3327.1 3466.9 3543.1 3553.8 3560.4 1021.4 1050.4 1055.0 1069.1 1079.7 9993.8 11528.6 11687.4 11749.6 11852.2 4408.4 4479.6 4643.6 4657.3 4658.1 9132.4 9142.7 9150.6 9166.6 9186.2 5254.6 5268.6 5269.0 5281.5 5281.7 4351.9 4449.2 4562.2 4687.8 4912.2 3217.5 3699.5 3718.6 3821.3 3841.1 1144.7 1161.3 1172.3 1173.2 1176.8 896.7 911.1 914.8 939.5 944.8 5699.6 5918.9 5955.5 6000.0 6077.0 415.8 448.1 450.3 450.9 457.9 3800.2 3974.4 3992.7 3993.6 3994.2 10412.3 10449.8 10735.1 10825.9 10895.8 10579.6 10708.1 10822.6 10823.4 10829.2 8080.6 8165.6 8259.1 8272.6 8358.5 5729.2 5763.8 5862.8 5932.7 5939.8 9613.9 9787.1 10019.9 10089.6 10212.9 10006.2 10214.5 10275.9 10288.9 10383.5 6957.1 7057.1 7072.3 7119.8 7160.7 8245.7 8360.0 8373.1 8380.5 8381.1 7424.3 7482.6 7512.3 7586.6 7695.3 7020.3 7364.6 7369.7 7412.4 7421.0 6933.6 6938.0 7012.6 7016.9 7035.2 4968.5 5004.2 5048.1 5060.2 5123.9 4561.6 4927.9 4938.7 5186.5 5205.1 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4114.02 Median:4419.62 stddev:1227.85 (27.8%) stddev-sans-first:1196.79 04:38:17 INFO - PROCESS | 1654 | Values: 263.2 292.1 309.1 312.9 316.4 4382.9 5300.4 5330.7 5351.2 5377.5 5103.2 5234.5 5253.3 5297.2 5358.4 4043.2 4049.3 4094.6 4116.9 4125.5 4126.1 4141.9 4143.5 4146.4 4162.4 2881.8 3934.0 3991.0 4009.3 4022.5 3659.7 3982.3 4097.0 4104.3 4109.5 3125.7 3542.3 3549.7 3557.5 3563.4 4819.6 4822.2 4830.5 5019.5 5276.0 4455.9 4560.9 4596.4 4612.7 4629.7 5685.7 5699.0 5708.8 5744.6 5746.9 3255.8 3550.7 3817.5 3827.3 3833.5 5207.5 5499.5 5749.2 5954.1 5989.6 3715.6 3747.3 3891.7 3893.7 3895.1 3933.4 3940.6 3946.3 3958.9 3960.9 3755.3 3888.6 4241.6 4630.6 4631.4 4639.8 5578.9 5581.5 5643.9 5666.9 1033.8 1307.9 1308.3 1315.3 1323.9 755.2 805.4 812.5 818.8 823.3 3857.9 4053.9 4400.0 4477.0 4508.4 4360.5 4527.7 4844.9 4884.5 4885.6 4051.5 4307.5 4413.8 4435.2 4445.4 2128.0 2245.4 2298.6 2414.5 2588.1 4833.3 4996.8 5014.7 5051.0 5095.7 4529.8 4608.3 4807.7 4990.7 5002.8 4297.4 4400.7 4668.0 4976.8 5082.8 4425.5 4469.9 4685.9 4829.5 4923.5 3967.6 4495.5 4678.8 4831.0 4853.3 4017.6 4334.9 4632.8 4827.5 5025.8 2847.0 3138.8 3250.3 3395.8 3422.9 4392.3 4755.1 4775.3 4895.6 4922.8 4347.0 4391.5 4403.9 4405.6 4670.5 4071.0 4121.9 4714.1 4718.3 4781.4 4018.0 4317.3 4594.7 4686.4 4695.4 3981.1 4128.6 4289.1 4573.6 4693.0 3770.4 4281.0 4341.4 4559.7 4585.0 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24835.58 Median:3870.06 stddev:40039.61 (1034.6%) stddev-sans-first:40110.76 04:38:17 INFO - PROCESS | 1654 | Values: 653.9 655.5 716.5 808.2 822.8 14971.0 15259.5 15852.9 15878.3 16097.3 14311.1 14712.7 14743.7 14763.7 14764.7 709.7 725.0 892.9 894.9 896.7 727.2 736.1 863.5 887.5 898.3 937.2 943.4 944.7 945.5 948.1 934.7 935.6 935.8 937.3 938.1 555.6 571.6 687.8 702.8 711.0 15128.8 15179.7 15190.0 15198.8 15228.6 13712.0 13980.3 14146.2 14168.6 14368.9 12400.9 12557.6 12651.6 12670.5 12973.2 4462.6 4537.1 4585.4 4635.4 4771.3 113801.4 115431.0 116805.0 117189.0 121041.4 10905.3 10991.7 11198.3 11257.4 11287.1 21998.3 22436.0 22484.8 22491.0 22500.0 6871.6 7321.1 7913.0 7966.2 7978.0 4210.5 4339.7 4395.7 4409.8 4410.3 3408.0 3437.4 3493.0 3497.0 3529.6 610.8 638.1 649.6 650.7 651.5 593.3 606.9 610.6 637.1 646.5 7887.8 8015.5 8280.3 8866.2 8893.2 606.8 619.3 621.5 636.8 646.1 4213.4 4253.7 4325.1 4390.7 4518.2 107827.0 122747.8 132964.0 138131.0 144020.3 131945.0 132209.0 137199.0 137926.0 138047.0 117918.0 119551.2 119731.0 120290.0 122457.0 5905.6 7252.2 8145.1 8174.0 8544.6 59497.0 63300.0 64162.4 67477.7 68260.0 88747.6 96066.0 97537.5 99690.5 100588.0 11538.4 11670.4 11690.4 11800.4 12303.1 10323.0 12563.6 12599.1 12638.6 12736.0 11600.9 11897.6 11962.7 12022.4 12318.7 10148.3 11667.0 12115.6 12294.4 12349.5 11354.8 11491.3 11591.6 11699.0 12113.7 9921.9 9949.6 10080.8 10089.8 10270.6 8560.1 8961.7 9137.9 10041.7 10099.5 04:38:17 INFO - PROCESS | 1654 | -------- Summary: end -------- 04:38:17 INFO - PROCESS | 1654 | 04:38:17 INFO - TEST-INFO | 1654: exit 0 04:38:17 INFO - TEST-OK | dromaeo_css | took 1119338ms 04:38:17 INFO - TEST-START | kraken 04:38:17 INFO - operating with platform_type : mac_ 04:38:17 INFO - Initialising browser for kraken test... 04:38:17 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpvnOvhM/profile http://localhost:49266/getInfo.html) 04:38:20 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 04:38:20 INFO - PROCESS | 1662 | colorDepth:24 04:38:20 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 04:38:20 INFO - PROCESS | 1662 | __metrics 04:38:20 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:38:20 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:21 INFO - TEST-INFO | 1662: exit 0 04:38:21 INFO - Browser initialized. 04:38:21 INFO - Running cycle 1/1 for kraken test... 04:38:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpvnOvhM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:32 INFO - PROCESS | 1663 | RSS: Main: 240078848 04:38:32 INFO - PROCESS | 1663 | 04:38:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:36 INFO - PROCESS | 1663 | RSS: Main: 291012608 04:38:36 INFO - PROCESS | 1663 | 04:38:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 04:38:39 INFO - PROCESS | 1663 | RSS: Main: 289509376 04:38:39 INFO - PROCESS | 1663 | 04:38:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 04:38:43 INFO - PROCESS | 1663 | RSS: Main: 383315968 04:38:43 INFO - PROCESS | 1663 | 04:38:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 04:38:46 INFO - PROCESS | 1663 | RSS: Main: 284311552 04:38:46 INFO - PROCESS | 1663 | 04:38:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:49 INFO - PROCESS | 1663 | RSS: Main: 289660928 04:38:49 INFO - PROCESS | 1663 | 04:38:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:52 INFO - PROCESS | 1663 | RSS: Main: 328171520 04:38:52 INFO - PROCESS | 1663 | 04:38:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:55 INFO - PROCESS | 1663 | RSS: Main: 328339456 04:38:55 INFO - PROCESS | 1663 | 04:38:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 04:38:59 INFO - PROCESS | 1663 | RSS: Main: 327262208 04:38:59 INFO - PROCESS | 1663 | 04:39:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:01 INFO - PROCESS | 1663 | RSS: Main: 303071232 04:39:01 INFO - PROCESS | 1663 | 04:39:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:03 INFO - PROCESS | 1663 | RSS: Main: 305692672 04:39:03 INFO - PROCESS | 1663 | 04:39:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:06 INFO - PROCESS | 1663 | RSS: Main: 310116352 04:39:06 INFO - PROCESS | 1663 | 04:39:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:10 INFO - PROCESS | 1663 | RSS: Main: 318156800 04:39:10 INFO - PROCESS | 1663 | 04:39:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:13 INFO - PROCESS | 1663 | RSS: Main: 317546496 04:39:13 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 04:39:15 INFO - PROCESS | 1663 | RSS: Main: 361537536 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | __start_tp_report 04:39:15 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 04:39:15 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 04:39:15 INFO - PROCESS | 1663 | |i|pagename|runs| 04:39:15 INFO - PROCESS | 1663 | |0;ai-astar;113;114;115;115;115;115;115;119;166;157 04:39:15 INFO - PROCESS | 1663 | |1;audio-beat-detection;151;114;112;148;112;113;113;110;142;112 04:39:15 INFO - PROCESS | 1663 | |2;audio-dft;185;185;184;184;182;185;181;184;183;181 04:39:15 INFO - PROCESS | 1663 | |3;audio-fft;79;59;59;88;62;59;57;57;81;56 04:39:15 INFO - PROCESS | 1663 | |4;audio-oscillator;83;70;93;69;69;70;93;68;69;91 04:39:15 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;86;88;85;87;83;87;84;87;84 04:39:15 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;92;93;92;93;92;93;93;93;92 04:39:15 INFO - PROCESS | 1663 | |7;imaging-desaturate;81;83;80;79;82;83;83;83;83;83 04:39:15 INFO - PROCESS | 1663 | |8;json-parse-financial;57;55;53;53;53;54;56;54;55;54 04:39:15 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;71;70;74;77;76;70;70;70;74 04:39:15 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;91;86;86;85;86;80;86;87;90;92 04:39:15 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;143;149;145;146;144;140;147;143;188;148 04:39:15 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;170;170;171;170;169;175;237;218;169;171 04:39:15 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;70;70;69;68;69;71;68;68;68;70 04:39:15 INFO - PROCESS | 1663 | __end_tp_report 04:39:15 INFO - PROCESS | 1663 | __start_cc_report 04:39:15 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1941 04:39:15 INFO - PROCESS | 1663 | __end_cc_report 04:39:15 INFO - PROCESS | 1663 | __startTimestamp1476790755890__endTimestamp 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | ------- Summary: start ------- 04:39:15 INFO - PROCESS | 1663 | Number of tests: 14 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:124.40 Median:115.00 stddev:19.73 (17.2%) stddev-sans-first:20.49 04:39:15 INFO - PROCESS | 1663 | Values: 113.0 114.0 115.0 115.0 115.0 115.0 115.0 119.0 166.0 157.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:113.50 stddev:16.94 (14.9%) stddev-sans-first:14.54 04:39:15 INFO - PROCESS | 1663 | Values: 151.0 114.0 112.0 148.0 112.0 113.0 113.0 110.0 142.0 112.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.58 (0.9%) stddev-sans-first:1.56 04:39:15 INFO - PROCESS | 1663 | Values: 185.0 185.0 184.0 184.0 182.0 185.0 181.0 184.0 183.0 181.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.50 stddev:12.03 (19.9%) stddev-sans-first:11.76 04:39:15 INFO - PROCESS | 1663 | Values: 79.0 59.0 59.0 88.0 62.0 59.0 57.0 57.0 81.0 56.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:76.50 stddev:11.12 (14.5%) stddev-sans-first:11.61 04:39:15 INFO - PROCESS | 1663 | Values: 83.0 70.0 93.0 69.0 69.0 70.0 93.0 68.0 69.0 91.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.73 04:39:15 INFO - PROCESS | 1663 | Values: 87.0 86.0 88.0 85.0 87.0 83.0 87.0 84.0 87.0 84.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 04:39:15 INFO - PROCESS | 1663 | Values: 94.0 92.0 93.0 92.0 93.0 92.0 93.0 93.0 93.0 92.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:83.00 stddev:1.49 (1.8%) stddev-sans-first:1.54 04:39:15 INFO - PROCESS | 1663 | Values: 81.0 83.0 80.0 79.0 82.0 83.0 83.0 83.0 83.0 83.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.35 (2.5%) stddev-sans-first:1.05 04:39:15 INFO - PROCESS | 1663 | Values: 57.0 55.0 53.0 53.0 53.0 54.0 56.0 54.0 55.0 54.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:3.56 (4.9%) stddev-sans-first:2.83 04:39:15 INFO - PROCESS | 1663 | Values: 65.0 71.0 70.0 74.0 77.0 76.0 70.0 70.0 70.0 74.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:3.45 (4.0%) stddev-sans-first:3.32 04:39:15 INFO - PROCESS | 1663 | Values: 91.0 86.0 86.0 85.0 86.0 80.0 86.0 87.0 90.0 92.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:146.50 stddev:13.86 (9.5%) stddev-sans-first:14.51 04:39:15 INFO - PROCESS | 1663 | Values: 143.0 149.0 145.0 146.0 144.0 140.0 147.0 143.0 188.0 148.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:171.00 stddev:24.45 (14.3%) stddev-sans-first:25.55 04:39:15 INFO - PROCESS | 1663 | Values: 170.0 170.0 171.0 170.0 169.0 175.0 237.0 218.0 169.0 171.0 04:39:15 INFO - PROCESS | 1663 | 04:39:15 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.10 (1.6%) stddev-sans-first:1.12 04:39:15 INFO - PROCESS | 1663 | Values: 70.0 70.0 69.0 68.0 69.0 71.0 68.0 68.0 68.0 70.0 04:39:15 INFO - PROCESS | 1663 | -------- Summary: end -------- 04:39:15 INFO - PROCESS | 1663 | 04:39:16 INFO - TEST-INFO | 1663: exit 0 04:39:16 INFO - TEST-OK | kraken | took 59154ms 04:39:16 INFO - SUITE-END | took 1178s 04:39:17 INFO - Completed test suite (00:19:38) 04:39:17 INFO - javascript benchmark 04:39:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.2088436122244, 3339.7328213742903, 3367.3770352484776, 3368.3936891359554, 3390.8813191538284, 5600.6079574429805, 5670.518005969492, 5721.971390143054, 5800.216970708953, 5817.592768506201, 5683.8010669626465, 5738.56960727945, 5750.338711048231, 5759.769609215637, 5768.480836724694, 5199.766010529516, 5226.660267082647, 5240.371155461331, 5273.894522109575, 5282.0, 5254.080535906221, 5284.128118860383, 5285.841424757264, 5312.654677445954, 5329.987302412529, 5345.839624811262, 5350.117230656937, 5351.0, 5357.624966252364, 5384.6769193848495, 4397.164538737629, 5361.678299302054, 5378.381486129106, 5386.380566234855, 5418.674879507203, 3905.5703872573995, 4974.253861920741, 5111.744412779346, 5239.659422137549, 5304.9734751326, 5693.373728889819, 5719.542436605103, 5729.598928075036, 5751.194832723422, 5812.099124635688, 6277.623342599459, 6288.088227207029, 6301.747930082791, 6309.116723658692, 6313.179286692746, 6166.876662466726, 6196.752129914798, 6233.501319894398, 6243.37566243372, 6250.34371391002, 5811.27359080115, 5879.353271140171, 5926.555508336892, 5934.37689042653, 5935.792247271324, 6251.718672659741, 6273.654948977759, 6297.2128483939505, 6300.117983482316, 6300.873982520416, 5217.426083130853, 5709.0865461525955, 5890.793822216202, 6231.563790534619, 6234.937650623527, 6193.318734939153, 6208.534359923024, 6224.470919971763, 6259.342769009279, 6300.873982520324, 6230.7819226326865, 6256.749730010749, 6268.749250030039, 6274.905876411857, 6295.527835412362, 6243.344448832898, 6291.276503202191, 6294.748210071637, 6296.181496405529, 6302.558820882494, 4841.588464980516, 4890.144224760653, 4894.3147959285725, 4932.53140951609, 4948.455669876311, 4429.512753597101, 4431.534688857688, 4445.088756804847, 4498.302763071729, 4529.773511324421, 5874.559408044413, 5877.764889404376, 5880.26496687914, 5886.3230728465915, 5894.115882617642, 6105.308121371101, 6230.719617617218, 6247.812565623039, 6266.874662506724, 6282.905756413657, 5755.251817263729, 5800.651960882361, 5805.071188609802, 5812.6221795584, 5914.201582786355, 5430.402655707869, 5432.158015507603, 5436.266104075899, 5447.0, 5461.535769459561, 6243.875122497434, 6307.463865571386, 6321.399467050623, 6341.460975817107, 6344.270408902943, 6179.227596550431, 6256.655883926245, 6296.992481202986, 6300.684965751602, 6305.274893387319, 5531.695756733418, 6261.56169068179, 6293.402126797947, 6300.464460520907, 6369.936300636934, 6217.253929528486, 6256.280527739368, 6280.0265958774635, 6286.9626511625065, 6299.905501417574, 6078.696065196634, 6249.437550620466, 6282.528810339151, 6349.238091428873, 6360.363963603602, 6036.3058248302, 6089.908651370321, 6112.480439162543, 6114.6636934969, 6163.691815409122, 5171.456997015259, 6143.788236235041, 6192.0, 6197.845053873509, 6201.348858369806, 5988.670623115596, 6077.179580756718, 6084.269887613515, 6104.053871649901, 6112.938870611415, 6044.818655440344, 6106.297775755667, 6130.233720784902, 6189.102580125947, 6210.937890621036, 4901.803927842989, 5872.882542349043, 5913.349531551612, 6087.634741915322, 6102.786402475892], "value": 5710.203165571396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.6384870968548, 503.76828653941106, 512.2367672168469, 514.4289838279511, 532.4116850879777, 28555.0, 30410.239744006383, 31112.377752444936, 39534.80232598833, 40451.78644640658, 41201.793991030005, 41681.791591042005, 41689.332426702895, 41851.581484185146, 41867.0, 9398.62405503779, 9583.472908990003, 9585.233181345511, 9591.760205994837, 9596.616135354578, 8616.956915215447, 8841.0, 11337.716557086056, 11611.535538578446, 11634.941825290862, 11419.086473082176, 11502.0, 11507.59723409681, 11531.711707207303, 11531.884681153208, 8594.398392112555, 9705.660301889471, 11424.371659558721, 11484.966353028267, 11506.252093613972, 7436.590987495686, 8619.827603447897, 8737.126287371275, 8746.212840844355, 11148.442577871156, 39171.41242881359, 39234.019149521206, 39239.50646909435, 39261.0, 39289.41065884014, 3304.2895777407734, 3338.565986421774, 3358.22760765023, 3573.6605022522817, 3762.9651845742364, 29321.0, 29499.410011799642, 29672.258193545335, 30035.399292014037, 30088.24779380533, 3102.115896969353, 3149.700778426046, 3152.3695260947675, 3192.7260854724746, 3227.5481432599454, 473803.0, 474962.0, 475418.0, 478051.0, 481953.0, 47838.28242576364, 49569.752151239736, 49736.50263497391, 52683.73658131685, 52738.0, 58442.83114337774, 59765.70117149474, 59913.0, 63394.68302658457, 63639.045414318825, 14507.274636268145, 14641.0, 14646.194459304841, 14654.047486913316, 14674.853251467563, 10256.282060255711, 10455.84316235257, 11198.776024479464, 11279.154063445274, 11295.378754168436, 13918.633832248543, 15240.009399389226, 15322.70561829212, 15648.2958266876, 15713.528594142193, 7094.787156385317, 7187.5687458752645, 7189.0, 7190.928090719026, 7219.422446204291, 871.6164887449502, 888.0852721696663, 936.1901954809041, 1020.0105897279627, 1060.3213943076437, 28721.56917646237, 29189.0, 29212.561811572843, 29413.55879661807, 29853.552196717068, 1052.1687866585464, 1101.5263436722125, 1133.3143448213877, 1146.358039497884, 1173.12015988009, 14608.34262458192, 14771.704565908836, 14878.645981379408, 15005.474808381654, 15081.47214847497, 180420.0978995123, 181171.0, 181263.0, 181319.0, 182275.0, 55688.72155639196, 55965.440345596835, 55991.720041400346, 56073.7196314024, 56160.43839561634, 1352.8241328627216, 1381.9930900345635, 1400.4958215042577, 1400.9229492377813, 1401.488456713272, 28551.857240713663, 28791.0, 28856.104425902235, 29755.851220743756, 29853.253668657588, 47471.116688079346, 47958.52041479541, 47985.28022079602, 47989.5201047999, 48046.75976620094, 463872.0, 464654.0, 465386.0, 465932.0, 467550.0, 32881.506777398834, 33798.15504612306, 38905.0, 39084.80457597694, 39794.0, 38741.61258387493, 38823.611763882, 44462.77768611136, 45865.54134458613, 48330.0, 36937.63062369342, 37612.811935940146, 37740.81129594444, 38722.838314850596, 38863.611363886, 37160.88517344484, 37324.0, 37334.43998339973, 38344.61655383522, 38346.0413489665, 36630.450543242405, 37538.87383378503, 37674.0, 37745.43381849329, 37795.81102094472, 30959.845200773852, 33735.3252934935, 33736.49395259122, 33766.98699039033, 33838.32323353568, 21381.893090534446, 24554.263372098867, 24941.501169976862, 25535.106271281158, 26528.071517496795], "value": 18816.80888322605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.29089294001983, 370.94250391189377, 379.9753016053957, 385.9710521710869, 398.5396866619056, 11375.431228438587, 16231.675366492664, 18897.33859314924, 21255.25606603769, 21319.147234110635, 15975.440859569917, 17181.74227386587, 20349.287774927845, 20619.793802061973, 20909.37271881846, 5707.086866101425, 5927.673977931212, 5981.342052374235, 5981.88036239275, 5987.461128498434, 5541.861453463675, 5811.883762324751, 5867.383924687889, 5878.764849406019, 5880.176775251447, 4095.262852686515, 4317.4819021717285, 5872.941270587304, 6139.201903752506, 6468.2561505426775, 5654.575906806965, 6458.2895881453005, 6490.383413575702, 6490.610563366213, 6490.837729056764, 5736.541076713853, 5824.650520968756, 5847.386024467412, 5856.472917437409, 5857.414258574151, 11183.608573699881, 13569.660758481117, 13622.659433514142, 13771.724565508734, 13796.172229666152, 2073.523089689365, 2119.162930642403, 2142.635751922177, 2633.2363614551755, 2664.5203863304596, 9814.754631134207, 9927.354721943122, 10324.328918620266, 10396.16830653546, 10540.156787456985, 1708.897466152035, 1833.5232839461703, 1899.7435346228222, 1928.4407521818655, 1934.303650685752, 109712.0, 121409.0, 124419.37790310991, 125435.3728231353, 126916.0, 11279.0, 11300.943495282636, 11356.148288878367, 11458.656240312805, 11630.592929247436, 12063.879361206451, 14533.200673963034, 14548.927255363868, 14589.832813374904, 14591.124532528082, 7848.960755196187, 8080.39397045224, 8096.0, 8220.712275070344, 8240.093589705128, 7823.843523129505, 7856.135825059239, 7868.055833299926, 7985.5208687478935, 7986.920130798734, 4526.705764125387, 4531.524189960007, 4533.5013148553635, 4554.544545545486, 4609.262517997105, 1867.8886062792617, 1928.3732786844332, 1933.497290704399, 1934.6517626827024, 1940.3596813051659, 781.968721251155, 843.5444859775653, 879.2149795132018, 882.2897567458258, 921.9861702074475, 19573.804261957484, 19697.803021969885, 19797.91111488882, 20325.0, 21025.89487052555, 922.2207234886511, 924.9768755781159, 928.1924725488733, 928.7538802217417, 942.0955882352881, 10549.789004219872, 11130.888691112985, 11139.0, 11227.045701115496, 11290.04034657047, 541411.0, 544283.0, 545108.0, 567899.0, 580230.0, 108788.4560577192, 117908.41045794888, 119634.0, 123235.0, 130237.69762302445, 963.1957315641378, 966.6423423333271, 993.7416271769392, 993.9006099390148, 994.796066806303, 18477.72283415777, 18773.812261877752, 18806.905965470087, 18839.0, 18914.52713682169, 50832.74583627058, 50878.0, 50965.0, 51536.22695659493, 52228.0, 66645.0, 69070.65464672644, 69903.0, 70620.0, 71600.0, 7850.607469626381, 7932.532481490943, 8066.435349525477, 8155.714549990722, 8481.703140390056, 9821.95089024579, 10253.384796912209, 12669.176503527242, 12924.676883077998, 13173.868261317264, 9201.76995575116, 10488.632897848538, 10663.826979032456, 10693.502909592507, 10883.129349652167, 10318.071373576415, 10875.238733288594, 11148.498317575566, 11218.66344009681, 11239.494222760159, 11186.720331991766, 11359.659210223706, 11544.0, 11701.88298117008, 11821.468033938321, 5908.409159084229, 6908.930910690829, 7437.107547094383, 8070.5964701763505, 8246.05170405387, 10010.749731256778, 11101.5559377624, 11156.497957591766, 11585.0, 11953.342566158944], "value": 9172.50598309753, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.042369493964, 1411.505972909482, 1507.8916996007936, 1742.2072956804648, 1954.8045195480463, 6809.28502507237, 8327.458715183517, 8497.745067647966, 8865.980412252593, 8875.289976801856, 8712.259457946066, 8735.694250701226, 8813.1627495388, 8815.250703690179, 8819.426737262074, 2363.267387109993, 2381.4403615150427, 2389.6773935518745, 2394.0543485323287, 2400.2679182849224, 2327.674125622414, 2360.5986982213067, 2374.7387787343378, 2377.3818807110188, 2377.500724847784, 2317.513322202331, 2332.2070496031347, 2342.496363281894, 2353.376355265856, 2358.445765245166, 2316.7683231676865, 2338.83628146029, 2344.9179278725164, 2349.635806450003, 2358.740538540759, 2294.8852557372234, 2323.8838058097026, 2327.197116994634, 2331.661909023182, 2341.555104530134, 8709.390342676015, 8794.472331660121, 8796.0, 8815.118488151198, 8828.0, 5141.023205590963, 5400.432954539756, 5409.323834520685, 5442.401335853053, 5465.863353416196, 3327.1183136468853, 3466.861325546975, 3543.0965103898343, 3553.8223088845452, 3560.4481305397703, 1021.4331046269317, 1050.448514529878, 1054.973625659357, 1069.096613361708, 1079.6545105566222, 9993.800123997553, 11528.59649912249, 11687.415629218505, 11749.588764393206, 11852.170348075639, 4408.426904502394, 4479.574440428154, 4643.558861908114, 4657.301404789308, 4658.138244424725, 9132.360734748636, 9142.680006199751, 9150.63397464094, 9166.633334666538, 9186.173244408035, 5254.579633629301, 5268.552173065333, 5268.9736551317, 5281.471852814688, 5281.683099014072, 4351.8694439166875, 4449.243628583149, 4562.201614717411, 4687.7656117194, 4912.214045752662, 3217.533457648628, 3699.5190625218547, 3718.5537735471917, 3821.2739579480367, 3841.0589405595806, 1144.6794897428733, 1161.3380373187372, 1172.2556176827604, 1173.1729130962651, 1176.8352430659716, 896.7444278380631, 911.1207684584408, 914.7850255190025, 939.4645052320112, 944.7826999790087, 5699.629524080921, 5918.940810591925, 5955.493783028404, 6000.0, 6076.966915624266, 415.77340349508984, 448.1149729284702, 450.31776858060067, 450.93236014597414, 457.9335996280521, 3800.201957588937, 3974.364101743707, 3992.720509564361, 3993.6006399360413, 3994.2211268802303, 10412.32319899204, 10449.84325235122, 10735.141188705042, 10825.945870270756, 10895.782084358269, 10579.629712960163, 10708.08981236588, 10822.621208257673, 10823.350598964087, 10829.24195306321, 8080.636371363303, 8165.591720413956, 8259.132791056853, 8272.586370681442, 8358.540280284642, 5729.197912292366, 5763.827085187451, 5862.750860484557, 5932.733027013708, 5939.762409503572, 9613.903860961302, 9787.070228328583, 10019.949900250453, 10089.596416143271, 10212.897871021492, 10006.249531285037, 10214.54034568461, 10275.897241027793, 10288.897111029093, 10383.532741026824, 6957.095577574883, 7057.117860267466, 7072.292770722886, 7119.75080872167, 7160.749373771893, 8245.711400100967, 8359.958200209203, 8373.120822313813, 8380.497170169809, 8381.078081411162, 7424.257574242532, 7482.588457634883, 7512.32389084985, 7586.582737949466, 7695.307422332017, 7020.262872398324, 7364.631768411665, 7369.668364923484, 7412.444066695128, 7421.035265415461, 6933.583984960918, 6938.0, 7012.614306213207, 7016.929830701832, 7035.1909530404655, 4968.478309777422, 5004.17431123875, 5048.091343558195, 5060.165072762953, 5123.897522049464, 4561.589456948891, 4927.901441971212, 4938.728369939688, 5186.4554221807675, 5205.115130427761], "value": 4449.321869152523, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.19593641425445, 292.146930961592, 309.12209325515533, 312.94679904416245, 316.4493780821369, 4382.868513944582, 5300.443453437387, 5330.680159190451, 5351.170568561879, 5377.542908852743, 5103.209002604603, 5234.528892399683, 5253.3170687810625, 5297.17893726473, 5358.410574836775, 4043.2115737431213, 4049.2711311963835, 4094.5905409458965, 4116.917661646765, 4125.463689720332, 4126.112885729567, 4141.875743727693, 4143.513891665007, 4146.419501269825, 4162.43807086044, 2881.7550508206828, 3933.9968308081397, 3991.0221995611114, 4009.3384591542363, 4022.537408198051, 3659.743817932719, 3982.2677135446174, 4096.9795151024355, 4104.302268614328, 4109.465769449982, 3125.687211371207, 3542.291541691672, 3549.698275646573, 3557.51973483579, 3563.394222982073, 4819.6385271104455, 4822.180229361017, 4830.516948305177, 5019.52314530119, 5275.973620131913, 4455.933161002587, 4560.8859778505475, 4596.4254468191475, 4612.655824527191, 4629.675922685414, 5685.715714214314, 5698.971505142447, 5708.828735137952, 5744.597878148531, 5746.873656746989, 3255.7790828439333, 3550.668499312758, 3817.541894972593, 3827.349350610403, 3833.5399752029934, 5207.531322180984, 5499.477549632778, 5749.223854779593, 5954.1244507979845, 5989.610675306091, 3715.6098609646137, 3747.2880152770886, 3891.703894702139, 3893.7079719021185, 3895.104126051024, 3933.4296527003426, 3940.581390699346, 3946.3291240489184, 3958.8614398495915, 3960.9207815844097, 3755.2864955658883, 3888.6305800948867, 4241.618254357123, 4630.560096790799, 4631.421072365954, 4639.770460827884, 5578.86052848682, 5581.469760372758, 5643.887122257532, 5666.914996275059, 1033.7674023344687, 1307.9346032698327, 1308.3196737696344, 1315.316395014383, 1323.8742319479634, 755.2447552447552, 805.3798575097143, 812.5368539932182, 818.8198596308803, 823.2714048067503, 3857.9035524112123, 4053.91892162161, 4399.956000440018, 4477.0, 4508.436445444319, 4360.520342762294, 4527.728336299832, 4844.903101938012, 4884.508900460791, 4885.560299573055, 4051.541445079769, 4307.5261721210645, 4413.762787723757, 4435.161496642151, 4445.444094566876, 2127.9890503474376, 2245.4498647831388, 2298.6322188449767, 2414.5291668124896, 2588.120039186648, 4833.347498087784, 4996.800127994839, 5014.674046186986, 5050.974745126251, 5095.745212739423, 4529.84145554904, 4608.308753686973, 4807.687500312469, 4990.650654454226, 5002.849914502571, 4297.376880352332, 4400.69195156336, 4668.0, 4976.755811047238, 5082.822101226439, 4425.468943726773, 4469.888252793706, 4685.906281874275, 4829.541193586604, 4923.458419573915, 3967.5635680074593, 4495.505494395548, 4678.836240731558, 4830.95169048305, 4853.272009198648, 4017.6418232535843, 4334.894601876501, 4632.791524381343, 4827.468978412302, 5025.824096156617, 2846.9715302847535, 3138.8430578471443, 3250.293595862191, 3395.847186876547, 3422.863085476553, 4392.3411488277015, 4755.072760811747, 4775.307580400892, 4895.583875370491, 4922.7538623067985, 4347.044010073054, 4391.494978077434, 4403.9119217614825, 4405.625521830681, 4670.5329467053025, 4070.982254436391, 4121.91756164869, 4714.104320179292, 4718.292256161603, 4781.422130696931, 4017.991004497751, 4317.273090763594, 4594.659370069417, 4686.367340409138, 4695.440984663435, 3981.124152686404, 4128.60778226068, 4289.142171565637, 4573.611243044245, 4692.976535117303, 3770.4155855842387, 4281.046078206028, 4341.435613370241, 4559.658025648156, 4584.977075114736], "value": 3728.552168430134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9149910511633, 655.51164382535, 716.5306724095717, 808.2200676347331, 822.7860756203389, 14971.0, 15259.542213733577, 15852.920735396321, 15878.285477153528, 16097.275622596982, 14311.14133152009, 14712.705745885076, 14743.705125897475, 14763.704725905476, 14764.704705905875, 709.6912842913323, 724.9818754531126, 892.9285657147445, 894.9239314658262, 896.66375109334, 727.1601300497933, 736.057845957173, 863.5336918064238, 887.5118684723409, 898.3352319283748, 937.194013148695, 943.377370935183, 944.7024187380987, 945.5414124149781, 948.080362048815, 934.700895713372, 935.6210734652443, 935.822193783179, 937.2829785214317, 938.061938061938, 555.5722093987607, 571.5598988778659, 687.7661595057655, 702.8032150997677, 711.0365454808712, 15128.848711512854, 15179.696406071927, 15190.0, 15198.848011519854, 15228.619284517865, 13712.0, 13980.300984950814, 14146.221957792317, 14168.574942751733, 14368.856311436857, 12400.937995310056, 12557.560485382968, 12651.620451386472, 12670.49318027287, 12973.221606703533, 4462.553744625544, 4537.137943790669, 4585.358049873021, 4635.397398338228, 4771.33201351811, 113801.4309928445, 115431.0, 116805.0, 117189.0, 121041.39479302635, 10905.345679259111, 10991.725206869733, 11198.272112312674, 11257.380844053656, 11287.097032237401, 21998.34004979853, 22436.0, 22484.775152248596, 22491.0, 22499.987500562514, 6871.587704737732, 7321.121465424183, 7912.960435197787, 7966.163552826985, 7977.960110199412, 4210.536840947493, 4339.717918335298, 4395.692301538926, 4409.757463339547, 4410.316400957857, 3407.982960085233, 3437.415639341318, 3493.0, 3497.0, 3529.576450825917, 610.8472881779555, 638.084348959245, 649.5777744466135, 650.7169381319142, 651.5146216068964, 593.2702775586054, 606.9332373438918, 610.6305685060563, 637.0953246390137, 646.4666650013758, 7887.763367098882, 8015.47899386538, 8280.337572994145, 8866.157715017063, 8893.232347911036, 606.7633622887078, 619.2661695890384, 621.5245337316957, 636.8089573128043, 646.1083704487777, 4213.367994800743, 4253.659707223414, 4325.134973005349, 4390.670699697535, 4518.2319005769095, 107827.0, 122747.77252227542, 132964.0, 138131.0, 144020.27989860193, 131945.0, 132209.0, 137199.0, 137926.0, 138047.0, 117917.99999999828, 119551.20673190083, 119731.0, 120290.0, 122457.0, 5905.645661260338, 7252.202257751748, 8145.104038555873, 8174.0, 8544.607509897238, 59496.95752495624, 63300.0, 64162.358376415636, 67477.66261168662, 68260.0, 88747.55626221828, 96066.0, 97537.51231243799, 99690.50464243187, 100588.0, 11538.403963894025, 11670.358130302575, 11690.357030363071, 11800.409979500819, 12303.077269204667, 10323.0, 12563.623091307276, 12599.118061735591, 12638.620841374774, 12736.0, 11600.94199528997, 11897.583584574499, 11962.70093247641, 12022.398880056136, 12318.692032699255, 10148.340357876714, 11667.0, 12115.636530904087, 12294.385280736105, 12349.506019759108, 11354.829677554679, 11491.253068550517, 11591.594294199662, 11699.0, 12113.69715757113, 9921.851172232278, 9949.602015919281, 10080.798384032132, 10089.848652270075, 10270.6405275815, 8560.070627316152, 8961.731148065568, 9137.862932055892, 10041.682266317235, 10099.495025248854], "value": 7611.147741438064, "unit": "score"}], "name": "dromaeo_css", "value": 7065.937029879656, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 119.0, 166.0, 157.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 112.0, 148.0, 112.0, 113.0, 113.0, 110.0, 142.0, 112.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 184.0, 182.0, 185.0, 181.0, 184.0, 183.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 62.0, 59.0, 57.0, 57.0, 81.0, 56.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 93.0, 69.0, 69.0, 70.0, 93.0, 68.0, 69.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 85.0, 87.0, 83.0, 87.0, 84.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 93.0, 92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 80.0, 79.0, 82.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 53.0, 53.0, 54.0, 56.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 70.0, 74.0, 77.0, 76.0, 70.0, 70.0, 70.0, 74.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 86.0, 85.0, 86.0, 80.0, 86.0, 87.0, 90.0, 92.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 149.0, 145.0, 146.0, 144.0, 140.0, 147.0, 143.0, 188.0, 148.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 171.0, 170.0, 169.0, 175.0, 237.0, 218.0, 169.0, 171.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 70.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1447.6, "alertThreshold": 2.0}]} 04:39:17 INFO - Return code: 0 04:39:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:39:17 INFO - # TBPL SUCCESS # 04:39:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:17 INFO - 2016-10-18 04:39:17.214 screenresolution[1667:9837] starting screenresolution argv=screenresolution get 04:39:17 INFO - 2016-10-18 04:39:17.217 screenresolution[1667:9837] Display 0: 1600x1200x32@60 04:39:17 INFO - 2016-10-18 04:39:17.223 screenresolution[1668:9840] starting screenresolution argv=screenresolution list 04:39:17 INFO - Available Modes on Display 0 04:39:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:17 INFO - Intel Iris: 04:39:17 INFO - Chipset Model: Intel Iris 04:39:17 INFO - Type: GPU 04:39:17 INFO - Bus: Built-In 04:39:17 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:17 INFO - Vendor: Intel (0x8086) 04:39:17 INFO - Device ID: 0x0a2e 04:39:17 INFO - Revision ID: 0x0009 04:39:17 INFO - Displays: 04:39:17 INFO - Display: 04:39:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:17 INFO - Display Serial Number: 1600x1200 60 04:39:17 INFO - Main Display: Yes 04:39:17 INFO - Mirror: Off 04:39:17 INFO - Online: Yes 04:39:17 INFO - Rotation: Supported 04:39:17 INFO - Return code: 0 04:39:17 INFO - Running post-action listener: _resource_record_post_action 04:39:17 INFO - [mozharness: 2016-10-18 11:39:17.465200Z] Finished run-tests step (success) 04:39:17 INFO - Running post-run listener: _resource_record_post_run 04:39:17 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38528000; Write bytes: 706986496; Read time: 380; Write time: 1904 04:39:17 INFO - TinderboxPrint: CPU usage
53.9% 04:39:17 INFO - TinderboxPrint: I/O read bytes / time
38,528,000 / 380 04:39:17 INFO - TinderboxPrint: I/O write bytes / time
706,986,496 / 1,904 04:39:17 INFO - TinderboxPrint: CPU idle
2,236.7 (46.1%) 04:39:17 INFO - TinderboxPrint: CPU system
975.4 (20.1%) 04:39:17 INFO - TinderboxPrint: CPU user
1,641.6 (33.8%) 04:39:17 INFO - TinderboxPrint: Swap in / out
444,461,056 / 0 04:39:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 398664192; Write bytes: 387024896; Read time: 28918; Write time: 692 04:39:17 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31370240; Write bytes: 297609728; Read time: 295; Write time: 1168 04:39:18 INFO - Running post-run listener: _upload_blobber_files 04:39:18 INFO - Blob upload gear active. 04:39:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:18 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 04:39:18 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'] 04:39:18 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 04:39:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:19 INFO - (blobuploader) - INFO - Done attempting. 04:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:20 INFO - (blobuploader) - INFO - Done attempting. 04:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:22 INFO - (blobuploader) - INFO - Done attempting. 04:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:22 INFO - Return code: 0 04:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708f28e1c49385f10e6af6abc0d2617a6d1f6a5dbbbb8ae3c5546006e952b8e80b91714dabde84801f971d6d6bacdc652e9ff78318acd50d101fbfee27feb2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b81be226d1ea6cea1d616250fd720ec4452de347a1e88ee825d3675b3c5b54b5559a7d6f9c695681508402a77847635096163df53c734b2431be42ad38bf4846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02434686437b8621d9002e6383f8cda2bde6e0980457252a9e7795142cecdc1adadbcbcafbb5bc36271b5c651973dbf6c8d36c6ff2c8efd890e1b35216963bfb"} 04:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:22 INFO - Contents: 04:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708f28e1c49385f10e6af6abc0d2617a6d1f6a5dbbbb8ae3c5546006e952b8e80b91714dabde84801f971d6d6bacdc652e9ff78318acd50d101fbfee27feb2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b81be226d1ea6cea1d616250fd720ec4452de347a1e88ee825d3675b3c5b54b5559a7d6f9c695681508402a77847635096163df53c734b2431be42ad38bf4846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02434686437b8621d9002e6383f8cda2bde6e0980457252a9e7795142cecdc1adadbcbcafbb5bc36271b5c651973dbf6c8d36c6ff2c8efd890e1b35216963bfb"} 04:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:22 INFO - Copying logs to upload dir... 04:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.922602 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-18 04:39:23.043519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:39:23.047535) ========= 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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/d708f28e1c49385f10e6af6abc0d2617a6d1f6a5dbbbb8ae3c5546006e952b8e80b91714dabde84801f971d6d6bacdc652e9ff78318acd50d101fbfee27feb2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b81be226d1ea6cea1d616250fd720ec4452de347a1e88ee825d3675b3c5b54b5559a7d6f9c695681508402a77847635096163df53c734b2431be42ad38bf4846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02434686437b8621d9002e6383f8cda2bde6e0980457252a9e7795142cecdc1adadbcbcafbb5bc36271b5c651973dbf6c8d36c6ff2c8efd890e1b35216963bfb"} build_url:https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010807 build_url: 'https://queue.taskcluster.net/v1/task/J9Z0R6nOQh-UusfZmEAnMg/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/d708f28e1c49385f10e6af6abc0d2617a6d1f6a5dbbbb8ae3c5546006e952b8e80b91714dabde84801f971d6d6bacdc652e9ff78318acd50d101fbfee27feb2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b81be226d1ea6cea1d616250fd720ec4452de347a1e88ee825d3675b3c5b54b5559a7d6f9c695681508402a77847635096163df53c734b2431be42ad38bf4846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02434686437b8621d9002e6383f8cda2bde6e0980457252a9e7795142cecdc1adadbcbcafbb5bc36271b5c651973dbf6c8d36c6ff2c8efd890e1b35216963bfb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:39:23.083299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:39:23.083627) ========= 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.QzqUGRRLZV/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.5oEEdeb9Zr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005070 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:39:23.134679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:39:23.135261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:39:23.135808) ========= ========= Total master_lag: 2.59 =========