builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0346 starttime: 1476488107.57 results: success (0) buildid: 20161014144235 builduid: cb463a0add744897a27dd56f40f95750 revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.574560) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.575004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.575290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.599338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.599626) ========= 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.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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-14 16:35:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.8M=0s 2016-10-14 16:35:07 (24.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.772353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.772866) ========= 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.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.024790 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.821935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:07.822279) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de5d73a0568d1c3d50da32169026cc68ee09b1ae --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 de5d73a0568d1c3d50da32169026cc68ee09b1ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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-14 16:35:07,875 truncating revision to first 12 chars 2016-10-14 16:35:07,875 Setting DEBUG logging. 2016-10-14 16:35:07,875 attempt 1/10 2016-10-14 16:35:07,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de5d73a0568d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 16:35:08,575 unpacking tar archive at: mozilla-central-de5d73a0568d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:08.802764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:08.803096) ========= script_repo_revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:08.803503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:08.803789) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:08.821620) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-14 16:35:08.821897) ========= /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.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:08 INFO - MultiFileLogger online at 20161014 16:35:08 in /builds/slave/test 16:35:08 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 16:35:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:08 INFO - {'append_to_log': False, 16:35:08 INFO - 'base_work_dir': '/builds/slave/test', 16:35:08 INFO - 'blob_upload_branch': 'Firefox', 16:35:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:08 INFO - 'branch': 'Firefox', 16:35:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:08 INFO - 'config_files': ('talos/mac_config.py',), 16:35:08 INFO - 'default_actions': ('clobber', 16:35:08 INFO - 'read-buildbot-config', 16:35:08 INFO - 'download-and-extract', 16:35:08 INFO - 'populate-webroot', 16:35:08 INFO - 'create-virtualenv', 16:35:08 INFO - 'install', 16:35:08 INFO - 'run-tests'), 16:35:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:08 INFO - 'download_minidump_stackwalk': True, 16:35:08 INFO - 'download_symbols': 'ondemand', 16:35:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:08 INFO - 'installer_path': 'installer.exe', 16:35:08 INFO - 'log_level': 'info', 16:35:08 INFO - 'log_name': 'talos', 16:35:08 INFO - 'log_to_console': True, 16:35:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:35:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:35:08 INFO - 'opt_config_files': (), 16:35:08 INFO - 'pip_index': False, 16:35:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:08 INFO - 'cmd': ('bash', 16:35:08 INFO - '-c', 16:35:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:08 INFO - 'enabled': True, 16:35:08 INFO - 'halt_on_failure': False, 16:35:08 INFO - 'name': 'check_screen_resolution'},), 16:35:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:08 INFO - 'cmd': ('bash', 16:35:08 INFO - '-c', 16:35:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:08 INFO - 'enabled': True, 16:35:08 INFO - 'halt_on_failure': False, 16:35:08 INFO - 'name': 'check_screen_resolution'},), 16:35:08 INFO - 'run_cmd_checks_enabled': True, 16:35:08 INFO - 'sps_profile': False, 16:35:08 INFO - 'sps_profile_interval': 0, 16:35:08 INFO - 'suite': 'dromaeojs', 16:35:08 INFO - 'system_bits': '32', 16:35:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:08 INFO - 'title': 't-yosemite-r7-0346', 16:35:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:08 INFO - 'use_talos_json': True, 16:35:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:08 INFO - 'work_dir': 'build'} 16:35:08 INFO - [mozharness: 2016-10-14 23:35:08.994556Z] Running clobber step. 16:35:08 INFO - Running pre-action listener: _resource_record_pre_action 16:35:08 INFO - Running main action method: clobber 16:35:08 INFO - rmtree: /builds/slave/test/build 16:35:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:11 INFO - Running post-action listener: _resource_record_post_action 16:35:11 INFO - [mozharness: 2016-10-14 23:35:11.153468Z] Finished clobber step (success) 16:35:11 INFO - [mozharness: 2016-10-14 23:35:11.153622Z] Running read-buildbot-config step. 16:35:11 INFO - Running pre-action listener: _resource_record_pre_action 16:35:11 INFO - Running main action method: read_buildbot_config 16:35:11 INFO - Using buildbot properties: 16:35:11 INFO - { 16:35:11 INFO - "project": "", 16:35:11 INFO - "product": "firefox", 16:35:11 INFO - "script_repo_revision": "production", 16:35:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:35:11 INFO - "repository": "", 16:35:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:35:11 INFO - "buildid": "20161014144235", 16:35:11 INFO - "pgo_build": "False", 16:35:11 INFO - "basedir": "/builds/slave/test", 16:35:11 INFO - "buildnumber": 7, 16:35:11 INFO - "slavename": "t-yosemite-r7-0346", 16:35:11 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:35:11 INFO - "platform": "yosemite_r7", 16:35:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:35:11 INFO - "branch": "mozilla-central", 16:35:11 INFO - "repo_path": "mozilla-central", 16:35:11 INFO - "revision": "de5d73a0568d1c3d50da32169026cc68ee09b1ae", 16:35:11 INFO - "stage_platform": "macosx64", 16:35:11 INFO - "builduid": "cb463a0add744897a27dd56f40f95750", 16:35:11 INFO - "slavebuilddir": "test" 16:35:11 INFO - } 16:35:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:35:11 INFO - Running post-action listener: _resource_record_post_action 16:35:11 INFO - [mozharness: 2016-10-14 23:35:11.156671Z] Finished read-buildbot-config step (success) 16:35:11 INFO - [mozharness: 2016-10-14 23:35:11.156769Z] Running download-and-extract step. 16:35:11 INFO - Running pre-action listener: _resource_record_pre_action 16:35:11 INFO - Running main action method: download_and_extract 16:35:11 INFO - mkdir: /builds/slave/test/build/tests 16:35:11 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')]} 16:35:11 INFO - trying https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:12 INFO - Downloaded 1199 bytes. 16:35:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:35:12 INFO - Using the following test package requirements: 16:35:12 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:35:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:35:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:35:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'jsshell-mac.zip'], 16:35:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:35:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:35:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:35:12 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:35:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:35:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:12 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:35:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:35:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:35:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:35:13 INFO - Http code: 200 16:35:13 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 16:35:13 INFO - x-amz-cf-id: uOYOdNHV9K9rdFSy8hN1tBxsyr75_b1byiaE8k5ggi1BiMX7SyhI0w== 16:35:13 INFO - x-amz-version-id: v2oMC3FxxZq6PcVIwZlM26xfI6c2s0BH 16:35:13 INFO - Expected file size: 16516674 16:35:13 INFO - Obtained file size: 16516674 16:35:20 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 16:35:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:35:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:35:20 INFO - Http code: 200 16:35:20 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 16:35:20 INFO - x-amz-cf-id: KNXu05USJqx3_fKxtNcxWd1SzapQmmBO05so02z0_h8rBMMTgxvmBQ== 16:35:20 INFO - x-amz-version-id: v2oMC3FxxZq6PcVIwZlM26xfI6c2s0BH 16:35:20 INFO - Expected file size: 16516674 16:35:20 INFO - Obtained file size: 16516674 16:35:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:35:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:35:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:35:28 INFO - Http code: 200 16:35:28 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 16:35:28 INFO - x-amz-cf-id: G-6T1pBSwYp48dabLXE_-Qwqa_L58NZdapXOWXH-NJK3AhVLYAZChA== 16:35:28 INFO - x-amz-version-id: ckHd9cD_mWJFSrgsefn93k0tIlt3YJOh 16:35:29 INFO - Expected file size: 14409028 16:35:29 INFO - Obtained file size: 14409028 16:35:29 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')]} 16:35:29 INFO - trying https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:32 INFO - Downloaded 111972944 bytes. 16:35:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:32 INFO - mkdir: /builds/slave/test/properties 16:35:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:32 INFO - Contents: 16:35:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:33 INFO - Running post-action listener: _resource_record_post_action 16:35:33 INFO - Running post-action listener: set_extra_try_arguments 16:35:33 INFO - [mozharness: 2016-10-14 23:35:33.824913Z] Finished download-and-extract step (success) 16:35:33 INFO - [mozharness: 2016-10-14 23:35:33.825052Z] Running populate-webroot step. 16:35:33 INFO - Running pre-action listener: _resource_record_pre_action 16:35:33 INFO - Running main action method: populate_webroot 16:35:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:33 INFO - '--tppagecycles', 16:35:33 INFO - '7'], 16:35:33 INFO - 'tests': ['tsvgm']}}, 16:35:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:35:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:35:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['damp', 'tps']}, 16:35:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'tests': ['damp', 'tps']}, 16:35:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['dromaeo_dom']}, 16:35:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['basic_compositor_video']}, 16:35:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:35:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['a11yr', 16:35:33 INFO - 'ts_paint', 16:35:33 INFO - 'tpaint', 16:35:33 INFO - 'sessionrestore', 16:35:33 INFO - 'sessionrestore_no_auto_restore', 16:35:33 INFO - 'tabpaint']}, 16:35:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['tsvgx', 16:35:33 INFO - 'tsvgr_opacity', 16:35:33 INFO - 'tart', 16:35:33 INFO - 'tscrollx', 16:35:33 INFO - 'cart']}, 16:35:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:35:33 INFO - 'tsvgr_opacity', 16:35:33 INFO - 'tart', 16:35:33 INFO - 'tscrollx', 16:35:33 INFO - 'cart']}, 16:35:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'talos_options': ['--disable-e10s'], 16:35:33 INFO - 'tests': ['tp5o']}, 16:35:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'tests': ['tp5o']}, 16:35:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'talos_options': ['--disable-e10s', 16:35:33 INFO - '--xperf_path', 16:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:33 INFO - 'tests': ['tp5n']}, 16:35:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:33 INFO - 'talos_options': ['--xperf_path', 16:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:33 INFO - 'tests': ['tp5n']}}, 16:35:33 INFO - 'talos.zip': {'path': '', 16:35:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:33 INFO - Running post-action listener: _resource_record_post_action 16:35:33 INFO - [mozharness: 2016-10-14 23:35:33.844110Z] Finished populate-webroot step (success) 16:35:33 INFO - [mozharness: 2016-10-14 23:35:33.844227Z] Running create-virtualenv step. 16:35:33 INFO - Running pre-action listener: _resource_record_pre_action 16:35:33 INFO - Running main action method: create_virtualenv 16:35:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:33 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 16:35:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:33 INFO - Using real prefix '/tools/python27' 16:35:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:37 INFO - Installing pip.................done. 16:35:37 INFO - Return code: 0 16:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:35:37 INFO - Reading from file tmpfile_stdout 16:35:37 INFO - Output received: 16:35:37 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) 16:35:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:37 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')]} 16:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 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')]} 16:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:37 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 16:35:37 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 16:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:37 INFO - 'HOME': '/Users/cltbld', 16:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:37 INFO - 'LOGNAME': 'cltbld', 16:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:37 INFO - 'MOZ_NO_REMOTE': '1', 16:35:37 INFO - 'NO_EM_RESTART': '1', 16:35:37 INFO - 'PAGER': '/bin/cat', 16:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:37 INFO - 'PWD': '/builds/slave/test', 16:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:37 INFO - 'SHELL': '/bin/bash', 16:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:37 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:37 INFO - 'USER': 'cltbld', 16:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:37 INFO - 'XPC_FLAGS': '0x0', 16:35:37 INFO - 'XPC_SERVICE_NAME': '0', 16:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:38 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 16:35:38 INFO - Cleaning up... 16:35:38 INFO - Return code: 0 16:35:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:38 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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:38 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 16:35:38 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 16:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:38 INFO - 'HOME': '/Users/cltbld', 16:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:38 INFO - 'LOGNAME': 'cltbld', 16:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:38 INFO - 'MOZ_NO_REMOTE': '1', 16:35:38 INFO - 'NO_EM_RESTART': '1', 16:35:38 INFO - 'PAGER': '/bin/cat', 16:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:38 INFO - 'PWD': '/builds/slave/test', 16:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:38 INFO - 'SHELL': '/bin/bash', 16:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:38 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:38 INFO - 'USER': 'cltbld', 16:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:38 INFO - 'XPC_FLAGS': '0x0', 16:35:38 INFO - 'XPC_SERVICE_NAME': '0', 16:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:38 INFO - Downloading/unpacking psutil>=3.1.1 16:35:38 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 16:35:38 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 16:35:38 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 16:35:38 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 16:35:38 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 16:35:38 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 16:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:41 INFO - Installing collected packages: psutil 16:35:41 INFO - Running setup.py install for psutil 16:35:41 INFO - building 'psutil._psutil_osx' extension 16:35:41 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 16:35:42 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 16:35:42 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 16:35:42 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 16:35:42 INFO - building 'psutil._psutil_posix' extension 16:35:42 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 16:35:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:42 INFO - ^ 16:35:42 INFO - 1 warning generated. 16:35:42 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 16:35:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:42 INFO - Successfully installed psutil 16:35:42 INFO - Cleaning up... 16:35:42 INFO - Return code: 0 16:35:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:35: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 mozsystemmonitor==0.3 16:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:42 INFO - 'HOME': '/Users/cltbld', 16:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:42 INFO - 'LOGNAME': 'cltbld', 16:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:42 INFO - 'MOZ_NO_REMOTE': '1', 16:35:42 INFO - 'NO_EM_RESTART': '1', 16:35:42 INFO - 'PAGER': '/bin/cat', 16:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:42 INFO - 'PWD': '/builds/slave/test', 16:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:42 INFO - 'SHELL': '/bin/bash', 16:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:42 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:42 INFO - 'USER': 'cltbld', 16:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:42 INFO - 'XPC_FLAGS': '0x0', 16:35:42 INFO - 'XPC_SERVICE_NAME': '0', 16:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:35:45 INFO - Installing collected packages: mozsystemmonitor 16:35:45 INFO - Running setup.py install for mozsystemmonitor 16:35:46 INFO - Successfully installed mozsystemmonitor 16:35:46 INFO - Cleaning up... 16:35:46 INFO - Return code: 0 16:35:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', '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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:35: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 jsonschema==2.5.1 16:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:46 INFO - 'HOME': '/Users/cltbld', 16:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:46 INFO - 'LOGNAME': 'cltbld', 16:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:46 INFO - 'MOZ_NO_REMOTE': '1', 16:35:46 INFO - 'NO_EM_RESTART': '1', 16:35:46 INFO - 'PAGER': '/bin/cat', 16:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:46 INFO - 'PWD': '/builds/slave/test', 16:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:46 INFO - 'SHELL': '/bin/bash', 16:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:46 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:46 INFO - 'USER': 'cltbld', 16:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:46 INFO - 'XPC_FLAGS': '0x0', 16:35:46 INFO - 'XPC_SERVICE_NAME': '0', 16:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:46 INFO - Downloading/unpacking jsonschema==2.5.1 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:49 INFO - warning: no files found matching '*.txt' 16:35:49 INFO - no previously-included directories found matching 'build' 16:35:49 INFO - no previously-included directories found matching 'dist' 16:35:49 INFO - no previously-included directories found matching '.git*' 16:35:49 INFO - Installing collected packages: jsonschema, functools32 16:35:49 INFO - Running setup.py install for functools32 16:35:49 INFO - warning: no files found matching '*.txt' 16:35:49 INFO - no previously-included directories found matching 'build' 16:35:49 INFO - no previously-included directories found matching 'dist' 16:35:49 INFO - no previously-included directories found matching '.git*' 16:35:49 INFO - Successfully installed jsonschema functools32 16:35:49 INFO - Cleaning up... 16:35:49 INFO - Return code: 0 16:35:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:49 INFO - 'HOME': '/Users/cltbld', 16:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:49 INFO - 'LOGNAME': 'cltbld', 16:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:49 INFO - 'MOZ_NO_REMOTE': '1', 16:35:49 INFO - 'NO_EM_RESTART': '1', 16:35:49 INFO - 'PAGER': '/bin/cat', 16:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:49 INFO - 'PWD': '/builds/slave/test', 16:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:49 INFO - 'SHELL': '/bin/bash', 16:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:49 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:49 INFO - 'USER': 'cltbld', 16:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:49 INFO - 'XPC_FLAGS': '0x0', 16:35:49 INFO - 'XPC_SERVICE_NAME': '0', 16:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:35:49 INFO - Cleaning up... 16:35:49 INFO - Return code: 0 16:35:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:49 INFO - 'HOME': '/Users/cltbld', 16:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:49 INFO - 'LOGNAME': 'cltbld', 16:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:49 INFO - 'MOZ_NO_REMOTE': '1', 16:35:49 INFO - 'NO_EM_RESTART': '1', 16:35:49 INFO - 'PAGER': '/bin/cat', 16:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:49 INFO - 'PWD': '/builds/slave/test', 16:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:49 INFO - 'SHELL': '/bin/bash', 16:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:49 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:49 INFO - 'USER': 'cltbld', 16:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:49 INFO - 'XPC_FLAGS': '0x0', 16:35:49 INFO - 'XPC_SERVICE_NAME': '0', 16:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:53 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 16:35:53 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 16:35:53 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 16:35:53 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 16:35:53 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 16:35:53 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 16:35:53 INFO - Downloading docopt-0.6.1.tar.gz 16:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:53 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:53 INFO - Running setup.py install for blobuploader 16:35:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:54 INFO - Running setup.py install for requests 16:35:54 INFO - Running setup.py install for docopt 16:35:54 INFO - Successfully installed blobuploader requests docopt 16:35:54 INFO - Cleaning up... 16:35:54 INFO - Return code: 0 16:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:54 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')]} 16:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:54 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')]} 16:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:54 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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:54 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 16:35:54 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 16:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:54 INFO - 'HOME': '/Users/cltbld', 16:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:54 INFO - 'LOGNAME': 'cltbld', 16:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:54 INFO - 'MOZ_NO_REMOTE': '1', 16:35:54 INFO - 'NO_EM_RESTART': '1', 16:35:54 INFO - 'PAGER': '/bin/cat', 16:35:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:54 INFO - 'PWD': '/builds/slave/test', 16:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:54 INFO - 'SHELL': '/bin/bash', 16:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:54 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:54 INFO - 'USER': 'cltbld', 16:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:54 INFO - 'XPC_FLAGS': '0x0', 16:35:54 INFO - 'XPC_SERVICE_NAME': '0', 16:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Po61en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-hv4igU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-vfkAAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-zqMLQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Zcjh2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-n6DUl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-9jFUXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-AAuo4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-QUv2Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-dOzwKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-IjHwFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-UBzztu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-6ckU5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-aDym3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-YBTe6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-yC0aAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:56 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-WjRHv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:56 INFO - Running setup.py install for manifestparser 16:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Running setup.py install for mozcrash 16:35:57 INFO - Running setup.py install for mozdebug 16:35:57 INFO - Running setup.py install for mozdevice 16:35:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Running setup.py install for mozfile 16:35:57 INFO - Running setup.py install for mozhttpd 16:35:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Running setup.py install for mozinfo 16:35:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Running setup.py install for mozInstall 16:35:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Running setup.py install for mozleak 16:35:58 INFO - Running setup.py install for mozlog 16:35:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Running setup.py install for moznetwork 16:35:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Running setup.py install for mozprocess 16:35:58 INFO - Running setup.py install for mozprofile 16:35:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:58 INFO - Running setup.py install for mozrunner 16:35:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:59 INFO - Running setup.py install for mozscreenshot 16:35:59 INFO - Running setup.py install for moztest 16:35:59 INFO - Running setup.py install for mozversion 16:35:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:59 INFO - Cleaning up... 16:35:59 INFO - Return code: 0 16:35:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:59 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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:35:59 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 16:35:59 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 16:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:59 INFO - 'HOME': '/Users/cltbld', 16:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:59 INFO - 'LOGNAME': 'cltbld', 16:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:59 INFO - 'MOZ_NO_REMOTE': '1', 16:35:59 INFO - 'NO_EM_RESTART': '1', 16:35:59 INFO - 'PAGER': '/bin/cat', 16:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:59 INFO - 'PWD': '/builds/slave/test', 16:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:59 INFO - 'SHELL': '/bin/bash', 16:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:35:59 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:59 INFO - 'USER': 'cltbld', 16:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:59 INFO - 'XPC_FLAGS': '0x0', 16:35:59 INFO - 'XPC_SERVICE_NAME': '0', 16:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:59 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-EI073M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:59 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-asb8oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:59 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-c2Stxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-3aAyZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-TyOTAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-zIR64a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-gu4Mwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-C656id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-_KorrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-iqh7m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-mlDZxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:00 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Ro_HCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:00 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)) 16:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-l12jkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:01 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)) 16:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-uSYxog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:01 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)) 16:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-hPqSm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:01 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)) 16:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-kyQaZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:01 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)) 16:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-_HnAzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:01 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)) 16:36:01 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)) 16:36:01 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)) 16:36:01 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)) 16:36:01 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)) 16:36:01 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)) 16:36:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:03 INFO - Downloading blessings-1.6.tar.gz 16:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:04 INFO - Installing collected packages: blessings 16:36:04 INFO - Running setup.py install for blessings 16:36:04 INFO - Successfully installed blessings 16:36:04 INFO - Cleaning up... 16:36:04 INFO - Return code: 0 16:36:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:04 INFO - Reading from file tmpfile_stdout 16:36:04 INFO - Current package versions: 16:36:04 INFO - blessings == 1.6 16:36:04 INFO - blobuploader == 1.2.4 16:36:04 INFO - docopt == 0.6.1 16:36:04 INFO - functools32 == 3.2.3-2 16:36:04 INFO - jsonschema == 2.5.1 16:36:04 INFO - manifestparser == 1.1 16:36:04 INFO - mozInstall == 1.12 16:36:04 INFO - mozcrash == 0.17 16:36:04 INFO - mozdebug == 0.1 16:36:04 INFO - mozdevice == 0.48 16:36:04 INFO - mozfile == 1.2 16:36:04 INFO - mozhttpd == 0.7 16:36:04 INFO - mozinfo == 0.9 16:36:04 INFO - mozleak == 0.1 16:36:04 INFO - mozlog == 3.4 16:36:04 INFO - moznetwork == 0.27 16:36:04 INFO - mozprocess == 0.23 16:36:04 INFO - mozprofile == 0.28 16:36:04 INFO - mozrunner == 6.12 16:36:04 INFO - mozscreenshot == 0.1 16:36:04 INFO - mozsystemmonitor == 0.3 16:36:04 INFO - moztest == 0.7 16:36:04 INFO - mozversion == 1.4 16:36:04 INFO - psutil == 3.1.1 16:36:04 INFO - requests == 1.2.3 16:36:04 INFO - wsgiref == 0.1.2 16:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:04 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')]} 16:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 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')]} 16:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 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 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:36:05 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 16:36:05 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 16:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:05 INFO - 'HOME': '/Users/cltbld', 16:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:05 INFO - 'LOGNAME': 'cltbld', 16:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:05 INFO - 'MOZ_NO_REMOTE': '1', 16:36:05 INFO - 'NO_EM_RESTART': '1', 16:36:05 INFO - 'PAGER': '/bin/cat', 16:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:05 INFO - 'PWD': '/builds/slave/test', 16:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:05 INFO - 'SHELL': '/bin/bash', 16:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:36:05 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:05 INFO - 'USER': 'cltbld', 16:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:05 INFO - 'XPC_FLAGS': '0x0', 16:36:05 INFO - 'XPC_SERVICE_NAME': '0', 16:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 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)) 16:36:06 INFO - Cleaning up... 16:36:06 INFO - Return code: 0 16:36:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108601490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108577570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a8cc86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, '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.TgxaffTqvS/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.2VDsN7B2A7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 16:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:06 INFO - 'HOME': '/Users/cltbld', 16:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:06 INFO - 'LOGNAME': 'cltbld', 16:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:06 INFO - 'MOZ_NO_REMOTE': '1', 16:36:06 INFO - 'NO_EM_RESTART': '1', 16:36:06 INFO - 'PAGER': '/bin/cat', 16:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:06 INFO - 'PWD': '/builds/slave/test', 16:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:06 INFO - 'SHELL': '/bin/bash', 16:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:36:06 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:06 INFO - 'USER': 'cltbld', 16:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:06 INFO - 'XPC_FLAGS': '0x0', 16:36:06 INFO - 'XPC_SERVICE_NAME': '0', 16:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:36:06 INFO - Cleaning up... 16:36:06 INFO - Return code: 0 16:36:06 INFO - Running post-action listener: _resource_record_post_action 16:36:06 INFO - Running post-action listener: _start_resource_monitoring 16:36:06 INFO - Starting resource monitoring. 16:36:06 INFO - [mozharness: 2016-10-14 23:36:06.688895Z] Finished create-virtualenv step (success) 16:36:06 INFO - [mozharness: 2016-10-14 23:36:06.689881Z] Running install step. 16:36:06 INFO - Running pre-action listener: _resource_record_pre_action 16:36:06 INFO - Running main action method: install 16:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:06 INFO - Reading from file tmpfile_stdout 16:36:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:07 INFO - Reading from file tmpfile_stdout 16:36:07 INFO - Output received: 16:36:07 INFO - Usage: mozinstall [options] installer 16:36:07 INFO - Options: 16:36:07 INFO - -h, --help show this help message and exit 16:36:07 INFO - -d DEST, --destination=DEST 16:36:07 INFO - Directory to install application into. [default: 16:36:07 INFO - "/builds/slave/test"] 16:36:07 INFO - --app=APP Application being installed. [default: firefox] 16:36:07 INFO - mkdir: /builds/slave/test/build/application 16:36:07 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'] 16:36:07 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 16:36:41 INFO - Reading from file tmpfile_stdout 16:36:41 INFO - Output received: 16:36:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:36:41 INFO - Running post-action listener: _resource_record_post_action 16:36:41 INFO - [mozharness: 2016-10-14 23:36:41.572257Z] Finished install step (success) 16:36:41 INFO - [mozharness: 2016-10-14 23:36:41.572440Z] Running run-tests step. 16:36:41 INFO - Running pre-action listener: _resource_record_pre_action 16:36:41 INFO - Running main action method: run_tests 16:36:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:41 INFO - 2016-10-14 16:36:41.586 screenresolution[1640:7426] starting screenresolution argv=screenresolution get 16:36:41 INFO - 2016-10-14 16:36:41.589 screenresolution[1640:7426] Display 0: 1600x1200x32@60 16:36:41 INFO - 2016-10-14 16:36:41.595 screenresolution[1641:7428] starting screenresolution argv=screenresolution list 16:36:41 INFO - Available Modes on Display 0 16:36:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:41 INFO - Intel Iris: 16:36:41 INFO - Chipset Model: Intel Iris 16:36:41 INFO - Type: GPU 16:36:41 INFO - Bus: Built-In 16:36:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:41 INFO - Vendor: Intel (0x8086) 16:36:41 INFO - Device ID: 0x0a2e 16:36:41 INFO - Revision ID: 0x0009 16:36:41 INFO - Displays: 16:36:41 INFO - Display: 16:36:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:41 INFO - Display Serial Number: 1600x1200 60 16:36:41 INFO - Main Display: Yes 16:36:41 INFO - Mirror: Off 16:36:41 INFO - Online: Yes 16:36:41 INFO - Rotation: Supported 16:36:41 INFO - Return code: 0 16:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:41 INFO - Python 2.7.3 16:36:41 INFO - Return code: 0 16:36:41 INFO - grabbing minidump binary from tooltool 16:36:41 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')]} 16:36:41 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 0x108415d30>, '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 0x10823bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:41 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 16:36:41 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 16:36:41 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 16:36:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:41 INFO - Return code: 0 16:36:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:41 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 16:36:41 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --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 16:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TgxaffTqvS/Render', 16:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:41 INFO - 'HOME': '/Users/cltbld', 16:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:41 INFO - 'LOGNAME': 'cltbld', 16:36:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:41 INFO - 'MOZ_NO_REMOTE': '1', 16:36:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:41 INFO - 'NO_EM_RESTART': '1', 16:36:41 INFO - 'PAGER': '/bin/cat', 16:36:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:41 INFO - 'PWD': '/builds/slave/test', 16:36:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:41 INFO - 'SHELL': '/bin/bash', 16:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2VDsN7B2A7/Listeners', 16:36:41 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 16:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:41 INFO - 'USER': 'cltbld', 16:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:41 INFO - 'XPC_FLAGS': '0x0', 16:36:41 INFO - 'XPC_SERVICE_NAME': '0', 16:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:41 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 16:36:42 INFO - mozversion application_buildid: 20161014144235 16:36:42 INFO - mozversion application_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:36:42 INFO - mozversion application_display_name: Nightly 16:36:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:42 INFO - mozversion application_name: Firefox 16:36:42 INFO - mozversion application_remotingname: firefox 16:36:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:36:42 INFO - mozversion application_vendor: Mozilla 16:36:42 INFO - mozversion application_version: 52.0a1 16:36:42 INFO - mozversion platform_buildid: 20161014144235 16:36:42 INFO - mozversion platform_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:36:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:36:42 INFO - mozversion platform_version: 52.0a1 16:36:42 INFO - using testdate: 1476488202 16:36:42 INFO - actual date: 1476488202 16:36:42 INFO - starting webserver on 'localhost:49272' 16:36:42 INFO - SUITE-START | Running 2 tests 16:36:42 INFO - TEST-START | dromaeo_css 16:36:42 INFO - operating with platform_type : mac_ 16:36:42 INFO - Initialising browser for dromaeo_css test... 16:36:42 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpGT6Y7K/profile http://localhost:49272/getInfo.html) 16:36:44 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 16:36:44 INFO - PROCESS | 1651 | colorDepth:24 16:36:44 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 16:36:44 INFO - PROCESS | 1651 | __metrics 16:36:44 INFO - PROCESS | 1651 | 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" 16:36:44 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:45 INFO - TEST-INFO | 1651: exit 0 16:36:45 INFO - Browser initialized. 16:36:45 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:45 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpGT6Y7K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:57 INFO - PROCESS | 1653 | RSS: Main: 260243456 16:36:57 INFO - PROCESS | 1653 | 16:37:48 INFO - PROCESS | 1653 | 1476488268900 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] 16:40:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 16:40:04 INFO - PROCESS | 1653 | RSS: Main: 412471296 16:40:04 INFO - PROCESS | 1653 | 16:43:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 16:43:07 INFO - PROCESS | 1653 | RSS: Main: 405118976 16:43:07 INFO - PROCESS | 1653 | 16:46:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 16:46:10 INFO - PROCESS | 1653 | RSS: Main: 349798400 16:46:10 INFO - PROCESS | 1653 | 16:49:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 16:49:13 INFO - PROCESS | 1653 | RSS: Main: 369577984 16:49:13 INFO - PROCESS | 1653 | 16:52:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 16:52:17 INFO - PROCESS | 1653 | RSS: Main: 344211456 16:52:17 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 16:55:21 INFO - PROCESS | 1653 | RSS: Main: 393089024 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | __start_tp_report 16:55:21 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 16:55:21 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 16:55:21 INFO - PROCESS | 1653 | |i|pagename|runs| 16:55:21 INFO - PROCESS | 1653 | |0;dojo.html;3284.7043766061056;3292.390907682079;3292.423825830479;3332.583427071616;3333.9333213335717;5488.094464413377;5581;5643.633163844357;5666.433356664332;5672.092465205568;5505.366882808478;5601.579881508883;5644.04051311276;5663.9433605663935;5696.373398926125;5012.548870601645;5039.748012599373;5042.974785126069;5107.616928730342;5111;5126.359205099363;5236;5242.449542798008;5246.134387826004;5280.207968804691;4716.434027916637;4761.738104404257;5151.459096794839;5155.793768249266;5252.71110088945;5077.238414237857;5120.052790233782;5134.768935397916;5135.666181698215;5139.820106296299;5002.52476014778;5102.872428189288;5119.334486516729;5125.84622461323;5126.5642420394315;5562.749676264537;5572.3870374258795;5588.6646801191655;5636.520895723868;5636.520895723868;6050.152978583002;6072.483838873657;6081.939180608181;6086.300075491331;6093.390660933871;5243.816466423695;6067.423594758491;6102.328743838174;6111.694415279218;6138.324784273726;5616.859578510529;5666.405027472098;5683.005474042026;5711.000574899459;5742.655440673573;6201.875962480815;6240.063990401385;6253.7185826637915;6284.340144284875;6286.339934306923;5816.2148110005455;6035.034394496947;6047.0324748040985;6057;6066.090086487062;6080.391960803884;6081.300650425169;6110.969445152835;6115.179495343508;6119.013467208553;5104.795808167632;5210.713410762444;6024;6054.878902421927;6056.636601803906;5763.625364351304;6098.54260930432;6113.266408031065;6115.969420152871;6172.938270617326;4775.355327030876;4834.613230941586;4840.2255639097575;4847.660663753574;4881.633877459205;4320.4383430153875;4353.912921741611;4355.0854320593035;4375.584319489643;4403.84586539476;5649.180868774005;5659.660420374791;5661.745221464962;5662.6036177468;5672.376038635829;4919.286703428054;6037.275526936708;6115.327313995457;6118.929187392188;6216.098665693539;5602.467765562346;5636.689982050944;5666.036773748473;5680.261565996394;5681.062624666966;5331.253624492497;5337.6797392156595;5342.626016178908;5345.919811202835;5369.812056578001;6207.534434917309;6233.594816336924;6236.469900058546;6252.624842509464;6261.217347831521;6044.335123136363;6066.878662426639;6121.84695382619;6135.202423684892;6145.832291864532;6211.751529938932;6228.781992630236;6234.1583886174785;6246.094316324198;6247.562670613013;6028.788992385421;6076.787312444043;6079.635221886701;6101.115338275837;6114.357992410733;5833.766649333979;5925.200097986716;6160.44555989963;6168.19813424252;6229.4393504584805;5954.612950158225;5968.612040217546;5999.5800293979;6032.1856549365275;6078.088286757022;6023.45788879003;6026.608270462406;6030.185924900083;6035.004224303117;6046.788362407295;5685.431456854281;5822.94177058224;5846.239988801429;5876.294844618673;5893.557983151367;4886.389201349832;4972.477889821516;5811.418858114154;5913.852153696192;6058.878822423439;5808.07070868659;5809.099589563455;5809.622374545641;5818.679972601548;5858.619189752652 16:55:21 INFO - PROCESS | 1653 | |1;ext.html;483.25819866504924;509.2183498330063;511.2152845382339;521.2962500624158;525.855389767814;30368.848155759217;40559.98600034997;41210.79394603023;41220.793896030475;43386.566134338645;42496.15007699844;42819.35770963438;42967.3554896676;42996.78501607488;43057.569424305744;9413.67052153173;9562.378445401062;9574;9607.759806004837;9616.134547890688;9455.763605909873;9585.472798996052;9587.520623968809;9595.232381409505;9611.66359177429;9597.280203984694;9605.66380176694;9618.90381096187;9642.951785241064;9649.662261820838;9526.42841429513;9573.90426095744;9594.280428967786;9606.9519652402;9615.230781537495;9488.335816492849;9561.760955976086;9576.138147566753;9576.90423095767;9588.424694518351;40313.59686403128;40579.79710101431;40643;40667;40719.7964010181;3313.867445302185;3510.0347404463723;3525.3301872644115;3768.3593789055926;3957.98021009896;29737.81048758047;29772.404551909058;30402.391952161055;30511.932082377232;30573;3041.3461105862125;3099.5815564898676;3100;3101.829399383033;3149.1497295730255;438856;482990.9999999965;484460;485774;493497;60467.39532604618;60801.39198607957;60827.695861520406;60880.78238435207;60942;34593.654063459544;34893.82553087269;35102.47346289808;62328.376716233164;62433;16630.417935372203;16717.99692018483;16795.91602041982;16809.15954202285;16838.579035523966;12416.875831241572;12422.006239500819;12816.35918204086;12836.908862746584;12902.483900644056;19196.328128515433;19210.80789192118;19417.126229319714;19454.70817937732;19485.928273944784;7878.684852605831;7937.3650107991225;7941.444098913021;7950.562719050507;8042.597870106471;836.4437648963371;924.902885197058;979.5004547680592;985.4284514981293;1008.495752123938;29792;30447;30485.39029219403;30808.84355425687;31228;798.3214267872378;998.0967224661692;998.9900100999042;999.1756800639502;1133.5012594458412;12099.697507562205;15075;15129.773053404208;15517;15663.981841180286;558101;589129;589270;591606;593437;57462.850742984905;58145.8370832581;58242.7087864558;58288.70855645695;58357.708211458674;1192.761447710444;1250.3935591238242;1281.4297637551388;1389.6248013036422;1390.1728471559406;28910.42179156363;29182.854085729436;30388.24029399194;30633.795807870978;30966.84516577493;49583;50388.496115039845;50459.990800184525;50470.99999999853;50532.49467505278;435266;436513;436981;437535;437845;26540.469190615695;26597.33506662349;27002;27193.86403067972;27585.448291033666;47556;47607.76196118997;47782;47946.5205347942;48941.26588101253;39294.01764955899;39326.01684957899;39421.60578394294;40063.78214100056;40632.39051414172;38864.02839928911;39267.607323927536;40073.1985360297;40524.39213411742;40850.79574602108;38494.230115398095;38641.03397415087;38882;39398.60601393949;40659.186816264104;27698.86150569234;33459;34252.48621270633;35092.549493428574;35526.822365888;23508.294751157493;24405.633915490926;25709.614355785052;25931.351716207246;26312.605310919967 16:55:21 INFO - PROCESS | 1653 | |2;jquery.html;354.80663038643934;371.6840685417394;375.7219657453484;382.2450659946605;403.26001786721366;15402.229888505572;15423.915216956611;19676.704849427253;21382.35852924411;21611.243606473778;20686.68969965452;20768.48078798031;20787.792122078776;21362.57274854502;21515.031823567937;5598.300212473451;5973.342932277467;5975.402459754012;5989.3112292086535;5991.191189189469;5724.398938111501;5838.386969368219;5851.678157701324;5852.473277405033;5879.941200588003;5809.912851307213;5821.8835623287505;5837.241158649391;5860.033094539396;5873.618214816044;5588.524975377098;5742;5818.301803783531;5822.224221612407;5829.4753472187285;5075;5077.339945807058;5078.187490001619;5085.440601533828;5095.8980820383385;13380.264085475295;13559.932200339033;23295.71873546954;23443.4139146521;24481.143159989493;2085.2284654677715;2164.653655415126;2180.4439867833757;2186.6173419651495;2279.259240746764;10166.745831354201;10249.692509224735;10274.7431314217;10491.42297173655;14623.853761462356;1773.5388798912247;1807.2138619700472;1826.1143345477433;1833.1109411935201;1854.0451667391305;116891.41554292174;122189;122467.387663062;135480.96778548328;137844.31077844647;11339.773204535863;11461.426928653535;11523.539058437736;11578.536858525733;11888.64334069962;12981;13437.529686460926;13495.865041349658;13506.797398039038;14248.857511424752;8460.915390846136;8501.362397820189;8601.118625260608;8703;8718.607662655195;8549.871751923725;8564.785880353042;8591.957040214758;8756.649734010696;8795;3974.787689754595;4474.440694913136;4498.685092043525;4585.656075794329;4617.076584683077;1852.1199534723635;1887.1602137049156;1905.7236700678325;1907.990460047691;1915.6264528417103;826.2935190412231;875.1423604867266;947.9810403791886;986.2110311750571;1003.0821798054699;20406.183752650024;20937.581248374947;21092.261770838253;21146.193685136823;21175;923.4782347973373;935.6023689931752;941.4962994797751;947.554649314821;951.2009911674227;10881.075108615856;11337.943310283395;11392.601258955896;11415.029722473517;11443.313401195956;570029;575297;575843;588336;590486;130176.3491182538;132027;132149;133568;136295.6370436283;952.1953948913157;959.3428501476511;981.9214462842956;982.543117450389;984.5618699678574;18933.33733319327;19203.807961920204;19204.903975480032;19211.231550738372;19215.32746353871;54698;56566;56763.43236567581;56955.715221425286;57335.42664573301;71316.28683713304;74416.8607964485;75069.6246518764;75277.62361188159;83173;7826.569538675428;7844.803879903048;8001.199880011952;8083.110857805755;8238.176182381714;11399;12655.177413468095;12714.427850746553;13053.151545149534;13216.471341146247;10910.509027093958;11340.036096931854;11400.149962509373;11548.018418434527;11565.363904985306;10647.467626618793;10855.945720271347;10931.070858977077;11042.061424778984;11450.885491144982;11377.715557110807;11598.130140239347;11645.76708465843;11851.881481185077;11867.58463453775;6880.552764070319;7509.399248060033;7829.49108307981;7940.444168908121;8251.133630968901;10766.515506802056;11267.549298028314;11478.598249061242;11581.305121692725;11738.063219568676 16:55:21 INFO - PROCESS | 1653 | |3;mootools.html;1395.379056319938;1458.3874772595511;1584.3820909845163;1823.6808558502266;1981.2669312354421;7997.640106195221;8496.49021058737;8668.696595619154;9021.95489022554;9044.8643270351;8913.598888050037;8983.281337493001;8990.775230619238;8991;8992.640294388217;2374.845635033726;2400.495895861862;2404.7234568024637;2409.6265078912797;2410.0359856057544;2342;2386.78518933296;2388.1163969331283;2389.8685572293516;2391.414103544634;2366.3965688749345;2388.152205966883;2388.7133543974746;2389.450426401929;2390.95218095638;2336.3224664847176;2357.446000189954;2363.102021231921;2367.30164601443;2373.4896997145697;2340.8595484270827;2360.5632957902844;2361.8700971446565;2365.66880636711;2366.976330236693;7408.962955185243;8977.865332020025;8981;9002.27981761464;9019.684311049083;5385.623006389555;5527.949689558971;5539.556835453154;5566.916496252559;5573.136163894603;3686.189038411545;3711.2391959648207;3735.1969326594913;3787.507624008861;3805.2009078093633;1018.1396719771781;1069.8605984626347;1070.946452677363;1076.7415820203173;1079.9892001079968;11778.293302401798;11813.054955603531;11903.940480297542;11912.987396071345;11930.88069119315;4277.251480990814;4441.111777644484;4456.153330867125;4527.705699129546;4691.39011928454;8117.553534555656;9244.121808428188;9273.489958052238;9279;9301.209397201179;5049.495050494921;5314.256004159421;5345.973270133624;5357.919631205535;5370.355557333145;4215.683823713233;4487.6185524230805;4640.234361330343;4662.160811054043;4716.882077948078;3333.3166700826273;3757.1734218471893;3775.6413140751583;3866.478025466526;3871.612838716162;1008.5511947183433;1159.7100724818795;1160.0545555372344;1165.5650250795804;1181.285322379965;826.5412695953803;861.5864385095064;907.5008745190119;917.3991035871514;946.703016866883;4908.263760435963;5056.9633225188745;5937;5958.255218097738;6102.969485152635;427.37603099475115;429.3516789647654;438.45412461485654;446.4040505924627;446.48208078628636;3866.497355343787;3919.647231749156;4020.3567429211184;4040.131371755028;4061.5329237138108;10400.895991040145;10633.989770971746;10823.891761082446;10855.565777368975;10993;10966.780664386668;10983.340999540053;10985.725356866142;11024.842391548933;11049.33703977764;8079.878801817978;8335.458195217292;8426;8453.577321133918;8455.74632761018;5754.68349240779;5802.361740208489;5864.67744274069;5895.882082358415;5983.132445795248;10081;10147.64483243083;10195.592176313161;10202.846957295498;10218.846717299395;8237.856633555073;10003.2997690161;10308.226882983656;10358.171346292429;10459.267851250339;6543.770968016097;6605.9009114864275;6674.566153200027;7175.928240717526;7198.172210195895;7909.564973926489;8332.750017499484;8511.36164787631;8580.91419085826;8611.31109511225;7448.73929412468;7543.8491230173995;7544.924550754642;7598.164201937893;7722.3049925506975;6525.608463492205;6647.803395388876;7230.13238411373;7461.291177338144;7508.2867127622785;6915.446764258747;6963.9651801740665;7038.718451261892;7059.82350441243;7086.822829429306;4951.8266860659705;4975.875603109951;4982.302477653204;4987.925181122214;5156.948430515797;4900;4906.8773280668265;4958.380202474691;5038;5455.863603409946 16:55:21 INFO - PROCESS | 1653 | |4;prototype.html;289.1700818650472;299.4086678809352;306.7545963229417;309.3997644569535;311.8144703901178;4323.675724320677;4688.742119183444;5210.805301732109;5239.187925871486;5257.737113144347;5079.822206222783;5160.664556803815;5213.246462546969;5217.165253559422;5243.535538297004;3978.3435733104;4027.6369231691574;4049.2711311963835;4069.511658600972;4071.6335529802313;3111.0200286909662;3389.0341252742974;3992.7803970781597;4036.8183431745642;4097.578521934189;3535.0455377048183;3599.028262369172;3815.866444674437;3889.4554762333155;3981.104251543394;3621.8732344367954;3984.980075099635;4019.31671615826;4019.41718450823;4075.2257071156387;2936.6182396288345;3080.152957936585;3231.6588615724445;3475.8957231283102;3488.1628409181612;4898.583620392271;5101.158308879068;5129.25625784263;5221.399539052982;5241.42344342122;4181.671969511572;4209.6000879916355;4443.400140980991;4540.228161212602;4569.611583015448;5281.890802931389;5486.725663716798;5600.143926597424;5622;5624;3483.0073429072845;3714.0900479382453;3828.9808550957346;3842.846286148551;3856.730028897978;5201.479852014806;5430.56555475561;5480.479354461319;5601.691906945116;5812.982728022579;3640.8543658253375;3665.9816700916326;3762.3415902217002;3773.2453509298252;3789.2610940866266;3603.3694103532303;3857.7106716996336;3883.9513331400362;3889.416587511896;3894.201688653819;3845.115623406632;4158.708890377705;4395.362672412482;4466.092169351818;4485.609461067014;4532.9093418132115;4726.929096063562;4959.454460009396;5435.673859568438;5511.476409741068;1072.8229842076125;1316.9539066132638;1319.7954317080869;1324.821149144853;1325.8541560428346;672.2202245395318;791.5290402210791;806.2824086562846;810.6473683947502;818.9108485713986;3623;4075.918481630351;4133.751974881517;4136.338185890243;4436.889077773017;4139.461869956886;4612.838550650711;4656.976715116402;4658.604018658452;4684.648651351163;4070.7150499465347;4353.891152721208;4361.6510679145595;4403.807239751155;4406.620424970544;2452.8650924198982;2684.489946910081;2930.560415937626;2932.882684692631;2960.304328482805;5368.1679339702405;5613.915791263134;5774.88450230993;5790.276215473066;5816.272965879265;4949.381327334083;5554.638948468337;5754.769809207585;5758.222639943638;5779.595428320062;5770;5799.9130013049835;5814.9709251454315;5905.911411328833;5916.319623243382;5087.379999300438;5502.669839809624;5595.524380427546;5619.606627536034;5628.577856660685;4461.553844615512;5370.248165256789;5581.748821303132;5600.691961942132;5648.328586418861;5309.867253318544;5824.796132135524;5846;5883.529317654663;5921.881562368642;3701.611330810334;3701.8889433317045;3710.591834898105;3762.8682996095004;3773.358529050123;4615.5845973862515;4764.595009424238;5297.655652382583;5548.945700316927;5578.219049333178;4394.472663280427;4587.908241835078;5378.623496355218;5447.291852059207;5458;5399.244105825109;5440.292761940922;5452.400235974119;5484.424135465719;5489.39616642177;4394.340848872567;4493.955060449353;4979.103761322996;5390.973045134906;5402;4400.73595584266;4419.49175844782;5247.181051516079;5263.736703191283;5308;4879.56083952446;5222.101733537923;5282.3132992712235;5312;5353.705546194997 16:55:21 INFO - PROCESS | 1653 | |5;yui.html;693.092049415266;740.00099865182;750.4634186556611;782.9686812527499;789.5144486141018;15149.772753408693;15442.382304707826;15487.84512154878;15498.457553985612;15953.92023039886;13951.372188251527;14109.223992680398;14209.147451152938;14222.431102755878;14258.857411425883;698.2633321845451;718.6370882704227;721.7906807025956;754.1892465599475;875.9386842920982;885.5439448683933;896.6189369517929;908.7728067983004;911.8313112074254;911.9968035161336;959.4387283439162;960.2941837749248;962.1629182611138;963.1187463470916;968.5496244246424;731.6195578299255;955.861400096989;956.8947415784259;956.9138777509988;957.004715096299;554.512029414117;559.6949662433983;559.9496045355896;560.1541672075155;560.456357333386;14223.786643200361;14497.42010319586;14624.561263162122;14681.119132852064;14990.400383984628;13730.588082357544;13887.623085610141;13955.85993151543;14167.750131504516;14250.358733857001;10931.945340273327;11189.608363707313;11222.158338124673;11292.266002709797;11687.240329378563;3311.503274508819;3330.167458135466;3339.833008349573;3412.488126781003;3476.28736109097;114777.98024836053;117256;119124;119697.40151299188;120248;10191.94904025475;10379.429131397847;10420.218483613608;10711.410872402093;10854.185936054828;22637.547249055257;22771.772282277296;22777.202797901995;22792.974316155814;22836.543269134523;6809.693563789641;7133.536320139175;7373.81565460857;7396.482246242819;7490.363319117936;4132.504099508078;4219.539514623522;4224.471941007374;4251.149770046003;4284.935725964113;3524.947125793115;3634.6547078027547;3691.390920498088;3700.907477313035;3707.5736290326417;644.5520363347429;647.5370110371107;649.0556240669814;656.2223764838682;665.2283351312454;593.7684303121786;615.673692942741;623.8596315828993;638.1321402892063;638.9840253993688;8732.432391894507;9094.1360570747;9249.583768730423;9253.814923701488;9338;628.7924984755019;662.1259936883267;662.2814246542555;663.8705452436825;668.2348710726288;4259.148170365877;4532.206863798822;4547.567981041796;4549.112922979987;4674.836380726658;94784;96046;96753.5486967696;147384;158902;99480.502597488;99673.50163249283;101720.49139754254;102014.34892383101;106404.46797766116;91815.54092229629;91870;94858;97135.05729885363;112112.43943780391;9105.453672779655;9634.373765705206;9671.106684924685;9694.843496106501;9760.85358719634;61030.69484652548;62820.589705147424;63157.68421157865;63842.7231455359;65540.3614909612;66761.31676956416;88772;92740;98437;99266;12711.555095571981;12874.549390771279;12949.805752913526;13166.473341066634;13211.471541138631;14762;15075.246237687852;15308.081515108684;15334.309956051782;15595.298211580279;13387.50453220226;13505.32473376347;13658.521951731642;13796.241206733726;14160.433582656578;13476.555669356327;13623.86376136226;13628.727425451634;13889.722205556034;14017.719645606827;10785.784284314113;13010.414531345923;13413.396397161956;13440.395182216627;13671.787130024237;10734.248602597743;10920.890791091988;11186.552537898393;11323.943380283046;11735.119866009913;11016.724581885517;11065.342540305699;11132.944335278271;11168.720781980515;11348 16:55:21 INFO - PROCESS | 1653 | __end_tp_report 16:55:21 INFO - PROCESS | 1653 | __start_cc_report 16:55:21 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1913 16:55:21 INFO - PROCESS | 1653 | __end_cc_report 16:55:21 INFO - PROCESS | 1653 | __startTimestamp1476489321556__endTimestamp 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | ------- Summary: start ------- 16:55:21 INFO - PROCESS | 1653 | Number of tests: 6 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5609.66 Median:5763.63 stddev:631.44 (11.0%) stddev-sans-first:606.46 16:55:21 INFO - PROCESS | 1653 | Values: 3284.7 3292.4 3292.4 3332.6 3333.9 5488.1 5581.0 5643.6 5666.4 5672.1 5505.4 5601.6 5644.0 5663.9 5696.4 5012.5 5039.7 5043.0 5107.6 5111.0 5126.4 5236.0 5242.4 5246.1 5280.2 4716.4 4761.7 5151.5 5155.8 5252.7 5077.2 5120.1 5134.8 5135.7 5139.8 5002.5 5102.9 5119.3 5125.8 5126.6 5562.7 5572.4 5588.7 5636.5 5636.5 6050.2 6072.5 6081.9 6086.3 6093.4 5243.8 6067.4 6102.3 6111.7 6138.3 5616.9 5666.4 5683.0 5711.0 5742.7 6201.9 6240.1 6253.7 6284.3 6286.3 5816.2 6035.0 6047.0 6057.0 6066.1 6080.4 6081.3 6111.0 6115.2 6119.0 5104.8 5210.7 6024.0 6054.9 6056.6 5763.6 6098.5 6113.3 6116.0 6172.9 4775.4 4834.6 4840.2 4847.7 4881.6 4320.4 4353.9 4355.1 4375.6 4403.8 5649.2 5659.7 5661.7 5662.6 5672.4 4919.3 6037.3 6115.3 6118.9 6216.1 5602.5 5636.7 5666.0 5680.3 5681.1 5331.3 5337.7 5342.6 5345.9 5369.8 6207.5 6233.6 6236.5 6252.6 6261.2 6044.3 6066.9 6121.8 6135.2 6145.8 6211.8 6228.8 6234.2 6246.1 6247.6 6028.8 6076.8 6079.6 6101.1 6114.4 5833.8 5925.2 6160.4 6168.2 6229.4 5954.6 5968.6 5999.6 6032.2 6078.1 6023.5 6026.6 6030.2 6035.0 6046.8 5685.4 5822.9 5846.2 5876.3 5893.6 4886.4 4972.5 5811.4 5913.9 6058.9 5808.1 5809.1 5809.6 5818.7 5858.6 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:64134.78 Median:40785.30 stddev:134029.46 (328.6%) stddev-sans-first:134320.24 16:55:21 INFO - PROCESS | 1653 | Values: 483.3 509.2 511.2 521.3 525.9 30368.8 40560.0 41210.8 41220.8 43386.6 42496.2 42819.4 42967.4 42996.8 43057.6 9413.7 9562.4 9574.0 9607.8 9616.1 9455.8 9585.5 9587.5 9595.2 9611.7 9597.3 9605.7 9618.9 9643.0 9649.7 9526.4 9573.9 9594.3 9607.0 9615.2 9488.3 9561.8 9576.1 9576.9 9588.4 40313.6 40579.8 40643.0 40667.0 40719.8 3313.9 3510.0 3525.3 3768.4 3958.0 29737.8 29772.4 30402.4 30511.9 30573.0 3041.3 3099.6 3100.0 3101.8 3149.1 438856.0 482991.0 484460.0 485774.0 493497.0 60467.4 60801.4 60827.7 60880.8 60942.0 34593.7 34893.8 35102.5 62328.4 62433.0 16630.4 16718.0 16795.9 16809.2 16838.6 12416.9 12422.0 12816.4 12836.9 12902.5 19196.3 19210.8 19417.1 19454.7 19485.9 7878.7 7937.4 7941.4 7950.6 8042.6 836.4 924.9 979.5 985.4 1008.5 29792.0 30447.0 30485.4 30808.8 31228.0 798.3 998.1 999.0 999.2 1133.5 12099.7 15075.0 15129.8 15517.0 15664.0 558101.0 589129.0 589270.0 591606.0 593437.0 57462.9 58145.8 58242.7 58288.7 58357.7 1192.8 1250.4 1281.4 1389.6 1390.2 28910.4 29182.9 30388.2 30633.8 30966.8 49583.0 50388.5 50460.0 50471.0 50532.5 435266.0 436513.0 436981.0 437535.0 437845.0 26540.5 26597.3 27002.0 27193.9 27585.4 47556.0 47607.8 47782.0 47946.5 48941.3 39294.0 39326.0 39421.6 40063.8 40632.4 38864.0 39267.6 40073.2 40524.4 40850.8 38494.2 38641.0 38882.0 39398.6 40659.2 27698.9 33459.0 34252.5 35092.5 35526.8 23508.3 24405.6 25709.6 25931.4 26312.6 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34777.94 Median:2183.53 stddev:97374.67 (4459.5%) stddev-sans-first:97613.53 16:55:21 INFO - PROCESS | 1653 | Values: 354.8 371.7 375.7 382.2 403.3 15402.2 15423.9 19676.7 21382.4 21611.2 20686.7 20768.5 20787.8 21362.6 21515.0 5598.3 5973.3 5975.4 5989.3 5991.2 5724.4 5838.4 5851.7 5852.5 5879.9 5809.9 5821.9 5837.2 5860.0 5873.6 5588.5 5742.0 5818.3 5822.2 5829.5 5075.0 5077.3 5078.2 5085.4 5095.9 13380.3 13559.9 23295.7 23443.4 24481.1 2085.2 2164.7 2180.4 2186.6 2279.3 10166.7 10249.7 10274.7 10491.4 14623.9 1773.5 1807.2 1826.1 1833.1 1854.0 116891.4 122189.0 122467.4 135481.0 137844.3 11339.8 11461.4 11523.5 11578.5 11888.6 12981.0 13437.5 13495.9 13506.8 14248.9 8460.9 8501.4 8601.1 8703.0 8718.6 8549.9 8564.8 8592.0 8756.6 8795.0 3974.8 4474.4 4498.7 4585.7 4617.1 1852.1 1887.2 1905.7 1908.0 1915.6 826.3 875.1 948.0 986.2 1003.1 20406.2 20937.6 21092.3 21146.2 21175.0 923.5 935.6 941.5 947.6 951.2 10881.1 11337.9 11392.6 11415.0 11443.3 570029.0 575297.0 575843.0 588336.0 590486.0 130176.3 132027.0 132149.0 133568.0 136295.6 952.2 959.3 981.9 982.5 984.6 18933.3 19203.8 19204.9 19211.2 19215.3 54698.0 56566.0 56763.4 56955.7 57335.4 71316.3 74416.9 75069.6 75277.6 83173.0 7826.6 7844.8 8001.2 8083.1 8238.2 11399.0 12655.2 12714.4 13053.2 13216.5 10910.5 11340.0 11400.1 11548.0 11565.4 10647.5 10855.9 10931.1 11042.1 11450.9 11377.7 11598.1 11645.8 11851.9 11867.6 6880.6 7509.4 7829.5 7940.4 8251.1 10766.5 11267.5 11478.6 11581.3 11738.1 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5669.04 Median:4651.20 stddev:3227.08 (69.4%) stddev-sans-first:3220.15 16:55:21 INFO - PROCESS | 1653 | Values: 1395.4 1458.4 1584.4 1823.7 1981.3 7997.6 8496.5 8668.7 9022.0 9044.9 8913.6 8983.3 8990.8 8991.0 8992.6 2374.8 2400.5 2404.7 2409.6 2410.0 2342.0 2386.8 2388.1 2389.9 2391.4 2366.4 2388.2 2388.7 2389.5 2391.0 2336.3 2357.4 2363.1 2367.3 2373.5 2340.9 2360.6 2361.9 2365.7 2367.0 7409.0 8977.9 8981.0 9002.3 9019.7 5385.6 5527.9 5539.6 5566.9 5573.1 3686.2 3711.2 3735.2 3787.5 3805.2 1018.1 1069.9 1070.9 1076.7 1080.0 11778.3 11813.1 11903.9 11913.0 11930.9 4277.3 4441.1 4456.2 4527.7 4691.4 8117.6 9244.1 9273.5 9279.0 9301.2 5049.5 5314.3 5346.0 5357.9 5370.4 4215.7 4487.6 4640.2 4662.2 4716.9 3333.3 3757.2 3775.6 3866.5 3871.6 1008.6 1159.7 1160.1 1165.6 1181.3 826.5 861.6 907.5 917.4 946.7 4908.3 5057.0 5937.0 5958.3 6103.0 427.4 429.4 438.5 446.4 446.5 3866.5 3919.6 4020.4 4040.1 4061.5 10400.9 10634.0 10823.9 10855.6 10993.0 10966.8 10983.3 10985.7 11024.8 11049.3 8079.9 8335.5 8426.0 8453.6 8455.7 5754.7 5802.4 5864.7 5895.9 5983.1 10081.0 10147.6 10195.6 10202.8 10218.8 8237.9 10003.3 10308.2 10358.2 10459.3 6543.8 6605.9 6674.6 7175.9 7198.2 7909.6 8332.8 8511.4 8580.9 8611.3 7448.7 7543.8 7544.9 7598.2 7722.3 6525.6 6647.8 7230.1 7461.3 7508.3 6915.4 6964.0 7038.7 7059.8 7086.8 4951.8 4975.9 4982.3 4987.9 5156.9 4900.0 4906.9 4958.4 5038.0 5455.9 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4338.74 Median:4614.21 stddev:1349.16 (29.2%) stddev-sans-first:1318.26 16:55:21 INFO - PROCESS | 1653 | Values: 289.2 299.4 306.8 309.4 311.8 4323.7 4688.7 5210.8 5239.2 5257.7 5079.8 5160.7 5213.2 5217.2 5243.5 3978.3 4027.6 4049.3 4069.5 4071.6 3111.0 3389.0 3992.8 4036.8 4097.6 3535.0 3599.0 3815.9 3889.5 3981.1 3621.9 3985.0 4019.3 4019.4 4075.2 2936.6 3080.2 3231.7 3475.9 3488.2 4898.6 5101.2 5129.3 5221.4 5241.4 4181.7 4209.6 4443.4 4540.2 4569.6 5281.9 5486.7 5600.1 5622.0 5624.0 3483.0 3714.1 3829.0 3842.8 3856.7 5201.5 5430.6 5480.5 5601.7 5813.0 3640.9 3666.0 3762.3 3773.2 3789.3 3603.4 3857.7 3884.0 3889.4 3894.2 3845.1 4158.7 4395.4 4466.1 4485.6 4532.9 4726.9 4959.5 5435.7 5511.5 1072.8 1317.0 1319.8 1324.8 1325.9 672.2 791.5 806.3 810.6 818.9 3623.0 4075.9 4133.8 4136.3 4436.9 4139.5 4612.8 4657.0 4658.6 4684.6 4070.7 4353.9 4361.7 4403.8 4406.6 2452.9 2684.5 2930.6 2932.9 2960.3 5368.2 5613.9 5774.9 5790.3 5816.3 4949.4 5554.6 5754.8 5758.2 5779.6 5770.0 5799.9 5815.0 5905.9 5916.3 5087.4 5502.7 5595.5 5619.6 5628.6 4461.6 5370.2 5581.7 5600.7 5648.3 5309.9 5824.8 5846.0 5883.5 5921.9 3701.6 3701.9 3710.6 3762.9 3773.4 4615.6 4764.6 5297.7 5548.9 5578.2 4394.5 4587.9 5378.6 5447.3 5458.0 5399.2 5440.3 5452.4 5484.4 5489.4 4394.3 4494.0 4979.1 5391.0 5402.0 4400.7 4419.5 5247.2 5263.7 5308.0 4879.6 5222.1 5282.3 5312.0 5353.7 16:55:21 INFO - PROCESS | 1653 | 16:55:21 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:23082.84 Median:3920.04 stddev:35398.66 (903.0%) stddev-sans-first:35458.05 16:55:21 INFO - PROCESS | 1653 | Values: 693.1 740.0 750.5 783.0 789.5 15149.8 15442.4 15487.8 15498.5 15953.9 13951.4 14109.2 14209.1 14222.4 14258.9 698.3 718.6 721.8 754.2 875.9 885.5 896.6 908.8 911.8 912.0 959.4 960.3 962.2 963.1 968.5 731.6 955.9 956.9 956.9 957.0 554.5 559.7 559.9 560.2 560.5 14223.8 14497.4 14624.6 14681.1 14990.4 13730.6 13887.6 13955.9 14167.8 14250.4 10931.9 11189.6 11222.2 11292.3 11687.2 3311.5 3330.2 3339.8 3412.5 3476.3 114778.0 117256.0 119124.0 119697.4 120248.0 10191.9 10379.4 10420.2 10711.4 10854.2 22637.5 22771.8 22777.2 22793.0 22836.5 6809.7 7133.5 7373.8 7396.5 7490.4 4132.5 4219.5 4224.5 4251.1 4284.9 3524.9 3634.7 3691.4 3700.9 3707.6 644.6 647.5 649.1 656.2 665.2 593.8 615.7 623.9 638.1 639.0 8732.4 9094.1 9249.6 9253.8 9338.0 628.8 662.1 662.3 663.9 668.2 4259.1 4532.2 4547.6 4549.1 4674.8 94784.0 96046.0 96753.5 147384.0 158902.0 99480.5 99673.5 101720.5 102014.3 106404.5 91815.5 91870.0 94858.0 97135.1 112112.4 9105.5 9634.4 9671.1 9694.8 9760.9 61030.7 62820.6 63157.7 63842.7 65540.4 66761.3 88772.0 92740.0 98437.0 99266.0 12711.6 12874.5 12949.8 13166.5 13211.5 14762.0 15075.2 15308.1 15334.3 15595.3 13387.5 13505.3 13658.5 13796.2 14160.4 13476.6 13623.9 13628.7 13889.7 14017.7 10785.8 13010.4 13413.4 13440.4 13671.8 10734.2 10920.9 11186.6 11323.9 11735.1 11016.7 11065.3 11132.9 11168.7 11348.0 16:55:21 INFO - PROCESS | 1653 | -------- Summary: end -------- 16:55:21 INFO - PROCESS | 1653 | 16:55:22 INFO - TEST-INFO | 1653: exit 0 16:55:22 INFO - TEST-OK | dromaeo_css | took 1120024ms 16:55:22 INFO - TEST-START | kraken 16:55:22 INFO - operating with platform_type : mac_ 16:55:22 INFO - Initialising browser for kraken test... 16:55:22 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpzzhlms/profile http://localhost:49272/getInfo.html) 16:55:24 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 16:55:24 INFO - PROCESS | 1663 | colorDepth:24 16:55:24 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 16:55:24 INFO - PROCESS | 1663 | __metrics 16:55:24 INFO - PROCESS | 1663 | 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" 16:55:24 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:25 INFO - TEST-INFO | 1663: exit 0 16:55:25 INFO - Browser initialized. 16:55:25 INFO - Running cycle 1/1 for kraken test... 16:55:25 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpzzhlms/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:37 INFO - PROCESS | 1664 | RSS: Main: 256012288 16:55:37 INFO - PROCESS | 1664 | 16:55:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:40 INFO - PROCESS | 1664 | RSS: Main: 304975872 16:55:40 INFO - PROCESS | 1664 | 16:55:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 16:55:43 INFO - PROCESS | 1664 | RSS: Main: 303579136 16:55:43 INFO - PROCESS | 1664 | 16:55:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 16:55:48 INFO - PROCESS | 1664 | RSS: Main: 393154560 16:55:48 INFO - PROCESS | 1664 | 16:55:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 16:55:50 INFO - PROCESS | 1664 | RSS: Main: 293986304 16:55:50 INFO - PROCESS | 1664 | 16:55:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:53 INFO - PROCESS | 1664 | RSS: Main: 298266624 16:55:53 INFO - PROCESS | 1664 | 16:55:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:56 INFO - PROCESS | 1664 | RSS: Main: 335781888 16:55:56 INFO - PROCESS | 1664 | 16:55:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:00 INFO - PROCESS | 1664 | RSS: Main: 336592896 16:56:00 INFO - PROCESS | 1664 | 16:56:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 16:56:03 INFO - PROCESS | 1664 | RSS: Main: 333799424 16:56:03 INFO - PROCESS | 1664 | 16:56:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:05 INFO - PROCESS | 1664 | RSS: Main: 311599104 16:56:05 INFO - PROCESS | 1664 | 16:56:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:08 INFO - PROCESS | 1664 | RSS: Main: 313122816 16:56:08 INFO - PROCESS | 1664 | 16:56:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:11 INFO - PROCESS | 1664 | RSS: Main: 321753088 16:56:11 INFO - PROCESS | 1664 | 16:56:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:14 INFO - PROCESS | 1664 | RSS: Main: 326828032 16:56:14 INFO - PROCESS | 1664 | 16:56:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:18 INFO - PROCESS | 1664 | RSS: Main: 326606848 16:56:18 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 16:56:20 INFO - PROCESS | 1664 | RSS: Main: 371081216 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | __start_tp_report 16:56:20 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 16:56:20 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 16:56:20 INFO - PROCESS | 1664 | |i|pagename|runs| 16:56:20 INFO - PROCESS | 1664 | |0;ai-astar;114;114;114;114;113;115;114;113;114;113 16:56:20 INFO - PROCESS | 1664 | |1;audio-beat-detection;148;112;115;142;115;112;112;112;142;111 16:56:20 INFO - PROCESS | 1664 | |2;audio-dft;182;183;185;185;185;184;190;250;186;183 16:56:20 INFO - PROCESS | 1664 | |3;audio-fft;82;59;60;88;63;59;59;57;82;59 16:56:20 INFO - PROCESS | 1664 | |4;audio-oscillator;91;70;91;71;67;68;92;67;68;90 16:56:20 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;85;89;85;88;86;129;87;89;85 16:56:20 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;97;99;96;98;97;96;97;96;98 16:56:20 INFO - PROCESS | 1664 | |7;imaging-desaturate;82;82;85;83;80;80;85;85;81;83 16:56:20 INFO - PROCESS | 1664 | |8;json-parse-financial;55;53;55;56;57;56;56;56;57;56 16:56:20 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;63;68;75;75;74;68;70;68;69;69 16:56:20 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;90;85;90;90;86;89;88;85;85 16:56:20 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;146;149;152;157;147;158;146;145;178;147 16:56:20 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;180;144;204;213;172;171;171;169;178;220 16:56:20 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;67;68;69;68;68;69;68;68;68;67 16:56:20 INFO - PROCESS | 1664 | __end_tp_report 16:56:20 INFO - PROCESS | 1664 | __start_cc_report 16:56:20 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1998 16:56:20 INFO - PROCESS | 1664 | __end_cc_report 16:56:20 INFO - PROCESS | 1664 | __startTimestamp1476489380396__endTimestamp 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | ------- Summary: start ------- 16:56:20 INFO - PROCESS | 1664 | Number of tests: 14 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:56:20 INFO - PROCESS | 1664 | Values: 114.0 114.0 114.0 114.0 113.0 115.0 114.0 113.0 114.0 113.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:115.00 stddev:15.26 (13.3%) stddev-sans-first:12.99 16:56:20 INFO - PROCESS | 1664 | Values: 148.0 112.0 115.0 142.0 115.0 112.0 112.0 112.0 142.0 111.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:191.30 Median:185.00 stddev:20.74 (11.2%) stddev-sans-first:21.73 16:56:20 INFO - PROCESS | 1664 | Values: 182.0 183.0 185.0 185.0 185.0 184.0 190.0 250.0 186.0 183.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:12.07 (19.6%) stddev-sans-first:11.48 16:56:20 INFO - PROCESS | 1664 | Values: 82.0 59.0 60.0 88.0 63.0 59.0 59.0 57.0 82.0 59.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:80.50 stddev:11.69 (14.5%) stddev-sans-first:11.34 16:56:20 INFO - PROCESS | 1664 | Values: 91.0 70.0 91.0 71.0 67.0 68.0 92.0 67.0 68.0 90.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:87.50 stddev:13.41 (15.3%) stddev-sans-first:14.18 16:56:20 INFO - PROCESS | 1664 | Values: 88.0 85.0 89.0 85.0 88.0 86.0 129.0 87.0 89.0 85.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:1.05 (1.1%) stddev-sans-first:1.05 16:56:20 INFO - PROCESS | 1664 | Values: 96.0 97.0 99.0 96.0 98.0 97.0 96.0 97.0 96.0 98.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:82.60 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.06 16:56:20 INFO - PROCESS | 1664 | Values: 82.0 82.0 85.0 83.0 80.0 80.0 85.0 85.0 81.0 83.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 16:56:20 INFO - PROCESS | 1664 | Values: 55.0 53.0 55.0 56.0 57.0 56.0 56.0 56.0 57.0 56.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:3.78 (5.4%) stddev-sans-first:3.08 16:56:20 INFO - PROCESS | 1664 | Values: 63.0 68.0 75.0 75.0 74.0 68.0 70.0 68.0 69.0 69.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:88.50 stddev:2.31 (2.6%) stddev-sans-first:2.30 16:56:20 INFO - PROCESS | 1664 | Values: 85.0 90.0 85.0 90.0 90.0 86.0 89.0 88.0 85.0 85.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:150.50 stddev:10.08 (6.7%) stddev-sans-first:10.41 16:56:20 INFO - PROCESS | 1664 | Values: 146.0 149.0 152.0 157.0 147.0 158.0 146.0 145.0 178.0 147.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:179.00 stddev:23.25 (13.0%) stddev-sans-first:24.64 16:56:20 INFO - PROCESS | 1664 | Values: 180.0 144.0 204.0 213.0 172.0 171.0 171.0 169.0 178.0 220.0 16:56:20 INFO - PROCESS | 1664 | 16:56:20 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 16:56:20 INFO - PROCESS | 1664 | Values: 67.0 68.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 67.0 16:56:20 INFO - PROCESS | 1664 | -------- Summary: end -------- 16:56:20 INFO - PROCESS | 1664 | 16:56:21 INFO - TEST-INFO | 1664: exit 0 16:56:21 INFO - TEST-OK | kraken | took 59080ms 16:56:21 INFO - SUITE-END | took 1179s 16:56:21 INFO - Completed test suite (00:19:39) 16:56:21 INFO - javascript benchmark 16:56:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3284.7043766061056, 3292.390907682079, 3292.423825830479, 3332.583427071616, 3333.9333213335717, 5488.094464413377, 5581.0, 5643.633163844357, 5666.433356664332, 5672.092465205568, 5505.366882808478, 5601.579881508883, 5644.04051311276, 5663.9433605663935, 5696.373398926125, 5012.548870601645, 5039.748012599373, 5042.974785126069, 5107.616928730342, 5111.0, 5126.359205099363, 5236.0, 5242.449542798008, 5246.134387826004, 5280.207968804691, 4716.434027916637, 4761.738104404257, 5151.459096794839, 5155.793768249266, 5252.71110088945, 5077.238414237857, 5120.052790233782, 5134.768935397916, 5135.666181698215, 5139.820106296299, 5002.52476014778, 5102.872428189288, 5119.334486516729, 5125.84622461323, 5126.5642420394315, 5562.749676264537, 5572.3870374258795, 5588.6646801191655, 5636.520895723868, 5636.520895723868, 6050.152978583002, 6072.483838873657, 6081.939180608181, 6086.300075491331, 6093.390660933871, 5243.816466423695, 6067.423594758491, 6102.328743838174, 6111.694415279218, 6138.324784273726, 5616.859578510529, 5666.405027472098, 5683.005474042026, 5711.000574899459, 5742.655440673573, 6201.875962480815, 6240.063990401385, 6253.7185826637915, 6284.340144284875, 6286.339934306923, 5816.2148110005455, 6035.034394496947, 6047.0324748040985, 6057.0, 6066.090086487062, 6080.391960803884, 6081.300650425169, 6110.969445152835, 6115.179495343508, 6119.013467208553, 5104.795808167632, 5210.713410762444, 6024.0, 6054.878902421927, 6056.636601803906, 5763.625364351304, 6098.54260930432, 6113.266408031065, 6115.969420152871, 6172.938270617326, 4775.355327030876, 4834.613230941586, 4840.2255639097575, 4847.660663753574, 4881.633877459205, 4320.4383430153875, 4353.912921741611, 4355.0854320593035, 4375.584319489643, 4403.84586539476, 5649.180868774005, 5659.660420374791, 5661.745221464962, 5662.6036177468, 5672.376038635829, 4919.286703428054, 6037.275526936708, 6115.327313995457, 6118.929187392188, 6216.098665693539, 5602.467765562346, 5636.689982050944, 5666.036773748473, 5680.261565996394, 5681.062624666966, 5331.253624492497, 5337.6797392156595, 5342.626016178908, 5345.919811202835, 5369.812056578001, 6207.534434917309, 6233.594816336924, 6236.469900058546, 6252.624842509464, 6261.217347831521, 6044.335123136363, 6066.878662426639, 6121.84695382619, 6135.202423684892, 6145.832291864532, 6211.751529938932, 6228.781992630236, 6234.1583886174785, 6246.094316324198, 6247.562670613013, 6028.788992385421, 6076.787312444043, 6079.635221886701, 6101.115338275837, 6114.357992410733, 5833.766649333979, 5925.200097986716, 6160.44555989963, 6168.19813424252, 6229.4393504584805, 5954.612950158225, 5968.612040217546, 5999.5800293979, 6032.1856549365275, 6078.088286757022, 6023.45788879003, 6026.608270462406, 6030.185924900083, 6035.004224303117, 6046.788362407295, 5685.431456854281, 5822.94177058224, 5846.239988801429, 5876.294844618673, 5893.557983151367, 4886.389201349832, 4972.477889821516, 5811.418858114154, 5913.852153696192, 6058.878822423439, 5808.07070868659, 5809.099589563455, 5809.622374545641, 5818.679972601548, 5858.619189752652], "value": 5570.598083008857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.25819866504924, 509.2183498330063, 511.2152845382339, 521.2962500624158, 525.855389767814, 30368.848155759217, 40559.98600034997, 41210.79394603023, 41220.793896030475, 43386.566134338645, 42496.15007699844, 42819.35770963438, 42967.3554896676, 42996.78501607488, 43057.569424305744, 9413.67052153173, 9562.378445401062, 9574.0, 9607.759806004837, 9616.134547890688, 9455.763605909873, 9585.472798996052, 9587.520623968809, 9595.232381409505, 9611.66359177429, 9597.280203984694, 9605.66380176694, 9618.90381096187, 9642.951785241064, 9649.662261820838, 9526.42841429513, 9573.90426095744, 9594.280428967786, 9606.9519652402, 9615.230781537495, 9488.335816492849, 9561.760955976086, 9576.138147566753, 9576.90423095767, 9588.424694518351, 40313.59686403128, 40579.79710101431, 40643.0, 40667.0, 40719.7964010181, 3313.867445302185, 3510.0347404463723, 3525.3301872644115, 3768.3593789055926, 3957.98021009896, 29737.81048758047, 29772.404551909058, 30402.391952161055, 30511.932082377232, 30573.0, 3041.3461105862125, 3099.5815564898676, 3100.0, 3101.829399383033, 3149.1497295730255, 438856.0, 482990.9999999965, 484460.0, 485774.0, 493497.0, 60467.39532604618, 60801.39198607957, 60827.695861520406, 60880.78238435207, 60942.0, 34593.654063459544, 34893.82553087269, 35102.47346289808, 62328.376716233164, 62433.0, 16630.417935372203, 16717.99692018483, 16795.91602041982, 16809.15954202285, 16838.579035523966, 12416.875831241572, 12422.006239500819, 12816.35918204086, 12836.908862746584, 12902.483900644056, 19196.328128515433, 19210.80789192118, 19417.126229319714, 19454.70817937732, 19485.928273944784, 7878.684852605831, 7937.3650107991225, 7941.444098913021, 7950.562719050507, 8042.597870106471, 836.4437648963371, 924.902885197058, 979.5004547680592, 985.4284514981293, 1008.495752123938, 29792.0, 30447.0, 30485.39029219403, 30808.84355425687, 31228.0, 798.3214267872378, 998.0967224661692, 998.9900100999042, 999.1756800639502, 1133.5012594458412, 12099.697507562205, 15075.0, 15129.773053404208, 15517.0, 15663.981841180286, 558101.0, 589129.0, 589270.0, 591606.0, 593437.0, 57462.850742984905, 58145.8370832581, 58242.7087864558, 58288.70855645695, 58357.708211458674, 1192.761447710444, 1250.3935591238242, 1281.4297637551388, 1389.6248013036422, 1390.1728471559406, 28910.42179156363, 29182.854085729436, 30388.24029399194, 30633.795807870978, 30966.84516577493, 49583.0, 50388.496115039845, 50459.990800184525, 50470.99999999853, 50532.49467505278, 435266.0, 436513.0, 436981.0, 437535.0, 437845.0, 26540.469190615695, 26597.33506662349, 27002.0, 27193.86403067972, 27585.448291033666, 47556.0, 47607.76196118997, 47782.0, 47946.5205347942, 48941.26588101253, 39294.01764955899, 39326.01684957899, 39421.60578394294, 40063.78214100056, 40632.39051414172, 38864.02839928911, 39267.607323927536, 40073.1985360297, 40524.39213411742, 40850.79574602108, 38494.230115398095, 38641.03397415087, 38882.0, 39398.60601393949, 40659.186816264104, 27698.86150569234, 33459.0, 34252.48621270633, 35092.549493428574, 35526.822365888, 23508.294751157493, 24405.633915490926, 25709.614355785052, 25931.351716207246, 26312.605310919967], "value": 19615.68500270229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.80663038643934, 371.6840685417394, 375.7219657453484, 382.2450659946605, 403.26001786721366, 15402.229888505572, 15423.915216956611, 19676.704849427253, 21382.35852924411, 21611.243606473778, 20686.68969965452, 20768.48078798031, 20787.792122078776, 21362.57274854502, 21515.031823567937, 5598.300212473451, 5973.342932277467, 5975.402459754012, 5989.3112292086535, 5991.191189189469, 5724.398938111501, 5838.386969368219, 5851.678157701324, 5852.473277405033, 5879.941200588003, 5809.912851307213, 5821.8835623287505, 5837.241158649391, 5860.033094539396, 5873.618214816044, 5588.524975377098, 5742.0, 5818.301803783531, 5822.224221612407, 5829.4753472187285, 5075.0, 5077.339945807058, 5078.187490001619, 5085.440601533828, 5095.8980820383385, 13380.264085475295, 13559.932200339033, 23295.71873546954, 23443.4139146521, 24481.143159989493, 2085.2284654677715, 2164.653655415126, 2180.4439867833757, 2186.6173419651495, 2279.259240746764, 10166.745831354201, 10249.692509224735, 10274.7431314217, 10491.42297173655, 14623.853761462356, 1773.5388798912247, 1807.2138619700472, 1826.1143345477433, 1833.1109411935201, 1854.0451667391305, 116891.41554292174, 122189.0, 122467.387663062, 135480.96778548328, 137844.31077844647, 11339.773204535863, 11461.426928653535, 11523.539058437736, 11578.536858525733, 11888.64334069962, 12981.0, 13437.529686460926, 13495.865041349658, 13506.797398039038, 14248.857511424752, 8460.915390846136, 8501.362397820189, 8601.118625260608, 8703.0, 8718.607662655195, 8549.871751923725, 8564.785880353042, 8591.957040214758, 8756.649734010696, 8795.0, 3974.787689754595, 4474.440694913136, 4498.685092043525, 4585.656075794329, 4617.076584683077, 1852.1199534723635, 1887.1602137049156, 1905.7236700678325, 1907.990460047691, 1915.6264528417103, 826.2935190412231, 875.1423604867266, 947.9810403791886, 986.2110311750571, 1003.0821798054699, 20406.183752650024, 20937.581248374947, 21092.261770838253, 21146.193685136823, 21175.0, 923.4782347973373, 935.6023689931752, 941.4962994797751, 947.554649314821, 951.2009911674227, 10881.075108615856, 11337.943310283395, 11392.601258955896, 11415.029722473517, 11443.313401195956, 570029.0, 575297.0, 575843.0, 588336.0, 590486.0, 130176.3491182538, 132027.0, 132149.0, 133568.0, 136295.6370436283, 952.1953948913157, 959.3428501476511, 981.9214462842956, 982.543117450389, 984.5618699678574, 18933.33733319327, 19203.807961920204, 19204.903975480032, 19211.231550738372, 19215.32746353871, 54698.0, 56566.0, 56763.43236567581, 56955.715221425286, 57335.42664573301, 71316.28683713304, 74416.8607964485, 75069.6246518764, 75277.62361188159, 83173.0, 7826.569538675428, 7844.803879903048, 8001.199880011952, 8083.110857805755, 8238.176182381714, 11399.0, 12655.177413468095, 12714.427850746553, 13053.151545149534, 13216.471341146247, 10910.509027093958, 11340.036096931854, 11400.149962509373, 11548.018418434527, 11565.363904985306, 10647.467626618793, 10855.945720271347, 10931.070858977077, 11042.061424778984, 11450.885491144982, 11377.715557110807, 11598.130140239347, 11645.76708465843, 11851.881481185077, 11867.58463453775, 6880.552764070319, 7509.399248060033, 7829.49108307981, 7940.444168908121, 8251.133630968901, 10766.515506802056, 11267.549298028314, 11478.598249061242, 11581.305121692725, 11738.063219568676], "value": 9493.134910472041, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.379056319938, 1458.3874772595511, 1584.3820909845163, 1823.6808558502266, 1981.2669312354421, 7997.640106195221, 8496.49021058737, 8668.696595619154, 9021.95489022554, 9044.8643270351, 8913.598888050037, 8983.281337493001, 8990.775230619238, 8991.0, 8992.640294388217, 2374.845635033726, 2400.495895861862, 2404.7234568024637, 2409.6265078912797, 2410.0359856057544, 2342.0, 2386.78518933296, 2388.1163969331283, 2389.8685572293516, 2391.414103544634, 2366.3965688749345, 2388.152205966883, 2388.7133543974746, 2389.450426401929, 2390.95218095638, 2336.3224664847176, 2357.446000189954, 2363.102021231921, 2367.30164601443, 2373.4896997145697, 2340.8595484270827, 2360.5632957902844, 2361.8700971446565, 2365.66880636711, 2366.976330236693, 7408.962955185243, 8977.865332020025, 8981.0, 9002.27981761464, 9019.684311049083, 5385.623006389555, 5527.949689558971, 5539.556835453154, 5566.916496252559, 5573.136163894603, 3686.189038411545, 3711.2391959648207, 3735.1969326594913, 3787.507624008861, 3805.2009078093633, 1018.1396719771781, 1069.8605984626347, 1070.946452677363, 1076.7415820203173, 1079.9892001079968, 11778.293302401798, 11813.054955603531, 11903.940480297542, 11912.987396071345, 11930.88069119315, 4277.251480990814, 4441.111777644484, 4456.153330867125, 4527.705699129546, 4691.39011928454, 8117.553534555656, 9244.121808428188, 9273.489958052238, 9279.0, 9301.209397201179, 5049.495050494921, 5314.256004159421, 5345.973270133624, 5357.919631205535, 5370.355557333145, 4215.683823713233, 4487.6185524230805, 4640.234361330343, 4662.160811054043, 4716.882077948078, 3333.3166700826273, 3757.1734218471893, 3775.6413140751583, 3866.478025466526, 3871.612838716162, 1008.5511947183433, 1159.7100724818795, 1160.0545555372344, 1165.5650250795804, 1181.285322379965, 826.5412695953803, 861.5864385095064, 907.5008745190119, 917.3991035871514, 946.703016866883, 4908.263760435963, 5056.9633225188745, 5937.0, 5958.255218097738, 6102.969485152635, 427.37603099475115, 429.3516789647654, 438.45412461485654, 446.4040505924627, 446.48208078628636, 3866.497355343787, 3919.647231749156, 4020.3567429211184, 4040.131371755028, 4061.5329237138108, 10400.895991040145, 10633.989770971746, 10823.891761082446, 10855.565777368975, 10993.0, 10966.780664386668, 10983.340999540053, 10985.725356866142, 11024.842391548933, 11049.33703977764, 8079.878801817978, 8335.458195217292, 8426.0, 8453.577321133918, 8455.74632761018, 5754.68349240779, 5802.361740208489, 5864.67744274069, 5895.882082358415, 5983.132445795248, 10081.0, 10147.64483243083, 10195.592176313161, 10202.846957295498, 10218.846717299395, 8237.856633555073, 10003.2997690161, 10308.226882983656, 10358.171346292429, 10459.267851250339, 6543.770968016097, 6605.9009114864275, 6674.566153200027, 7175.928240717526, 7198.172210195895, 7909.564973926489, 8332.750017499484, 8511.36164787631, 8580.91419085826, 8611.31109511225, 7448.73929412468, 7543.8491230173995, 7544.924550754642, 7598.164201937893, 7722.3049925506975, 6525.608463492205, 6647.803395388876, 7230.13238411373, 7461.291177338144, 7508.2867127622785, 6915.446764258747, 6963.9651801740665, 7038.718451261892, 7059.82350441243, 7086.822829429306, 4951.8266860659705, 4975.875603109951, 4982.302477653204, 4987.925181122214, 5156.948430515797, 4900.0, 4906.8773280668265, 4958.380202474691, 5038.0, 5455.863603409946], "value": 4465.932022067357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.1700818650472, 299.4086678809352, 306.7545963229417, 309.3997644569535, 311.8144703901178, 4323.675724320677, 4688.742119183444, 5210.805301732109, 5239.187925871486, 5257.737113144347, 5079.822206222783, 5160.664556803815, 5213.246462546969, 5217.165253559422, 5243.535538297004, 3978.3435733104, 4027.6369231691574, 4049.2711311963835, 4069.511658600972, 4071.6335529802313, 3111.0200286909662, 3389.0341252742974, 3992.7803970781597, 4036.8183431745642, 4097.578521934189, 3535.0455377048183, 3599.028262369172, 3815.866444674437, 3889.4554762333155, 3981.104251543394, 3621.8732344367954, 3984.980075099635, 4019.31671615826, 4019.41718450823, 4075.2257071156387, 2936.6182396288345, 3080.152957936585, 3231.6588615724445, 3475.8957231283102, 3488.1628409181612, 4898.583620392271, 5101.158308879068, 5129.25625784263, 5221.399539052982, 5241.42344342122, 4181.671969511572, 4209.6000879916355, 4443.400140980991, 4540.228161212602, 4569.611583015448, 5281.890802931389, 5486.725663716798, 5600.143926597424, 5622.0, 5624.0, 3483.0073429072845, 3714.0900479382453, 3828.9808550957346, 3842.846286148551, 3856.730028897978, 5201.479852014806, 5430.56555475561, 5480.479354461319, 5601.691906945116, 5812.982728022579, 3640.8543658253375, 3665.9816700916326, 3762.3415902217002, 3773.2453509298252, 3789.2610940866266, 3603.3694103532303, 3857.7106716996336, 3883.9513331400362, 3889.416587511896, 3894.201688653819, 3845.115623406632, 4158.708890377705, 4395.362672412482, 4466.092169351818, 4485.609461067014, 4532.9093418132115, 4726.929096063562, 4959.454460009396, 5435.673859568438, 5511.476409741068, 1072.8229842076125, 1316.9539066132638, 1319.7954317080869, 1324.821149144853, 1325.8541560428346, 672.2202245395318, 791.5290402210791, 806.2824086562846, 810.6473683947502, 818.9108485713986, 3623.0, 4075.918481630351, 4133.751974881517, 4136.338185890243, 4436.889077773017, 4139.461869956886, 4612.838550650711, 4656.976715116402, 4658.604018658452, 4684.648651351163, 4070.7150499465347, 4353.891152721208, 4361.6510679145595, 4403.807239751155, 4406.620424970544, 2452.8650924198982, 2684.489946910081, 2930.560415937626, 2932.882684692631, 2960.304328482805, 5368.1679339702405, 5613.915791263134, 5774.88450230993, 5790.276215473066, 5816.272965879265, 4949.381327334083, 5554.638948468337, 5754.769809207585, 5758.222639943638, 5779.595428320062, 5770.0, 5799.9130013049835, 5814.9709251454315, 5905.911411328833, 5916.319623243382, 5087.379999300438, 5502.669839809624, 5595.524380427546, 5619.606627536034, 5628.577856660685, 4461.553844615512, 5370.248165256789, 5581.748821303132, 5600.691961942132, 5648.328586418861, 5309.867253318544, 5824.796132135524, 5846.0, 5883.529317654663, 5921.881562368642, 3701.611330810334, 3701.8889433317045, 3710.591834898105, 3762.8682996095004, 3773.358529050123, 4615.5845973862515, 4764.595009424238, 5297.655652382583, 5548.945700316927, 5578.219049333178, 4394.472663280427, 4587.908241835078, 5378.623496355218, 5447.291852059207, 5458.0, 5399.244105825109, 5440.292761940922, 5452.400235974119, 5484.424135465719, 5489.39616642177, 4394.340848872567, 4493.955060449353, 4979.103761322996, 5390.973045134906, 5402.0, 4400.73595584266, 4419.49175844782, 5247.181051516079, 5263.736703191283, 5308.0, 4879.56083952446, 5222.101733537923, 5282.3132992712235, 5312.0, 5353.705546194997], "value": 3908.4032167978608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.092049415266, 740.00099865182, 750.4634186556611, 782.9686812527499, 789.5144486141018, 15149.772753408693, 15442.382304707826, 15487.84512154878, 15498.457553985612, 15953.92023039886, 13951.372188251527, 14109.223992680398, 14209.147451152938, 14222.431102755878, 14258.857411425883, 698.2633321845451, 718.6370882704227, 721.7906807025956, 754.1892465599475, 875.9386842920982, 885.5439448683933, 896.6189369517929, 908.7728067983004, 911.8313112074254, 911.9968035161336, 959.4387283439162, 960.2941837749248, 962.1629182611138, 963.1187463470916, 968.5496244246424, 731.6195578299255, 955.861400096989, 956.8947415784259, 956.9138777509988, 957.004715096299, 554.512029414117, 559.6949662433983, 559.9496045355896, 560.1541672075155, 560.456357333386, 14223.786643200361, 14497.42010319586, 14624.561263162122, 14681.119132852064, 14990.400383984628, 13730.588082357544, 13887.623085610141, 13955.85993151543, 14167.750131504516, 14250.358733857001, 10931.945340273327, 11189.608363707313, 11222.158338124673, 11292.266002709797, 11687.240329378563, 3311.503274508819, 3330.167458135466, 3339.833008349573, 3412.488126781003, 3476.28736109097, 114777.98024836053, 117256.0, 119124.0, 119697.40151299188, 120248.0, 10191.94904025475, 10379.429131397847, 10420.218483613608, 10711.410872402093, 10854.185936054828, 22637.547249055257, 22771.772282277296, 22777.202797901995, 22792.974316155814, 22836.543269134523, 6809.693563789641, 7133.536320139175, 7373.81565460857, 7396.482246242819, 7490.363319117936, 4132.504099508078, 4219.539514623522, 4224.471941007374, 4251.149770046003, 4284.935725964113, 3524.947125793115, 3634.6547078027547, 3691.390920498088, 3700.907477313035, 3707.5736290326417, 644.5520363347429, 647.5370110371107, 649.0556240669814, 656.2223764838682, 665.2283351312454, 593.7684303121786, 615.673692942741, 623.8596315828993, 638.1321402892063, 638.9840253993688, 8732.432391894507, 9094.1360570747, 9249.583768730423, 9253.814923701488, 9338.0, 628.7924984755019, 662.1259936883267, 662.2814246542555, 663.8705452436825, 668.2348710726288, 4259.148170365877, 4532.206863798822, 4547.567981041796, 4549.112922979987, 4674.836380726658, 94784.0, 96046.0, 96753.5486967696, 147384.0, 158902.0, 99480.502597488, 99673.50163249283, 101720.49139754254, 102014.34892383101, 106404.46797766116, 91815.54092229629, 91870.0, 94858.0, 97135.05729885363, 112112.43943780391, 9105.453672779655, 9634.373765705206, 9671.106684924685, 9694.843496106501, 9760.85358719634, 61030.69484652548, 62820.589705147424, 63157.68421157865, 63842.7231455359, 65540.3614909612, 66761.31676956416, 88772.0, 92740.0, 98437.0, 99266.0, 12711.555095571981, 12874.549390771279, 12949.805752913526, 13166.473341066634, 13211.471541138631, 14762.0, 15075.246237687852, 15308.081515108684, 15334.309956051782, 15595.298211580279, 13387.50453220226, 13505.32473376347, 13658.521951731642, 13796.241206733726, 14160.433582656578, 13476.555669356327, 13623.86376136226, 13628.727425451634, 13889.722205556034, 14017.719645606827, 10785.784284314113, 13010.414531345923, 13413.396397161956, 13440.395182216627, 13671.787130024237, 10734.248602597743, 10920.890791091988, 11186.552537898393, 11323.943380283046, 11735.119866009913, 11016.724581885517, 11065.342540305699, 11132.944335278271, 11168.720781980515, 11348.0], "value": 7622.5566336166, "unit": "score"}], "name": "dromaeo_css", "value": 7188.903137781883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 113.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 115.0, 142.0, 115.0, 112.0, 112.0, 112.0, 142.0, 111.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 185.0, 185.0, 184.0, 190.0, 250.0, 186.0, 183.0], "value": 191.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 88.0, 63.0, 59.0, 59.0, 57.0, 82.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 91.0, 71.0, 67.0, 68.0, 92.0, 67.0, 68.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 85.0, 88.0, 86.0, 129.0, 87.0, 89.0, 85.0], "value": 91.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 99.0, 96.0, 98.0, 97.0, 96.0, 97.0, 96.0, 98.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 83.0, 80.0, 80.0, 85.0, 85.0, 81.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 75.0, 75.0, 74.0, 68.0, 70.0, 68.0, 69.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 85.0, 90.0, 90.0, 86.0, 89.0, 88.0, 85.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 152.0, 157.0, 147.0, 158.0, 146.0, 145.0, 178.0, 147.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 144.0, 204.0, 213.0, 172.0, 171.0, 171.0, 169.0, 178.0, 220.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1457.8000000000002, "alertThreshold": 2.0}]} 16:56:21 INFO - Return code: 0 16:56:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:56:21 INFO - # TBPL SUCCESS # 16:56:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:56:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:56:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:56:21 INFO - 2016-10-14 16:56:21.714 screenresolution[1668:9764] starting screenresolution argv=screenresolution get 16:56:21 INFO - 2016-10-14 16:56:21.716 screenresolution[1668:9764] Display 0: 1600x1200x32@60 16:56:21 INFO - 2016-10-14 16:56:21.722 screenresolution[1669:9767] starting screenresolution argv=screenresolution list 16:56:21 INFO - Available Modes on Display 0 16:56:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:56:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:56:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:56:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:56:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:56:21 INFO - Intel Iris: 16:56:21 INFO - Chipset Model: Intel Iris 16:56:21 INFO - Type: GPU 16:56:21 INFO - Bus: Built-In 16:56:21 INFO - VRAM (Dynamic, Max): 1536 MB 16:56:21 INFO - Vendor: Intel (0x8086) 16:56:21 INFO - Device ID: 0x0a2e 16:56:21 INFO - Revision ID: 0x0009 16:56:21 INFO - Displays: 16:56:21 INFO - Display: 16:56:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:56:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:56:21 INFO - Display Serial Number: 1600x1200 60 16:56:21 INFO - Main Display: Yes 16:56:21 INFO - Mirror: Off 16:56:21 INFO - Online: Yes 16:56:21 INFO - Rotation: Supported 16:56:21 INFO - Return code: 0 16:56:21 INFO - Running post-action listener: _resource_record_post_action 16:56:21 INFO - [mozharness: 2016-10-14 23:56:21.959103Z] Finished run-tests step (success) 16:56:21 INFO - Running post-run listener: _resource_record_post_run 16:56:22 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37295104; Write bytes: 711140864; Read time: 244; Write time: 1981 16:56:22 INFO - TinderboxPrint: CPU usage
53.7% 16:56:22 INFO - TinderboxPrint: I/O read bytes / time
37,295,104 / 244 16:56:22 INFO - TinderboxPrint: I/O write bytes / time
711,140,864 / 1,981 16:56:22 INFO - TinderboxPrint: CPU idle
2,247.5 (46.3%) 16:56:22 INFO - TinderboxPrint: CPU system
976.4 (20.1%) 16:56:22 INFO - TinderboxPrint: CPU user
1,633.8 (33.6%) 16:56:22 INFO - TinderboxPrint: Swap in / out
445,726,720 / 0 16:56:22 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390832640; Write bytes: 384456192; Read time: 29081; Write time: 789 16:56:22 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36340736; Write bytes: 299790336; Read time: 232; Write time: 1129 16:56:22 INFO - Running post-run listener: _upload_blobber_files 16:56:22 INFO - Blob upload gear active. 16:56:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:56:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:56:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:25 INFO - (blobuploader) - INFO - Done attempting. 16:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:26 INFO - (blobuploader) - INFO - Done attempting. 16:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:28 INFO - (blobuploader) - INFO - Done attempting. 16:56:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:56:28 INFO - Return code: 0 16:56:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:56:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:56:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f606c7d155e9d1374b4fcf236da09c62be3bd5e8952b5a9b2cbb548548f95af1ed8521581a46adb8db95fcee5cca7e3bdfcd6a5df2de9eebfb502306a67b4bbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8669bf8ef90d1ea1cbd15080961e80ff7eb4aeaee987d98afcd6b8357426aefa39064ed8f2b7b313018728284b85ea41c8e6e0c1f234302239f69507b97ced57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4efc76bb1f15a5aef2e7b9921d2345b94faf61282880e91b9d02b64e8bd04991a687445afb6767d9bfaca3c2706caa48fd25ec179acbe715bfded010e360e39"} 16:56:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:56:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:56:28 INFO - Contents: 16:56:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f606c7d155e9d1374b4fcf236da09c62be3bd5e8952b5a9b2cbb548548f95af1ed8521581a46adb8db95fcee5cca7e3bdfcd6a5df2de9eebfb502306a67b4bbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8669bf8ef90d1ea1cbd15080961e80ff7eb4aeaee987d98afcd6b8357426aefa39064ed8f2b7b313018728284b85ea41c8e6e0c1f234302239f69507b97ced57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4efc76bb1f15a5aef2e7b9921d2345b94faf61282880e91b9d02b64e8bd04991a687445afb6767d9bfaca3c2706caa48fd25ec179acbe715bfded010e360e39"} 16:56:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:56:28 INFO - Copying logs to upload dir... 16:56:28 INFO - mkdir: /builds/slave/test/build/upload/logs 16:56:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.212213 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-14 16:56:29.093692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:29.097601) ========= 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.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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/f606c7d155e9d1374b4fcf236da09c62be3bd5e8952b5a9b2cbb548548f95af1ed8521581a46adb8db95fcee5cca7e3bdfcd6a5df2de9eebfb502306a67b4bbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8669bf8ef90d1ea1cbd15080961e80ff7eb4aeaee987d98afcd6b8357426aefa39064ed8f2b7b313018728284b85ea41c8e6e0c1f234302239f69507b97ced57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4efc76bb1f15a5aef2e7b9921d2345b94faf61282880e91b9d02b64e8bd04991a687445afb6767d9bfaca3c2706caa48fd25ec179acbe715bfded010e360e39"} build_url:https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010946 build_url: 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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/f606c7d155e9d1374b4fcf236da09c62be3bd5e8952b5a9b2cbb548548f95af1ed8521581a46adb8db95fcee5cca7e3bdfcd6a5df2de9eebfb502306a67b4bbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8669bf8ef90d1ea1cbd15080961e80ff7eb4aeaee987d98afcd6b8357426aefa39064ed8f2b7b313018728284b85ea41c8e6e0c1f234302239f69507b97ced57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4efc76bb1f15a5aef2e7b9921d2345b94faf61282880e91b9d02b64e8bd04991a687445afb6767d9bfaca3c2706caa48fd25ec179acbe715bfded010e360e39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:29.129039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:29.129549) ========= 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.TgxaffTqvS/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.2VDsN7B2A7/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:29.179155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:56:29.179663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:56:29.180090) ========= ========= Total master_lag: 0.19 =========