builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1484063779.45 results: success (0) buildid: 20170110064707 builduid: 97d70c113e944f00ae379858f533734a revision: 2c85b6401be3a9e67e985e62b82b2a8277338880 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.451065) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.451584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.451913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.477641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.478108) ========= 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.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 --2017-01-10 07:56:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-01-10 07:56:19 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.609372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.609735) ========= 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.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.024202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.659127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:19.659518) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c85b6401be3a9e67e985e62b82b2a8277338880 --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 2c85b6401be3a9e67e985e62b82b2a8277338880 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 2017-01-10 07:56:19,771 truncating revision to first 12 chars 2017-01-10 07:56:19,771 Setting DEBUG logging. 2017-01-10 07:56:19,771 attempt 1/10 2017-01-10 07:56:19,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c85b6401be3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 07:56:20,405 unpacking tar archive at: mozilla-central-2c85b6401be3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:20.598880) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:20.599240) ========= script_repo_revision: 2c85b6401be3a9e67e985e62b82b2a8277338880 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:20.599761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:20.600080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 07:56:20.620384) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-10 07:56:20.620859) ========= /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.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:20 INFO - MultiFileLogger online at 20170110 07:56:20 in /builds/slave/test 07:56:20 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 07:56:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:20 INFO - {'append_to_log': False, 07:56:20 INFO - 'base_work_dir': '/builds/slave/test', 07:56:20 INFO - 'blob_upload_branch': 'Firefox', 07:56:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:20 INFO - 'branch': 'Firefox', 07:56:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:20 INFO - 'config_files': ('talos/mac_config.py',), 07:56:20 INFO - 'default_actions': ('clobber', 07:56:20 INFO - 'read-buildbot-config', 07:56:20 INFO - 'download-and-extract', 07:56:20 INFO - 'populate-webroot', 07:56:20 INFO - 'create-virtualenv', 07:56:20 INFO - 'install', 07:56:20 INFO - 'run-tests'), 07:56:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:20 INFO - 'download_minidump_stackwalk': True, 07:56:20 INFO - 'download_symbols': 'ondemand', 07:56:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:20 INFO - 'installer_path': 'installer.exe', 07:56:20 INFO - 'log_level': 'info', 07:56:20 INFO - 'log_name': 'talos', 07:56:20 INFO - 'log_to_console': True, 07:56:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:20 INFO - 'opt_config_files': (), 07:56:20 INFO - 'pip_index': False, 07:56:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'run_cmd_checks_enabled': True, 07:56:20 INFO - 'sps_profile': False, 07:56:20 INFO - 'sps_profile_interval': 0, 07:56:20 INFO - 'suite': 'dromaeojs', 07:56:20 INFO - 'system_bits': '32', 07:56:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:20 INFO - 'title': 't-yosemite-r7-0249', 07:56:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:20 INFO - 'use_talos_json': True, 07:56:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:20 INFO - 'work_dir': 'build'} 07:56:20 INFO - [mozharness: 2017-01-10 15:56:20.846441Z] Running clobber step. 07:56:20 INFO - Running pre-action listener: _resource_record_pre_action 07:56:20 INFO - Running main action method: clobber 07:56:20 INFO - rmtree: /builds/slave/test/build 07:56:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:23 INFO - Running post-action listener: _resource_record_post_action 07:56:23 INFO - [mozharness: 2017-01-10 15:56:23.130435Z] Finished clobber step (success) 07:56:23 INFO - [mozharness: 2017-01-10 15:56:23.130606Z] Running read-buildbot-config step. 07:56:23 INFO - Running pre-action listener: _resource_record_pre_action 07:56:23 INFO - Running main action method: read_buildbot_config 07:56:23 INFO - Using buildbot properties: 07:56:23 INFO - { 07:56:23 INFO - "project": "", 07:56:23 INFO - "product": "firefox", 07:56:23 INFO - "script_repo_revision": "production", 07:56:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:56:23 INFO - "repository": "", 07:56:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:56:23 INFO - "buildid": "20170110064707", 07:56:23 INFO - "pgo_build": "False", 07:56:23 INFO - "basedir": "/builds/slave/test", 07:56:23 INFO - "buildnumber": 73, 07:56:23 INFO - "slavename": "t-yosemite-r7-0249", 07:56:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:56:23 INFO - "platform": "yosemite_r7", 07:56:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:56:23 INFO - "branch": "mozilla-central", 07:56:23 INFO - "repo_path": "mozilla-central", 07:56:23 INFO - "revision": "2c85b6401be3a9e67e985e62b82b2a8277338880", 07:56:23 INFO - "stage_platform": "macosx64", 07:56:23 INFO - "builduid": "97d70c113e944f00ae379858f533734a", 07:56:23 INFO - "slavebuilddir": "test" 07:56:23 INFO - } 07:56:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:56:23 INFO - Running post-action listener: _resource_record_post_action 07:56:23 INFO - [mozharness: 2017-01-10 15:56:23.133929Z] Finished read-buildbot-config step (success) 07:56:23 INFO - [mozharness: 2017-01-10 15:56:23.134082Z] Running download-and-extract step. 07:56:23 INFO - Running pre-action listener: _resource_record_pre_action 07:56:23 INFO - Running main action method: download_and_extract 07:56:23 INFO - mkdir: /builds/slave/test/build/tests 07:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:23 INFO - trying https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:56:23 INFO - Downloading https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:56:24 INFO - Downloaded 1199 bytes. 07:56:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:56:24 INFO - Using the following test package requirements: 07:56:24 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:56:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:56:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:56:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'jsshell-mac.zip'], 07:56:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:56:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:56:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:56:24 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:56:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:56:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:56:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:56:25 INFO - Expected file size: 16309870 07:56:25 INFO - Obtained file size: 16309870 07:56:32 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:56:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:56:32 INFO - Fetch https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:56:33 INFO - Expected file size: 16309870 07:56:33 INFO - Obtained file size: 16309870 07:56:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:56:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:56:39 INFO - Fetch https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:56:40 INFO - Expected file size: 14403529 07:56:40 INFO - Obtained file size: 14403529 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:40 INFO - trying https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:56:42 INFO - Downloaded 69713604 bytes. 07:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:56:42 INFO - mkdir: /builds/slave/test/properties 07:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:42 INFO - Contents: 07:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:56:43 INFO - Running post-action listener: _resource_record_post_action 07:56:43 INFO - Running post-action listener: set_extra_try_arguments 07:56:43 INFO - [mozharness: 2017-01-10 15:56:43.080592Z] Finished download-and-extract step (success) 07:56:43 INFO - [mozharness: 2017-01-10 15:56:43.080698Z] Running populate-webroot step. 07:56:43 INFO - Running pre-action listener: _resource_record_pre_action 07:56:43 INFO - Running main action method: populate_webroot 07:56:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:43 INFO - '--tppagecycles', 07:56:43 INFO - '7'], 07:56:43 INFO - 'tests': ['tsvgm']}}, 07:56:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['damp', 'tps']}, 07:56:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'tests': ['damp', 'tps']}, 07:56:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['dromaeo_dom']}, 07:56:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['basic_compositor_video']}, 07:56:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tsvgx', 07:56:43 INFO - 'tsvgr_opacity', 07:56:43 INFO - 'tart', 07:56:43 INFO - 'tscrollx', 07:56:43 INFO - 'cart', 07:56:43 INFO - 'tsvg_static']}, 07:56:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:43 INFO - 'tsvgr_opacity', 07:56:43 INFO - 'tart', 07:56:43 INFO - 'tscrollx', 07:56:43 INFO - 'cart', 07:56:43 INFO - 'tsvg_static']}, 07:56:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tp5o']}, 07:56:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:56:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s', 07:56:43 INFO - '--xperf_path', 07:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:43 INFO - 'tests': ['tp5n']}, 07:56:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--xperf_path', 07:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:43 INFO - 'tests': ['tp5n']}}, 07:56:43 INFO - 'talos.zip': {'path': '', 07:56:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:43 INFO - Running post-action listener: _resource_record_post_action 07:56:43 INFO - [mozharness: 2017-01-10 15:56:43.099381Z] Finished populate-webroot step (success) 07:56:43 INFO - [mozharness: 2017-01-10 15:56:43.099495Z] Running create-virtualenv step. 07:56:43 INFO - Running pre-action listener: _resource_record_pre_action 07:56:43 INFO - Running main action method: create_virtualenv 07:56:43 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:43 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 07:56:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:43 INFO - Using real prefix '/tools/python27' 07:56:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:46 INFO - Installing pip.................done. 07:56:46 INFO - Return code: 0 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:56:47 INFO - Reading from file tmpfile_stdout 07:56:47 INFO - Output received: 07:56:47 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) 07:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:47 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 07:56:47 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 07:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:47 INFO - 'HOME': '/Users/cltbld', 07:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:47 INFO - 'LOGNAME': 'cltbld', 07:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:47 INFO - 'MOZ_NO_REMOTE': '1', 07:56:47 INFO - 'NO_EM_RESTART': '1', 07:56:47 INFO - 'PAGER': '/bin/cat', 07:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:47 INFO - 'PWD': '/builds/slave/test', 07:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:47 INFO - 'SHELL': '/bin/bash', 07:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:56:47 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:47 INFO - 'USER': 'cltbld', 07:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:47 INFO - 'XPC_FLAGS': '0x0', 07:56:47 INFO - 'XPC_SERVICE_NAME': '0', 07:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:47 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 07:56:47 INFO - Cleaning up... 07:56:47 INFO - Return code: 0 07:56:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:47 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 07:56:47 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 07:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:47 INFO - 'HOME': '/Users/cltbld', 07:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:47 INFO - 'LOGNAME': 'cltbld', 07:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:47 INFO - 'MOZ_NO_REMOTE': '1', 07:56:47 INFO - 'NO_EM_RESTART': '1', 07:56:47 INFO - 'PAGER': '/bin/cat', 07:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:47 INFO - 'PWD': '/builds/slave/test', 07:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:47 INFO - 'SHELL': '/bin/bash', 07:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:56:47 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:47 INFO - 'USER': 'cltbld', 07:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:47 INFO - 'XPC_FLAGS': '0x0', 07:56:47 INFO - 'XPC_SERVICE_NAME': '0', 07:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:47 INFO - Downloading/unpacking psutil>=3.1.1 07:56:47 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 07:56:47 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 07:56:47 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 07:56:47 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 07:56:47 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 07:56:47 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 07:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:51 INFO - Installing collected packages: psutil 07:56:51 INFO - Running setup.py install for psutil 07:56:51 INFO - building 'psutil._psutil_osx' extension 07:56:51 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 07:56:52 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 07:56:52 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 07:56:52 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 07:56:52 INFO - building 'psutil._psutil_posix' extension 07:56:52 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 07:56:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:56:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:56:52 INFO - ^ 07:56:52 INFO - 1 warning generated. 07:56:52 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 07:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:52 INFO - Successfully installed psutil 07:56:52 INFO - Cleaning up... 07:56:52 INFO - Return code: 0 07:56:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:52 INFO - 'HOME': '/Users/cltbld', 07:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:52 INFO - 'LOGNAME': 'cltbld', 07:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:52 INFO - 'MOZ_NO_REMOTE': '1', 07:56:52 INFO - 'NO_EM_RESTART': '1', 07:56:52 INFO - 'PAGER': '/bin/cat', 07:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:52 INFO - 'PWD': '/builds/slave/test', 07:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:52 INFO - 'SHELL': '/bin/bash', 07:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:56:52 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:52 INFO - 'USER': 'cltbld', 07:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:52 INFO - 'XPC_FLAGS': '0x0', 07:56:52 INFO - 'XPC_SERVICE_NAME': '0', 07:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:55 INFO - Installing collected packages: mozsystemmonitor 07:56:55 INFO - Running setup.py install for mozsystemmonitor 07:56:55 INFO - Successfully installed mozsystemmonitor 07:56:55 INFO - Cleaning up... 07:56:56 INFO - Return code: 0 07:56:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:56 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:56 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 07:56:56 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 07:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:56 INFO - 'HOME': '/Users/cltbld', 07:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:56 INFO - 'LOGNAME': 'cltbld', 07:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:56 INFO - 'MOZ_NO_REMOTE': '1', 07:56:56 INFO - 'NO_EM_RESTART': '1', 07:56:56 INFO - 'PAGER': '/bin/cat', 07:56:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:56 INFO - 'PWD': '/builds/slave/test', 07:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:56 INFO - 'SHELL': '/bin/bash', 07:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:56:56 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:56 INFO - 'USER': 'cltbld', 07:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:56 INFO - 'XPC_FLAGS': '0x0', 07:56:56 INFO - 'XPC_SERVICE_NAME': '0', 07:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:59 INFO - warning: no files found matching '*.txt' 07:56:59 INFO - no previously-included directories found matching 'build' 07:56:59 INFO - no previously-included directories found matching 'dist' 07:56:59 INFO - no previously-included directories found matching '.git*' 07:56:59 INFO - Installing collected packages: jsonschema, functools32 07:56:59 INFO - Running setup.py install for functools32 07:56:59 INFO - warning: no files found matching '*.txt' 07:56:59 INFO - no previously-included directories found matching 'build' 07:56:59 INFO - no previously-included directories found matching 'dist' 07:56:59 INFO - no previously-included directories found matching '.git*' 07:56:59 INFO - Successfully installed jsonschema functools32 07:56:59 INFO - Cleaning up... 07:56:59 INFO - Return code: 0 07:56:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:59 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:56:59 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 07:56:59 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 07:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:59 INFO - 'HOME': '/Users/cltbld', 07:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:59 INFO - 'LOGNAME': 'cltbld', 07:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:59 INFO - 'MOZ_NO_REMOTE': '1', 07:56:59 INFO - 'NO_EM_RESTART': '1', 07:56:59 INFO - 'PAGER': '/bin/cat', 07:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:59 INFO - 'PWD': '/builds/slave/test', 07:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:59 INFO - 'SHELL': '/bin/bash', 07:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:56:59 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:59 INFO - 'USER': 'cltbld', 07:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:59 INFO - 'XPC_FLAGS': '0x0', 07:56:59 INFO - 'XPC_SERVICE_NAME': '0', 07:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:57:00 INFO - Cleaning up... 07:57:00 INFO - Return code: 0 07:57:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:00 INFO - 'HOME': '/Users/cltbld', 07:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:00 INFO - 'LOGNAME': 'cltbld', 07:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:00 INFO - 'MOZ_NO_REMOTE': '1', 07:57:00 INFO - 'NO_EM_RESTART': '1', 07:57:00 INFO - 'PAGER': '/bin/cat', 07:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:00 INFO - 'PWD': '/builds/slave/test', 07:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:00 INFO - 'SHELL': '/bin/bash', 07:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:00 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:00 INFO - 'USER': 'cltbld', 07:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:00 INFO - 'XPC_FLAGS': '0x0', 07:57:00 INFO - 'XPC_SERVICE_NAME': '0', 07:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:04 INFO - Downloading docopt-0.6.1.tar.gz 07:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:04 INFO - Running setup.py install for blobuploader 07:57:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:04 INFO - Running setup.py install for requests 07:57:05 INFO - Running setup.py install for docopt 07:57:05 INFO - Successfully installed blobuploader requests docopt 07:57:05 INFO - Cleaning up... 07:57:05 INFO - Return code: 0 07:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57: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')]} 07:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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')]} 07:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:05 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:57:05 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 07:57:05 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 07:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:05 INFO - 'HOME': '/Users/cltbld', 07:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:05 INFO - 'LOGNAME': 'cltbld', 07:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:05 INFO - 'MOZ_NO_REMOTE': '1', 07:57:05 INFO - 'NO_EM_RESTART': '1', 07:57:05 INFO - 'PAGER': '/bin/cat', 07:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:05 INFO - 'PWD': '/builds/slave/test', 07:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:05 INFO - 'SHELL': '/bin/bash', 07:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:05 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:05 INFO - 'USER': 'cltbld', 07:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:05 INFO - 'XPC_FLAGS': '0x0', 07:57:05 INFO - 'XPC_SERVICE_NAME': '0', 07:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-pyXIkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-IKn2Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-GnfvD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-1PGqs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:05 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-yUAVEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-IVw_0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-PEcehM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-9aS0dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-2khrHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-B0_JL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-UjWqdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-b4Ay53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-UsMMJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:06 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-HmM3rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0HmAd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-QP3iG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:07 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-K30Fx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:07 INFO - Running setup.py install for manifestparser 07:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozcrash 07:57:07 INFO - Running setup.py install for mozdebug 07:57:07 INFO - Running setup.py install for mozdevice 07:57:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozfile 07:57:08 INFO - Running setup.py install for mozhttpd 07:57:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozinfo 07:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozInstall 07:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozleak 07:57:08 INFO - Running setup.py install for mozlog 07:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for moznetwork 07:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozprocess 07:57:09 INFO - Running setup.py install for mozprofile 07:57:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Running setup.py install for mozrunner 07:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Running setup.py install for mozscreenshot 07:57:09 INFO - Running setup.py install for moztest 07:57:09 INFO - Running setup.py install for mozversion 07:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:09 INFO - Cleaning up... 07:57:09 INFO - Return code: 0 07:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:57:09 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 07:57:09 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 07:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:09 INFO - 'HOME': '/Users/cltbld', 07:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:09 INFO - 'LOGNAME': 'cltbld', 07:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:09 INFO - 'MOZ_NO_REMOTE': '1', 07:57:09 INFO - 'NO_EM_RESTART': '1', 07:57:09 INFO - 'PAGER': '/bin/cat', 07:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:09 INFO - 'PWD': '/builds/slave/test', 07:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:09 INFO - 'SHELL': '/bin/bash', 07:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:09 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:09 INFO - 'USER': 'cltbld', 07:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:09 INFO - 'XPC_FLAGS': '0x0', 07:57:09 INFO - 'XPC_SERVICE_NAME': '0', 07:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-64NKO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-GiXpDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-HSNxCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-mNqNAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-CO6N9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-MChSlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ptMrBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:10 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-m6rePl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-5PpnlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-r4NT1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0LNcQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-8rze6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-bTXPQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-CAkB7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-RZcM5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ZWlWgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:11 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0rBBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:11 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)) 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:11 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)) 07:57:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:14 INFO - Downloading blessings-1.6.tar.gz 07:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:14 INFO - Installing collected packages: blessings 07:57:14 INFO - Running setup.py install for blessings 07:57:14 INFO - Successfully installed blessings 07:57:14 INFO - Cleaning up... 07:57:15 INFO - Return code: 0 07:57:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:15 INFO - Reading from file tmpfile_stdout 07:57:15 INFO - Current package versions: 07:57:15 INFO - blessings == 1.6 07:57:15 INFO - blobuploader == 1.2.4 07:57:15 INFO - docopt == 0.6.1 07:57:15 INFO - functools32 == 3.2.3-2 07:57:15 INFO - jsonschema == 2.5.1 07:57:15 INFO - manifestparser == 1.1 07:57:15 INFO - mozInstall == 1.12 07:57:15 INFO - mozcrash == 1.0 07:57:15 INFO - mozdebug == 0.1 07:57:15 INFO - mozdevice == 0.49 07:57:15 INFO - mozfile == 1.2 07:57:15 INFO - mozhttpd == 0.7 07:57:15 INFO - mozinfo == 0.9 07:57:15 INFO - mozleak == 0.1 07:57:15 INFO - mozlog == 3.4 07:57:15 INFO - moznetwork == 0.27 07:57:15 INFO - mozprocess == 0.24 07:57:15 INFO - mozprofile == 0.28 07:57:15 INFO - mozrunner == 6.13 07:57:15 INFO - mozscreenshot == 0.1 07:57:15 INFO - mozsystemmonitor == 0.3 07:57:15 INFO - moztest == 0.8 07:57:15 INFO - mozversion == 1.4 07:57:15 INFO - psutil == 3.1.1 07:57:15 INFO - requests == 1.2.3 07:57:15 INFO - wsgiref == 0.1.2 07:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:15 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')]} 07:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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')]} 07:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:57:15 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 07:57:15 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 07:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:15 INFO - 'HOME': '/Users/cltbld', 07:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:15 INFO - 'LOGNAME': 'cltbld', 07:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:15 INFO - 'MOZ_NO_REMOTE': '1', 07:57:15 INFO - 'NO_EM_RESTART': '1', 07:57:15 INFO - 'PAGER': '/bin/cat', 07:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:15 INFO - 'PWD': '/builds/slave/test', 07:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:15 INFO - 'SHELL': '/bin/bash', 07:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:15 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:15 INFO - 'USER': 'cltbld', 07:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:15 INFO - 'XPC_FLAGS': '0x0', 07:57:15 INFO - 'XPC_SERVICE_NAME': '0', 07:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 INFO - Cleaning up... 07:57:15 INFO - Return code: 0 07:57:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:15 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')]} 07:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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')]} 07:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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 0x109deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814a4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, '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.ZcnFyIlELq/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.WuossSxI46/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 07:57:15 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 07:57:15 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 07:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:15 INFO - 'HOME': '/Users/cltbld', 07:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:15 INFO - 'LOGNAME': 'cltbld', 07:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:15 INFO - 'MOZ_NO_REMOTE': '1', 07:57:15 INFO - 'NO_EM_RESTART': '1', 07:57:15 INFO - 'PAGER': '/bin/cat', 07:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:15 INFO - 'PWD': '/builds/slave/test', 07:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:15 INFO - 'SHELL': '/bin/bash', 07:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:15 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:15 INFO - 'USER': 'cltbld', 07:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:15 INFO - 'XPC_FLAGS': '0x0', 07:57:15 INFO - 'XPC_SERVICE_NAME': '0', 07:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:15 INFO - Cleaning up... 07:57:15 INFO - Return code: 0 07:57:15 INFO - Running post-action listener: _resource_record_post_action 07:57:15 INFO - Running post-action listener: _start_resource_monitoring 07:57:15 INFO - Starting resource monitoring. 07:57:15 INFO - [mozharness: 2017-01-10 15:57:15.889062Z] Finished create-virtualenv step (success) 07:57:15 INFO - [mozharness: 2017-01-10 15:57:15.890017Z] Running install step. 07:57:15 INFO - Running pre-action listener: _resource_record_pre_action 07:57:15 INFO - Running main action method: install 07:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:16 INFO - Reading from file tmpfile_stdout 07:57:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:16 INFO - Reading from file tmpfile_stdout 07:57:16 INFO - Output received: 07:57:16 INFO - Usage: mozinstall [options] installer 07:57:16 INFO - Options: 07:57:16 INFO - -h, --help show this help message and exit 07:57:16 INFO - -d DEST, --destination=DEST 07:57:16 INFO - Directory to install application into. [default: 07:57:16 INFO - "/builds/slave/test"] 07:57:16 INFO - --app=APP Application being installed. [default: firefox] 07:57:16 INFO - mkdir: /builds/slave/test/build/application 07:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:57:37 INFO - Reading from file tmpfile_stdout 07:57:37 INFO - Output received: 07:57:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:57:37 INFO - Running post-action listener: _resource_record_post_action 07:57:37 INFO - [mozharness: 2017-01-10 15:57:37.727270Z] Finished install step (success) 07:57:37 INFO - [mozharness: 2017-01-10 15:57:37.727406Z] Running run-tests step. 07:57:37 INFO - Running pre-action listener: _resource_record_pre_action 07:57:37 INFO - Running main action method: run_tests 07:57:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:37 INFO - 2017-01-10 07:57:37.741 screenresolution[1632:7539] starting screenresolution argv=screenresolution get 07:57:37 INFO - 2017-01-10 07:57:37.744 screenresolution[1632:7539] Display 0: 1600x1200x32@60 07:57:37 INFO - 2017-01-10 07:57:37.750 screenresolution[1633:7542] starting screenresolution argv=screenresolution list 07:57:37 INFO - Available Modes on Display 0 07:57:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:37 INFO - Intel Iris: 07:57:37 INFO - Chipset Model: Intel Iris 07:57:37 INFO - Type: GPU 07:57:37 INFO - Bus: Built-In 07:57:37 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:37 INFO - Vendor: Intel (0x8086) 07:57:37 INFO - Device ID: 0x0a2e 07:57:37 INFO - Revision ID: 0x0009 07:57:37 INFO - Displays: 07:57:37 INFO - Display: 07:57:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:37 INFO - Display Serial Number: 1600x1200 60 07:57:37 INFO - Main Display: Yes 07:57:37 INFO - Mirror: Off 07:57:37 INFO - Online: Yes 07:57:37 INFO - Rotation: Supported 07:57:37 INFO - Return code: 0 07:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:37 INFO - Python 2.7.3 07:57:37 INFO - Return code: 0 07:57:37 INFO - grabbing minidump binary from tooltool 07:57: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')]} 07:57:37 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 0x109bccd30>, '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 0x109af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:37 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 07:57:37 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 07:57:37 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 07:57:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:38 INFO - Return code: 0 07:57:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:57:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 07:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --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 07:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZcnFyIlELq/Render', 07:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:38 INFO - 'HOME': '/Users/cltbld', 07:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:38 INFO - 'LOGNAME': 'cltbld', 07:57:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:38 INFO - 'MOZ_NO_REMOTE': '1', 07:57:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:38 INFO - 'NO_EM_RESTART': '1', 07:57:38 INFO - 'PAGER': '/bin/cat', 07:57:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:38 INFO - 'PWD': '/builds/slave/test', 07:57:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:38 INFO - 'SHELL': '/bin/bash', 07:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuossSxI46/Listeners', 07:57:38 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 07:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:38 INFO - 'USER': 'cltbld', 07:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:38 INFO - 'XPC_FLAGS': '0x0', 07:57:38 INFO - 'XPC_SERVICE_NAME': '0', 07:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 07:57:38 INFO - mozversion application_buildid: 20170110064707 07:57:38 INFO - mozversion application_changeset: 2c85b6401be3a9e67e985e62b82b2a8277338880 07:57:38 INFO - mozversion application_display_name: Nightly 07:57:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:38 INFO - mozversion application_name: Firefox 07:57:38 INFO - mozversion application_remotingname: firefox 07:57:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:57:38 INFO - mozversion application_vendor: Mozilla 07:57:38 INFO - mozversion application_version: 53.0a1 07:57:38 INFO - mozversion platform_buildid: 20170110064707 07:57:38 INFO - mozversion platform_changeset: 2c85b6401be3a9e67e985e62b82b2a8277338880 07:57:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:57:38 INFO - mozversion platform_version: 53.0a1 07:57:38 INFO - using testdate: 1484063858 07:57:38 INFO - actual date: 1484063858 07:57:38 INFO - starting webserver on 'localhost:49244' 07:57:38 INFO - SUITE-START | Running 2 tests 07:57:38 INFO - TEST-START | dromaeo_css 07:57:38 INFO - operating with platform_type : mac_ 07:57:38 INFO - Initialising browser for dromaeo_css test... 07:57:38 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmppaMqzD/profile http://localhost:49244/getInfo.html) 07:57:40 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 07:57:40 INFO - PROCESS | 1643 | colorDepth:24 07:57:40 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 07:57:40 INFO - PROCESS | 1643 | __metrics 07:57:40 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:40 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:41 INFO - TEST-INFO | 1643: exit 0 07:57:41 INFO - Browser initialized. 07:57:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:41 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmppaMqzD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:53 INFO - PROCESS | 1645 | RSS: Main: 226529280 07:57:53 INFO - PROCESS | 1645 | 08:00:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:01:00 INFO - PROCESS | 1645 | RSS: Main: 477966336 08:01:00 INFO - PROCESS | 1645 | 08:02:42 INFO - PROCESS | 1645 | ************************* 08:02:42 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 08:02:42 INFO - PROCESS | 1645 | 08:02:42 INFO - PROCESS | 1645 | Full message: ReferenceError: fetch is not defined 08:02:42 INFO - PROCESS | 1645 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:02:42 INFO - PROCESS | 1645 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:02:42 INFO - PROCESS | 1645 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:02:42 INFO - PROCESS | 1645 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:02:42 INFO - PROCESS | 1645 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:02:42 INFO - PROCESS | 1645 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:02:42 INFO - PROCESS | 1645 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:02:42 INFO - PROCESS | 1645 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:02:42 INFO - PROCESS | 1645 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:02:42 INFO - PROCESS | 1645 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:02:42 INFO - PROCESS | 1645 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:02:42 INFO - PROCESS | 1645 | 08:02:42 INFO - PROCESS | 1645 | ************************* 08:04:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:04:04 INFO - PROCESS | 1645 | RSS: Main: 364904448 08:04:04 INFO - PROCESS | 1645 | 08:07:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:07:07 INFO - PROCESS | 1645 | RSS: Main: 346308608 08:07:07 INFO - PROCESS | 1645 | 08:10:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:10:10 INFO - PROCESS | 1645 | RSS: Main: 355037184 08:10:10 INFO - PROCESS | 1645 | 08:13:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:13:14 INFO - PROCESS | 1645 | RSS: Main: 333606912 08:13:14 INFO - PROCESS | 1645 | 08:16:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:16:18 INFO - PROCESS | 1645 | RSS: Main: 378023936 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | __start_tp_report 08:16:18 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 08:16:18 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 08:16:18 INFO - PROCESS | 1645 | |i|pagename|runs| 08:16:18 INFO - PROCESS | 1645 | |0;dojo.html;3278.4262754018046;3304.537364768931;3304.7190988765956;3338.8831390901323;3379.6282408935012;5577.665340079598;5626.971865140668;5631.549476041917;5673.943260567393;5712.628679135859;5648;5669.914951275724;5681.034224181889;5682.772689092431;5683.801066962657;5088.720120393377;5126.948730512703;5139.408967968676;5166.689998600077;5191.974040129813;4391.978040109795;5095.592352611782;5227.712475813829;5237.266782650432;5238.161894096946;5215.765290561933;5222.321098257221;5223.764930578133;5224.138017227172;5225.190095535179;5213.2701421800975;5215.16557350822;5219.660722053054;5223.37319521656;5230.686158830464;5018.397792264952;5145.819896303648;5173.922391164136;5186.481351864821;5189.714565698885;5702;5716.599838011341;5804.100364443518;5820.563457740686;5828.766849326022;6126.23422072241;6248.843778905518;6255.781047663356;6277.7175027123885;6280.748770049193;6176.660283684396;6211.596246243979;6216.595921265103;6222.097795819626;6253.093301471306;5884.970575147183;5885.176075349455;5893.764249430061;5904.586678932519;5937.257842769611;6246.437820596168;6252.781152659635;6268.780592679234;6277.246730392382;6288.968555157195;6018.518518518508;6100.678570187591;6103.67809926802;6144.38556144382;6150.292716337589;6227.875442491125;6285.528585356116;6286.088517164985;6291.496680265568;6306.400891915261;6132.264128304543;6235.3452887446165;6249.437550620375;6271.96864015677;6278.089676996809;6117.045103875247;6173.043178307369;6174.536909731698;6276.592021518587;6281.183446152062;4847.297141914473;4924.803007879645;4926.285688575208;4934.827281045146;4964.1809101498575;4405.933910991338;4412.183746006999;4412.24991751403;4418.403515525427;4435.512093669694;5506.063969125258;5629.043062679354;5635.408282130399;5657.321121465368;5682.857928551819;6180.567360284737;6234.532410069172;6243.282022567372;6245.250569931637;6254.937450625526;5630.943690563124;5664.20701101846;5672.659640421588;5675;5685.488306052475;5399.487048730364;5410.810621628224;5439.755211015514;5455.727213639302;5466.945330546723;5331.4401987790725;6307.5269354798575;6317.936820631735;6318.557700960889;6348.04779283102;6269.62382257066;6309.747610095545;6311.337309582611;6313.779017734358;6323.177986861679;6187.412195841388;6201.565890387629;6251.281102673251;6263.937360626518;6302.747890084345;6189.907151392823;6235.314115447207;6255.874882502416;6257.8748425030335;6265.122882796321;6287.993920972623;6293.937060629518;6304.7162877671535;6309.589876658002;6323.462505687068;5965.492933100735;6063.120847477003;6153.938460615336;6178.165947597017;6185.257769067741;6104.664243466652;6105.786297479567;6109.694515274307;6110.083487476914;6127.325994140552;5970.134330522137;5977.043673012297;5979.252593425822;5983.162357270073;5994.250718660168;6001.099835024781;6073.908891366545;6089.117078023751;6100.762843515285;6127.20346354971;5801.361850196559;5915.497182739516;5947.732352044255;5954.07711804671;5963.13534537481 08:16:18 INFO - PROCESS | 1645 | |1;ext.html;438.3643716610913;477.5033964676736;483.588949393016;495.91321518734225;528.4319356691552;37567;39610.00974975627;40029.39955900664;40046.59953400465;41683;40698.59301406985;40982.795086024606;41055.07339119302;41074.58925410745;41159.58840411595;8427.620757065946;8648.567571621425;9246.722598322061;9442.763930901714;9464.053594640549;10722.356658600509;11047.779044419107;11064.612738554153;11243.044341231005;11285.830712539318;11229.438528073604;11298.830517542243;11309.660710178667;11321;11328.490217940212;11133.053690436323;11189.49647265871;11272.887271127265;11294.60468883585;11299.209055366046;11070.778584428266;11085.612003579916;11087.667369978913;11135.387553684544;11142.944285278603;38209.80895095535;38718.80640596807;39038;39203;39244;3938.991253297378;3998.8800335989677;4049.8380064797375;4181.644560212386;4221.387898754694;29513.409731805245;29537.70462295371;29865.850670746724;30643.233919151975;30872;3148.952765708493;3155.4793459079456;3179.554862319277;3182.3317103408313;3290.8848190313224;513659;521673.57406749984;524908;640048;640569;55016;55727.72136139374;55792.16311755327;55828.44171558314;55855.441445585835;57483.71258143683;57735;57749.845003099705;57831.4216857826;57840;12730.427130778951;14887.47893823711;15141.318640661197;15206.847931520764;15320.846791531942;10708.625198118028;10933.28933619328;10949.616763413242;11638.476268567934;11905.761884762256;16974.236159372856;17212.483625491255;17252;17302.307907683804;17314.480565583053;7629.580373079423;7629.771106866803;7671.043883809592;7671.501352412075;7737.806554836062;673.723773252964;856.3320609924269;862.1206369503197;887.1793590928495;890.3455959869491;29242;29287.707122928925;29696;30146.698533014827;30218.09345719632;1038.408107378802;1045.7385653586603;1066.2163309967168;1087.3041253597703;1160.4719852467108;14564.49024284145;15068.773968390484;15224.238788060553;15537.990030647972;15670.686586268212;543869;544008;545453.5454645482;549777.515573906;551193;47678.76160619244;58377.416225838046;58874;58980;59123;1375.7867530532783;1415.5257988573737;1440.9711805764036;1441.9206943617992;1442.624917521431;27661;28450.57324140181;29154;29280.560791587715;29446;48789;53172;53195.73402132965;53259;53346.19980700215;536968;538611;542737.2863135659;543075.8309002945;546044;31901.36197276088;32726.50910236301;32880.50679239765;34059.65940340664;38061.4290785644;39247.99744948786;41594.37608435936;42351.788241058595;44403.55596443994;44455.77772111119;32625.673743262265;34332.656673432946;35074.947751567495;35542.37949066605;35720.64279357173;33921.49117763285;34223.657763422045;34845.12887177841;35661.28677426489;35850;34051.31897362089;34898.65101348954;34951.980522240265;34992.47511287282;35269.64730352664;30399.696003039688;31143.065708028797;31414.842925785226;31565.368692626478;31745.682543174273;23011;23226.883865580563;23503;23761.52476950486;23784.762152378946 08:16:18 INFO - PROCESS | 1645 | |2;jquery.html;348.17829921385527;384.57888611969884;390.6972096625115;395.4759943075424;405.27455854021304;19601.215951361944;19995.800041999577;21035.68446473304;21085.68371474429;21382.930853457343;11250.2687325324;12386.07104467164;12623.92696620786;20454.931760235973;21678.34964951054;5189.169732842746;5409.756560954766;5413.133898576229;5418.539424148932;5418.783248670048;5638.40796716345;5910.763569457216;5964.761409543613;6040.57715959883;6054.334023257438;5602.187682785993;5913.349531551526;6055.878882422349;6066.39336066392;6067.575269731121;5855.560832937525;5973.313068997078;5977.820665380045;5987.670678112702;6003.519718422515;5611.2144299798065;5772.9711351442975;5818.709064546756;5829.271341082364;5832.037713777222;13379.331033448387;13527.932360338134;13543.525976590772;24723.392979456457;25617.35956601081;2472.221250306148;2509.648649189115;2606.7784238339764;2617;2618.3454136465884;10034.24743144267;10488.842667359995;10700.678979630624;12468.251904885645;14941.70116597662;1808.4574627611664;1865.5988962373156;1869.5045812859603;1870.1771220662865;1872.3259626534436;107821.46089269582;114905.42547287294;127256;133158.99999999904;149243.13623547758;11104.61133860311;11783.941080294544;11855.347955862338;11874.072260012172;12039.040674865997;14806.62983425423;15501.922490387477;15562.688746225012;15589.142597157264;15653.452129175652;8441;8523.147685231428;8547.230749232598;8605.440646357967;8727.650893964297;6726.360995705498;8398.958005210057;8468.957655211685;8610.354223433267;8623;4683.086798074342;4771.5228477152705;4782.37829082224;4853.490383509751;4877.902441951142;1696.7539706742452;2004.168270167893;2014.3956812956055;2027.4120505053663;2029.472337192311;929.762910457829;1011.858339832424;1013.8847268005136;1015.167562598662;1058.1006144776877;19764.40706778799;21324;22013.779862201493;22119.115235390404;22139.446513837283;1033.8707661542308;1037.5382954585289;1049.275999560301;1081.5457507846722;1087.9401632910267;11068.335899846035;11449.599264025886;11452.026577740986;11468.483918223534;11571.6528504145;682051;700862;704168;715785;741273.2936335284;126597;146031;146392.26803866125;161151;165569.88602279592;940.1773448232797;989.9010098990043;1003.3377970539409;1004.5830980143159;1011.9291649584605;19157.61684766325;19749;20094.397168084397;20228.79771202269;20248.79751202528;46747.29879051885;47747.28379074247;48534.75732621314;56608.71695641495;59522.70238648779;84280.57859710662;85771;85810;86315.13684863322;87756.5612171935;8163.387745919199;8224.465409748347;8397.622107005322;8472.57637118154;8502.234798868132;12393.545942280474;12994.220346779224;13504.324783760576;13578.185308881499;13792.793108103186;9094.636214551609;11113.871964855385;11555.768884622428;11632.011279041377;11653.59212427561;11200.663980080612;11401.030912372542;11504.597339093092;11688.94155529217;11761.941190293994;11507.654770356903;11564.479598417924;11770.941145294219;11989.22070065443;12074.39628018578;6720.831979200363;8081.757547273356;8183.877241841258;8389.706360277361;8449.915500844912;5629.0712032514175;8252.546109964009;8412.957935210285;8968.10318968098;11122.499487522919 08:16:18 INFO - PROCESS | 1645 | |3;mootools.html;1327.8472975607808;1458.7301349250383;1465.3039806092108;1487.9181645009523;1488.4120772294943;7406.296401841823;7737.342325902298;7980.840383192332;8192.344612431007;8215.424920255584;8123.634436450359;8181;8209.179082091789;8278.503289802617;8278.668853245863;2182.47620571063;2217.002348942974;2217.9112835486562;2220.9222677206303;2225.6995305633777;2042.6221149087391;2120.5334826338258;2235;2300.5283916797016;2311.699479067719;1889.6409682160415;2230.364346161344;2236.8546044507057;2238.2613737466677;2240.5294888073445;2195.901184446696;2229.398062523118;2257.6726374675745;2300.183434880627;2302.838801283911;1935.796741342167;2268.727752669674;2271.3526644906287;2277.6583512473094;2292.197730794225;8177.713780017731;8225.383096267804;8290.792730181794;8301.086880443147;8301.29438997686;4360.803763830635;4990.82532111378;5140.74296285188;5159.17453207485;5161.896762064775;3089.7837151399413;3298.142482954449;3303.537504749337;3423.9144021399416;3500.8074555899416;1145.6963904565298;1230.809224570193;1242.589945318043;1703.5911381268406;1746.2054765081857;10541.52563134653;10543.683689489328;10655.360678359246;10673.733156671145;10676.252662313564;4170.979145104255;4367.497737760134;4406.383106365111;4430.5126436092005;4441.20058389493;8415.579221038923;8469.915300847037;8479.109693482218;8489.533075680896;8513.276371508367;5033.5469807716745;5038.899222015539;5044.899102017939;5046.369203849519;5049.798008079709;4522.29904364824;4660.324252983299;4732.858014259577;4734.739589322551;4743.739094349775;3534.2578058607464;3591.299696559146;3592.479090531858;3636.909077273089;3656.287024030342;1128.4808987865674;1129.6272230164027;1138.846255755479;1139.1659428320397;1140.703417111557;853.4452605806151;875.1336177184542;883.2977782662798;912.5802131019673;936.8782058332373;5247.422783493813;5259.684418934876;5487.42382049887;5556.91664625031;5588.91616625751;488.65793944239175;523.7486006716797;528.6088294661922;543.5271313956882;563.9605227634027;3304.438245498271;3574.1422058705725;3641.2717456508803;3683.1160521474653;3707.2029513654156;9462.57418416173;9745.707628771148;9847.50762461874;9847.950760246153;9852.064053914866;9431.90568094324;9644.469554174448;9789.657361992297;9816;9831.066048725359;7618.69525218985;7745.8450830983065;7762.844743105219;7770.728024519115;7774.92225077742;5256.4743525648655;5256.947430525645;5294.205869119663;5321.866953326198;5346.331708536433;8961.955190224007;8993.820123597361;9020.368574200005;9036.322275829207;9190.31072669539;9191.816163676824;9250.398724083183;9267.44395336282;9307.441553506811;9332.993406417652;6539.673016349068;6684.966575167093;6686.632235227109;6696.0960270362875;6699.698513566998;7364.631768411665;7614.428917831296;7677.462577619513;7690.769276921701;7703.037120359955;6963.8607227854145;7028.648567571703;7040.542364746275;7048.436125110082;7098.041764361745;6364.4908407326375;6878.828029299308;6951.44388448933;7008.474364422586;7034.5427547209265;6204.627722336674;6367.204099487564;6384.07430922523;6389.48884089281;6394.71223794921;3970.7021973351534;4754.690945088558;4889.657723959289;4922.1140194765285;4932.802687892444;4849.127157111754;4860.489648586848;4983.177775666974;5108.56577190943;5133.486651334986 08:16:18 INFO - PROCESS | 1645 | |4;prototype.html;330.1037682691492;349.8513131918934;351.5219301749621;363.21545461802503;376.38905484526236;4712.693674911128;4726.149293127236;4948.851534453967;5107.693538387699;5291.206319052144;4237.110206856564;4376.212281789277;4788.138135135674;5161.896762064756;5185.318423919012;3555.502229687833;3606.9359538935946;4112.362583799516;4113.25961326961;4114.917701645965;3764.811759412032;3847.865324713636;4037.454943582623;4038.2731108400476;4114.691398145136;3678;4036.656884164835;4038.374052021941;4074.3684728866924;4077.857274995376;3504.526888869995;3572.856685860526;3792.829322680472;4059.549383024435;4079.653229475498;3397.082787647346;3409.232922592422;3479.860805567774;3586.2110335726097;3605.3330133925306;5045.394552653668;5067.290579318898;5087.389513258396;5088;5100.48995100487;4718.41019872516;4736.786844592001;4738.431388233434;4741.881452963704;4750;4236.9364459533135;4561.954380456186;5321.441248668912;5387.811426600089;5462.6449280797015;3358.529805827186;3980.9402858957137;4001.379786133154;4002.378442120416;4006.2988976928923;4524.660650451229;5649;5659.066254068115;5775.5849816794735;5780.942190578125;3591.712662986955;3680.895801181663;3923.6076392361106;4064.8577299794365;4072.511298644182;3573.26748016656;3639.8170594556345;4119.6910231732145;4155.958440415558;4162.979185104055;3565.3404120237838;4695.483496815347;4719.4100737407825;4733.786979585927;4752.619790416758;5248.396434410091;5346.091164502044;5585.357683866408;5587.072460001293;5606.523445507178;1181.722295260613;1257.8679238679806;1263.7219811641423;1266.1959655618748;1273.6433798536425;720.1358369956074;809.8258874342044;855.2772906893665;864.7103220421103;873.4279047224078;4437.378766972626;4439.4228750262255;4787.928181077286;4936.48166942473;4960.776765045582;5464.754086066137;5476.398710612427;5484.230463615849;5498.697571633518;5537.861553461195;4553.089382123522;4767.523247675274;4925.4335751388335;4945.406551213805;4956.776945037482;2385.6898603181476;2506.922023529863;2573.1823653099827;2883.596296518489;2918.5184444566835;4879.975600122048;5633.352164501053;5679.488846003879;5717.313922329264;5718.4567466091485;4896.902061958741;4901.607871370282;5413.320406398858;5668.489835914705;5674.631148975303;4853.563179313879;4965.031818795373;5013.874653133701;5079.74601269935;5670.285962694442;5023.196288593807;5190.8183213587345;5385;5445.413428621373;5465.480779325958;4682.391289132391;5368.00691872005;5372.865678358073;5382.465997190782;5383.973080134574;4179.644730197846;4949.505049495166;5603.187537807076;5669.858253543694;5733.885322293448;3287.1289108385818;3516.331896939573;3768.736188466781;3812.0279328770985;3822.6177382262663;4928.383952005999;5219.9217011744095;5406.378266499403;5443.292371991616;5644.915326270191;4759.690620109682;5193;5448.782048718007;5518.16487541155;5614.85962850932;4669.39297891272;4825.445073816416;5414.729263536886;5540.340636494425;5575.637583557056;5226.626776364997;5362.249285100011;5436.320459942507;5462.088269105781;5493.560515158698;4720.12677654635;5142.714321419645;5407.945920540744;5503.009458297545;5504.366997795305;4888.804447822047;5141.357330333708;5232.613357460352;5374.596905232202;5502.422245664307 08:16:18 INFO - PROCESS | 1645 | |5;yui.html;696.470682281466;712.8431745016095;721.4228617106313;785.2226295966991;839.4585492357431;11575.42122893855;15026.924865375686;15070.698586028273;15074.170920599363;15086.170260635661;14514.637134071654;14609.561713148596;14687;14690.118592884435;14695.559133226021;668.9498287628423;690.8721886450998;820.1552401026952;827.4084029918607;846.2341580869293;848.7623465429658;852.7825404521839;853.185208126238;856.400519636254;860.4450129666361;904.669795524632;910.3172620534599;913.1005959130251;913.5432283858071;916.6516723645038;904.4256896870469;904.6019751309468;905.9682911098146;906.5603182456537;907.5689047702322;528.6114705691352;541.7101850509958;542.4412854759564;543.562432242045;547.7781498493117;14447;14984.550463486114;15048.924755376263;15414.22928853553;15466.690666186612;14462;14517.637059073502;14534.909881758911;14610.853891461056;14695.926520367437;10279.845802312897;11423.828642570368;11825.822612660817;11892.405379730979;12101.152919295564;3608.585012723544;3772.8113594320175;3790.6777923876502;3861.4014827701753;3866.709996750255;110938;116006.49768717951;117031.4148429261;117946.41026794897;119318.4034079824;10214.438205898747;10869.29349592274;11051.778964420666;11310.321380717183;11399.202055856176;23544.882275588854;23551.41121471977;23552.7644723554;23560.528789424116;23566.175183868483;7687.077550693953;7786;7793.220677932275;7879.487833290817;8005.879911801328;4286.7856607169515;4312.89217769552;4366.541513141138;4390.319500477431;4489.618382437464;3558.733095017884;3653.9817300913323;3660.816959152032;3665.486831843544;3667.431548110047;620.8447888027993;624.1418050181001;634.1597383466925;640.0591131037368;647.799182253503;624.865868448764;669.3206395508563;680.4352387518348;697.3932678569677;710.5807573531641;8473.067962524117;8646.43798153118;8906.73279801607;9213.90786092144;10416.479176041168;661.454300202335;667.8263651450658;686.629220221075;706.2132804005771;717.7631381644045;4777.307290442866;4946.431160416526;4953.925691114636;4959.792892162953;4975.601951843843;84410.15589844146;100031.49984250033;104092.47953760183;104585;105374.4193837093;90522.54738726265;92687.5365623181;93969.5301523488;94270;96640.06719865563;61047.694761525905;78095.21904780994;78127.60936195283;78929.21070789218;80897.59551202324;9609.759756006155;9654.951725241328;9691.273154513581;9753.561089750836;9844.310898237054;48610.29863954744;53482.93034139373;53700.73149634227;54383.72808135934;55040.72479637576;63287.05069424054;70218.94671579829;71241.28758712554;72401;74450.62774686092;12862.549810756578;13332.466701331838;13372.531961381304;13597;13781.51764688231;13799.655008624864;14918.925405372904;15578.22108894528;15581.98717083386;15703;13656;13953.372098255806;14058.01593888459;14062.015658903778;14265.71468570602;12506.937465312616;13030.41363138642;13384.732305354033;13474.258915759727;14244.216568088854;13380.735296320647;13438.798418023933;13454.192748435125;13712.588622340947;14160.008799383944;10574.365538067741;11031.338119712522;11092.057175140204;11169.441527923409;11898.940505297418;9267.304952128483;9368.718938431857;9529.380590261611;9675.70972870815;9684.854727178958 08:16:18 INFO - PROCESS | 1645 | __end_tp_report 08:16:18 INFO - PROCESS | 1645 | __start_cc_report 08:16:18 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2950 08:16:18 INFO - PROCESS | 1645 | __end_cc_report 08:16:18 INFO - PROCESS | 1645 | __startTimestamp1484064978020__endTimestamp 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | ------- Summary: start ------- 08:16:18 INFO - PROCESS | 1645 | Number of tests: 6 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5737.14 Median:5970.13 stddev:656.28 (11.0%) stddev-sans-first:629.31 08:16:18 INFO - PROCESS | 1645 | Values: 3278.4 3304.5 3304.7 3338.9 3379.6 5577.7 5627.0 5631.5 5673.9 5712.6 5648.0 5669.9 5681.0 5682.8 5683.8 5088.7 5126.9 5139.4 5166.7 5192.0 4392.0 5095.6 5227.7 5237.3 5238.2 5215.8 5222.3 5223.8 5224.1 5225.2 5213.3 5215.2 5219.7 5223.4 5230.7 5018.4 5145.8 5173.9 5186.5 5189.7 5702.0 5716.6 5804.1 5820.6 5828.8 6126.2 6248.8 6255.8 6277.7 6280.7 6176.7 6211.6 6216.6 6222.1 6253.1 5885.0 5885.2 5893.8 5904.6 5937.3 6246.4 6252.8 6268.8 6277.2 6289.0 6018.5 6100.7 6103.7 6144.4 6150.3 6227.9 6285.5 6286.1 6291.5 6306.4 6132.3 6235.3 6249.4 6272.0 6278.1 6117.0 6173.0 6174.5 6276.6 6281.2 4847.3 4924.8 4926.3 4934.8 4964.2 4405.9 4412.2 4412.2 4418.4 4435.5 5506.1 5629.0 5635.4 5657.3 5682.9 6180.6 6234.5 6243.3 6245.3 6254.9 5630.9 5664.2 5672.7 5675.0 5685.5 5399.5 5410.8 5439.8 5455.7 5466.9 5331.4 6307.5 6317.9 6318.6 6348.0 6269.6 6309.7 6311.3 6313.8 6323.2 6187.4 6201.6 6251.3 6263.9 6302.7 6189.9 6235.3 6255.9 6257.9 6265.1 6288.0 6293.9 6304.7 6309.6 6323.5 5965.5 6063.1 6153.9 6178.2 6185.3 6104.7 6105.8 6109.7 6110.1 6127.3 5970.1 5977.0 5979.3 5983.2 5994.3 6001.1 6073.9 6089.1 6100.8 6127.2 5801.4 5915.5 5947.7 5954.1 5963.1 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:68149.55 Median:34925.32 stddev:147686.42 (422.9%) stddev-sans-first:148013.22 08:16:18 INFO - PROCESS | 1645 | Values: 438.4 477.5 483.6 495.9 528.4 37567.0 39610.0 40029.4 40046.6 41683.0 40698.6 40982.8 41055.1 41074.6 41159.6 8427.6 8648.6 9246.7 9442.8 9464.1 10722.4 11047.8 11064.6 11243.0 11285.8 11229.4 11298.8 11309.7 11321.0 11328.5 11133.1 11189.5 11272.9 11294.6 11299.2 11070.8 11085.6 11087.7 11135.4 11142.9 38209.8 38718.8 39038.0 39203.0 39244.0 3939.0 3998.9 4049.8 4181.6 4221.4 29513.4 29537.7 29865.9 30643.2 30872.0 3149.0 3155.5 3179.6 3182.3 3290.9 513659.0 521673.6 524908.0 640048.0 640569.0 55016.0 55727.7 55792.2 55828.4 55855.4 57483.7 57735.0 57749.8 57831.4 57840.0 12730.4 14887.5 15141.3 15206.8 15320.8 10708.6 10933.3 10949.6 11638.5 11905.8 16974.2 17212.5 17252.0 17302.3 17314.5 7629.6 7629.8 7671.0 7671.5 7737.8 673.7 856.3 862.1 887.2 890.3 29242.0 29287.7 29696.0 30146.7 30218.1 1038.4 1045.7 1066.2 1087.3 1160.5 14564.5 15068.8 15224.2 15538.0 15670.7 543869.0 544008.0 545453.5 549777.5 551193.0 47678.8 58377.4 58874.0 58980.0 59123.0 1375.8 1415.5 1441.0 1441.9 1442.6 27661.0 28450.6 29154.0 29280.6 29446.0 48789.0 53172.0 53195.7 53259.0 53346.2 536968.0 538611.0 542737.3 543075.8 546044.0 31901.4 32726.5 32880.5 34059.7 38061.4 39248.0 41594.4 42351.8 44403.6 44455.8 32625.7 34332.7 35074.9 35542.4 35720.6 33921.5 34223.7 34845.1 35661.3 35850.0 34051.3 34898.7 34952.0 34992.5 35269.6 30399.7 31143.1 31414.8 31565.4 31745.7 23011.0 23226.9 23503.0 23761.5 23784.8 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:38917.72 Median:21530.64 stddev:118265.48 (549.3%) stddev-sans-first:118561.79 08:16:18 INFO - PROCESS | 1645 | Values: 348.2 384.6 390.7 395.5 405.3 19601.2 19995.8 21035.7 21085.7 21382.9 11250.3 12386.1 12623.9 20454.9 21678.3 5189.2 5409.8 5413.1 5418.5 5418.8 5638.4 5910.8 5964.8 6040.6 6054.3 5602.2 5913.3 6055.9 6066.4 6067.6 5855.6 5973.3 5977.8 5987.7 6003.5 5611.2 5773.0 5818.7 5829.3 5832.0 13379.3 13527.9 13543.5 24723.4 25617.4 2472.2 2509.6 2606.8 2617.0 2618.3 10034.2 10488.8 10700.7 12468.3 14941.7 1808.5 1865.6 1869.5 1870.2 1872.3 107821.5 114905.4 127256.0 133159.0 149243.1 11104.6 11783.9 11855.3 11874.1 12039.0 14806.6 15501.9 15562.7 15589.1 15653.5 8441.0 8523.1 8547.2 8605.4 8727.7 6726.4 8399.0 8469.0 8610.4 8623.0 4683.1 4771.5 4782.4 4853.5 4877.9 1696.8 2004.2 2014.4 2027.4 2029.5 929.8 1011.9 1013.9 1015.2 1058.1 19764.4 21324.0 22013.8 22119.1 22139.4 1033.9 1037.5 1049.3 1081.5 1087.9 11068.3 11449.6 11452.0 11468.5 11571.7 682051.0 700862.0 704168.0 715785.0 741273.3 126597.0 146031.0 146392.3 161151.0 165569.9 940.2 989.9 1003.3 1004.6 1011.9 19157.6 19749.0 20094.4 20228.8 20248.8 46747.3 47747.3 48534.8 56608.7 59522.7 84280.6 85771.0 85810.0 86315.1 87756.6 8163.4 8224.5 8397.6 8472.6 8502.2 12393.5 12994.2 13504.3 13578.2 13792.8 9094.6 11113.9 11555.8 11632.0 11653.6 11200.7 11401.0 11504.6 11688.9 11761.9 11507.7 11564.5 11770.9 11989.2 12074.4 6720.8 8081.8 8183.9 8389.7 8449.9 5629.1 8252.5 8413.0 8968.1 11122.5 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5274.94 Median:2842.82 stddev:2897.46 (101.9%) stddev-sans-first:2890.40 08:16:18 INFO - PROCESS | 1645 | Values: 1327.8 1458.7 1465.3 1487.9 1488.4 7406.3 7737.3 7980.8 8192.3 8215.4 8123.6 8181.0 8209.2 8278.5 8278.7 2182.5 2217.0 2217.9 2220.9 2225.7 2042.6 2120.5 2235.0 2300.5 2311.7 1889.6 2230.4 2236.9 2238.3 2240.5 2195.9 2229.4 2257.7 2300.2 2302.8 1935.8 2268.7 2271.4 2277.7 2292.2 8177.7 8225.4 8290.8 8301.1 8301.3 4360.8 4990.8 5140.7 5159.2 5161.9 3089.8 3298.1 3303.5 3423.9 3500.8 1145.7 1230.8 1242.6 1703.6 1746.2 10541.5 10543.7 10655.4 10673.7 10676.3 4171.0 4367.5 4406.4 4430.5 4441.2 8415.6 8469.9 8479.1 8489.5 8513.3 5033.5 5038.9 5044.9 5046.4 5049.8 4522.3 4660.3 4732.9 4734.7 4743.7 3534.3 3591.3 3592.5 3636.9 3656.3 1128.5 1129.6 1138.8 1139.2 1140.7 853.4 875.1 883.3 912.6 936.9 5247.4 5259.7 5487.4 5556.9 5588.9 488.7 523.7 528.6 543.5 564.0 3304.4 3574.1 3641.3 3683.1 3707.2 9462.6 9745.7 9847.5 9848.0 9852.1 9431.9 9644.5 9789.7 9816.0 9831.1 7618.7 7745.8 7762.8 7770.7 7774.9 5256.5 5256.9 5294.2 5321.9 5346.3 8962.0 8993.8 9020.4 9036.3 9190.3 9191.8 9250.4 9267.4 9307.4 9333.0 6539.7 6685.0 6686.6 6696.1 6699.7 7364.6 7614.4 7677.5 7690.8 7703.0 6963.9 7028.6 7040.5 7048.4 7098.0 6364.5 6878.8 6951.4 7008.5 7034.5 6204.6 6367.2 6384.1 6389.5 6394.7 3970.7 4754.7 4889.7 4922.1 4932.8 4849.1 4860.5 4983.2 5108.6 5133.5 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4387.95 Median:4884.39 stddev:1322.80 (27.1%) stddev-sans-first:1290.97 08:16:18 INFO - PROCESS | 1645 | Values: 330.1 349.9 351.5 363.2 376.4 4712.7 4726.1 4948.9 5107.7 5291.2 4237.1 4376.2 4788.1 5161.9 5185.3 3555.5 3606.9 4112.4 4113.3 4114.9 3764.8 3847.9 4037.5 4038.3 4114.7 3678.0 4036.7 4038.4 4074.4 4077.9 3504.5 3572.9 3792.8 4059.5 4079.7 3397.1 3409.2 3479.9 3586.2 3605.3 5045.4 5067.3 5087.4 5088.0 5100.5 4718.4 4736.8 4738.4 4741.9 4750.0 4236.9 4562.0 5321.4 5387.8 5462.6 3358.5 3980.9 4001.4 4002.4 4006.3 4524.7 5649.0 5659.1 5775.6 5780.9 3591.7 3680.9 3923.6 4064.9 4072.5 3573.3 3639.8 4119.7 4156.0 4163.0 3565.3 4695.5 4719.4 4733.8 4752.6 5248.4 5346.1 5585.4 5587.1 5606.5 1181.7 1257.9 1263.7 1266.2 1273.6 720.1 809.8 855.3 864.7 873.4 4437.4 4439.4 4787.9 4936.5 4960.8 5464.8 5476.4 5484.2 5498.7 5537.9 4553.1 4767.5 4925.4 4945.4 4956.8 2385.7 2506.9 2573.2 2883.6 2918.5 4880.0 5633.4 5679.5 5717.3 5718.5 4896.9 4901.6 5413.3 5668.5 5674.6 4853.6 4965.0 5013.9 5079.7 5670.3 5023.2 5190.8 5385.0 5445.4 5465.5 4682.4 5368.0 5372.9 5382.5 5384.0 4179.6 4949.5 5603.2 5669.9 5733.9 3287.1 3516.3 3768.7 3812.0 3822.6 4928.4 5219.9 5406.4 5443.3 5644.9 4759.7 5193.0 5448.8 5518.2 5614.9 4669.4 4825.4 5414.7 5540.3 5575.6 5226.6 5362.2 5436.3 5462.1 5493.6 4720.1 5142.7 5407.9 5503.0 5504.4 4888.8 5141.4 5232.6 5374.6 5502.4 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20923.82 Median:26693.80 stddev:30461.36 (114.1%) stddev-sans-first:30508.95 08:16:18 INFO - PROCESS | 1645 | Values: 696.5 712.8 721.4 785.2 839.5 11575.4 15026.9 15070.7 15074.2 15086.2 14514.6 14609.6 14687.0 14690.1 14695.6 668.9 690.9 820.2 827.4 846.2 848.8 852.8 853.2 856.4 860.4 904.7 910.3 913.1 913.5 916.7 904.4 904.6 906.0 906.6 907.6 528.6 541.7 542.4 543.6 547.8 14447.0 14984.6 15048.9 15414.2 15466.7 14462.0 14517.6 14534.9 14610.9 14695.9 10279.8 11423.8 11825.8 11892.4 12101.2 3608.6 3772.8 3790.7 3861.4 3866.7 110938.0 116006.5 117031.4 117946.4 119318.4 10214.4 10869.3 11051.8 11310.3 11399.2 23544.9 23551.4 23552.8 23560.5 23566.2 7687.1 7786.0 7793.2 7879.5 8005.9 4286.8 4312.9 4366.5 4390.3 4489.6 3558.7 3654.0 3660.8 3665.5 3667.4 620.8 624.1 634.2 640.1 647.8 624.9 669.3 680.4 697.4 710.6 8473.1 8646.4 8906.7 9213.9 10416.5 661.5 667.8 686.6 706.2 717.8 4777.3 4946.4 4953.9 4959.8 4975.6 84410.2 100031.5 104092.5 104585.0 105374.4 90522.5 92687.5 93969.5 94270.0 96640.1 61047.7 78095.2 78127.6 78929.2 80897.6 9609.8 9655.0 9691.3 9753.6 9844.3 48610.3 53482.9 53700.7 54383.7 55040.7 63287.1 70218.9 71241.3 72401.0 74450.6 12862.5 13332.5 13372.5 13597.0 13781.5 13799.7 14918.9 15578.2 15582.0 15703.0 13656.0 13953.4 14058.0 14062.0 14265.7 12506.9 13030.4 13384.7 13474.3 14244.2 13380.7 13438.8 13454.2 13712.6 14160.0 10574.4 11031.3 11092.1 11169.4 11898.9 9267.3 9368.7 9529.4 9675.7 9684.9 08:16:18 INFO - PROCESS | 1645 | -------- Summary: end -------- 08:16:18 INFO - PROCESS | 1645 | 08:16:18 INFO - TEST-INFO | 1645: exit 0 08:16:18 INFO - TEST-OK | dromaeo_css | took 1120348ms 08:16:18 INFO - TEST-START | kraken 08:16:18 INFO - operating with platform_type : mac_ 08:16:18 INFO - Initialising browser for kraken test... 08:16:18 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpjqv1R5/profile http://localhost:49244/getInfo.html) 08:16:20 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:16:20 INFO - PROCESS | 1652 | colorDepth:24 08:16:20 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:16:20 INFO - PROCESS | 1652 | __metrics 08:16:21 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:21 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:21 INFO - TEST-INFO | 1652: exit 0 08:16:21 INFO - Browser initialized. 08:16:21 INFO - Running cycle 1/1 for kraken test... 08:16:21 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpjqv1R5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:33 INFO - PROCESS | 1653 | RSS: Main: 234123264 08:16:33 INFO - PROCESS | 1653 | 08:16:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:37 INFO - PROCESS | 1653 | RSS: Main: 287567872 08:16:37 INFO - PROCESS | 1653 | 08:16:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:16:40 INFO - PROCESS | 1653 | RSS: Main: 288559104 08:16:40 INFO - PROCESS | 1653 | 08:16:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:16:44 INFO - PROCESS | 1653 | RSS: Main: 378605568 08:16:44 INFO - PROCESS | 1653 | 08:16:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:16:47 INFO - PROCESS | 1653 | RSS: Main: 281698304 08:16:47 INFO - PROCESS | 1653 | 08:16:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:49 INFO - PROCESS | 1653 | RSS: Main: 287010816 08:16:49 INFO - PROCESS | 1653 | 08:16:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:53 INFO - PROCESS | 1653 | RSS: Main: 328323072 08:16:53 INFO - PROCESS | 1653 | 08:16:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:57 INFO - PROCESS | 1653 | RSS: Main: 329162752 08:16:57 INFO - PROCESS | 1653 | 08:16:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:17:00 INFO - PROCESS | 1653 | RSS: Main: 327983104 08:17:00 INFO - PROCESS | 1653 | 08:17:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:17:02 INFO - PROCESS | 1653 | RSS: Main: 303435776 08:17:02 INFO - PROCESS | 1653 | 08:17:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:17:05 INFO - PROCESS | 1653 | RSS: Main: 307150848 08:17:05 INFO - PROCESS | 1653 | 08:17:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:08 INFO - PROCESS | 1653 | RSS: Main: 308412416 08:17:08 INFO - PROCESS | 1653 | 08:17:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:11 INFO - PROCESS | 1653 | RSS: Main: 324108288 08:17:11 INFO - PROCESS | 1653 | 08:17:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:15 INFO - PROCESS | 1653 | RSS: Main: 318070784 08:17:15 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:17:17 INFO - PROCESS | 1653 | RSS: Main: 362115072 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | __start_tp_report 08:17:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:17:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:17:17 INFO - PROCESS | 1653 | |i|pagename|runs| 08:17:17 INFO - PROCESS | 1653 | |0;ai-astar;114;115;115;114;115;115;114;116;113;114 08:17:17 INFO - PROCESS | 1653 | |1;audio-beat-detection;137;108;108;143;111;109;111;107;128;107 08:17:17 INFO - PROCESS | 1653 | |2;audio-dft;185;182;181;184;182;183;180;181;183;183 08:17:17 INFO - PROCESS | 1653 | |3;audio-fft;79;57;58;88;76;65;59;58;74;58 08:17:17 INFO - PROCESS | 1653 | |4;audio-oscillator;91;70;86;70;74;92;116;100;85;83 08:17:17 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;85;87;87;87;84;88;85;95;130 08:17:17 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;94;107;149;120;94;141;139;95 08:17:17 INFO - PROCESS | 1653 | |7;imaging-desaturate;87;85;88;88;87;88;85;88;90;87 08:17:17 INFO - PROCESS | 1653 | |8;json-parse-financial;58;57;55;55;56;56;55;56;56;56 08:17:17 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;66;66;70;79;81;74;69;71;71;72 08:17:17 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;87;87;88;87;87;86;89;90;91;85 08:17:17 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;155;140;136;138;137;140;138;139;206;177 08:17:17 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;172;171;173;171;172;171;170;175;172;169 08:17:17 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;78;87;87;87;66;69;66;65;67 08:17:17 INFO - PROCESS | 1653 | __end_tp_report 08:17:17 INFO - PROCESS | 1653 | __start_cc_report 08:17:17 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1991 08:17:17 INFO - PROCESS | 1653 | __end_cc_report 08:17:17 INFO - PROCESS | 1653 | __startTimestamp1484065037355__endTimestamp 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:17:17 INFO - PROCESS | 1653 | Number of tests: 14 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 08:17:17 INFO - PROCESS | 1653 | Values: 114.0 115.0 115.0 114.0 115.0 115.0 114.0 116.0 113.0 114.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:111.00 stddev:13.72 (12.4%) stddev-sans-first:12.48 08:17:17 INFO - PROCESS | 1653 | Values: 137.0 108.0 108.0 143.0 111.0 109.0 111.0 107.0 128.0 107.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.51 (0.8%) stddev-sans-first:1.27 08:17:17 INFO - PROCESS | 1653 | Values: 185.0 182.0 181.0 184.0 182.0 183.0 180.0 181.0 183.0 183.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:67.20 Median:69.50 stddev:11.18 (16.1%) stddev-sans-first:11.02 08:17:17 INFO - PROCESS | 1653 | Values: 79.0 57.0 58.0 88.0 76.0 65.0 59.0 58.0 74.0 58.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:84.00 stddev:14.21 (16.9%) stddev-sans-first:14.99 08:17:17 INFO - PROCESS | 1653 | Values: 91.0 70.0 86.0 70.0 74.0 92.0 116.0 100.0 85.0 83.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:87.00 stddev:13.83 (15.9%) stddev-sans-first:14.60 08:17:17 INFO - PROCESS | 1653 | Values: 88.0 85.0 87.0 87.0 87.0 84.0 88.0 85.0 95.0 130.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:94.00 stddev:22.63 (24.1%) stddev-sans-first:22.97 08:17:17 INFO - PROCESS | 1653 | Values: 94.0 94.0 94.0 107.0 149.0 120.0 94.0 141.0 139.0 95.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:88.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 08:17:17 INFO - PROCESS | 1653 | Values: 87.0 85.0 88.0 88.0 87.0 88.0 85.0 88.0 90.0 87.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:0.67 08:17:17 INFO - PROCESS | 1653 | Values: 58.0 57.0 55.0 55.0 56.0 56.0 55.0 56.0 56.0 56.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.50 stddev:4.95 (6.9%) stddev-sans-first:4.77 08:17:17 INFO - PROCESS | 1653 | Values: 66.0 66.0 70.0 79.0 81.0 74.0 69.0 71.0 71.0 72.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:1.83 (2.1%) stddev-sans-first:1.92 08:17:17 INFO - PROCESS | 1653 | Values: 87.0 87.0 88.0 87.0 87.0 86.0 89.0 90.0 91.0 85.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:140.00 stddev:23.24 (16.6%) stddev-sans-first:24.59 08:17:17 INFO - PROCESS | 1653 | Values: 155.0 140.0 136.0 138.0 137.0 140.0 138.0 139.0 206.0 177.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 08:17:17 INFO - PROCESS | 1653 | Values: 172.0 171.0 173.0 171.0 172.0 171.0 170.0 175.0 172.0 169.0 08:17:17 INFO - PROCESS | 1653 | 08:17:17 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:73.50 stddev:9.83 (13.4%) stddev-sans-first:10.01 08:17:17 INFO - PROCESS | 1653 | Values: 66.0 78.0 87.0 87.0 87.0 66.0 69.0 66.0 65.0 67.0 08:17:17 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:17:17 INFO - PROCESS | 1653 | 08:17:18 INFO - TEST-INFO | 1653: exit 0 08:17:18 INFO - TEST-OK | kraken | took 59593ms 08:17:18 INFO - SUITE-END | took 1179s 08:17:18 INFO - Completed test suite (00:19:40) 08:17:18 INFO - javascript benchmark 08:17:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.4262754018046, 3304.537364768931, 3304.7190988765956, 3338.8831390901323, 3379.6282408935012, 5577.665340079598, 5626.971865140668, 5631.549476041917, 5673.943260567393, 5712.628679135859, 5648.0, 5669.914951275724, 5681.034224181889, 5682.772689092431, 5683.801066962657, 5088.720120393377, 5126.948730512703, 5139.408967968676, 5166.689998600077, 5191.974040129813, 4391.978040109795, 5095.592352611782, 5227.712475813829, 5237.266782650432, 5238.161894096946, 5215.765290561933, 5222.321098257221, 5223.764930578133, 5224.138017227172, 5225.190095535179, 5213.2701421800975, 5215.16557350822, 5219.660722053054, 5223.37319521656, 5230.686158830464, 5018.397792264952, 5145.819896303648, 5173.922391164136, 5186.481351864821, 5189.714565698885, 5702.0, 5716.599838011341, 5804.100364443518, 5820.563457740686, 5828.766849326022, 6126.23422072241, 6248.843778905518, 6255.781047663356, 6277.7175027123885, 6280.748770049193, 6176.660283684396, 6211.596246243979, 6216.595921265103, 6222.097795819626, 6253.093301471306, 5884.970575147183, 5885.176075349455, 5893.764249430061, 5904.586678932519, 5937.257842769611, 6246.437820596168, 6252.781152659635, 6268.780592679234, 6277.246730392382, 6288.968555157195, 6018.518518518508, 6100.678570187591, 6103.67809926802, 6144.38556144382, 6150.292716337589, 6227.875442491125, 6285.528585356116, 6286.088517164985, 6291.496680265568, 6306.400891915261, 6132.264128304543, 6235.3452887446165, 6249.437550620375, 6271.96864015677, 6278.089676996809, 6117.045103875247, 6173.043178307369, 6174.536909731698, 6276.592021518587, 6281.183446152062, 4847.297141914473, 4924.803007879645, 4926.285688575208, 4934.827281045146, 4964.1809101498575, 4405.933910991338, 4412.183746006999, 4412.24991751403, 4418.403515525427, 4435.512093669694, 5506.063969125258, 5629.043062679354, 5635.408282130399, 5657.321121465368, 5682.857928551819, 6180.567360284737, 6234.532410069172, 6243.282022567372, 6245.250569931637, 6254.937450625526, 5630.943690563124, 5664.20701101846, 5672.659640421588, 5675.0, 5685.488306052475, 5399.487048730364, 5410.810621628224, 5439.755211015514, 5455.727213639302, 5466.945330546723, 5331.4401987790725, 6307.5269354798575, 6317.936820631735, 6318.557700960889, 6348.04779283102, 6269.62382257066, 6309.747610095545, 6311.337309582611, 6313.779017734358, 6323.177986861679, 6187.412195841388, 6201.565890387629, 6251.281102673251, 6263.937360626518, 6302.747890084345, 6189.907151392823, 6235.314115447207, 6255.874882502416, 6257.8748425030335, 6265.122882796321, 6287.993920972623, 6293.937060629518, 6304.7162877671535, 6309.589876658002, 6323.462505687068, 5965.492933100735, 6063.120847477003, 6153.938460615336, 6178.165947597017, 6185.257769067741, 6104.664243466652, 6105.786297479567, 6109.694515274307, 6110.083487476914, 6127.325994140552, 5970.134330522137, 5977.043673012297, 5979.252593425822, 5983.162357270073, 5994.250718660168, 6001.099835024781, 6073.908891366545, 6089.117078023751, 6100.762843515285, 6127.20346354971, 5801.361850196559, 5915.497182739516, 5947.732352044255, 5954.07711804671, 5963.13534537481], "value": 5693.538693568159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.3643716610913, 477.5033964676736, 483.588949393016, 495.91321518734225, 528.4319356691552, 37567.0, 39610.00974975627, 40029.39955900664, 40046.59953400465, 41683.0, 40698.59301406985, 40982.795086024606, 41055.07339119302, 41074.58925410745, 41159.58840411595, 8427.620757065946, 8648.567571621425, 9246.722598322061, 9442.763930901714, 9464.053594640549, 10722.356658600509, 11047.779044419107, 11064.612738554153, 11243.044341231005, 11285.830712539318, 11229.438528073604, 11298.830517542243, 11309.660710178667, 11321.0, 11328.490217940212, 11133.053690436323, 11189.49647265871, 11272.887271127265, 11294.60468883585, 11299.209055366046, 11070.778584428266, 11085.612003579916, 11087.667369978913, 11135.387553684544, 11142.944285278603, 38209.80895095535, 38718.80640596807, 39038.0, 39203.0, 39244.0, 3938.991253297378, 3998.8800335989677, 4049.8380064797375, 4181.644560212386, 4221.387898754694, 29513.409731805245, 29537.70462295371, 29865.850670746724, 30643.233919151975, 30872.0, 3148.952765708493, 3155.4793459079456, 3179.554862319277, 3182.3317103408313, 3290.8848190313224, 513659.0, 521673.57406749984, 524908.0, 640048.0, 640569.0, 55016.0, 55727.72136139374, 55792.16311755327, 55828.44171558314, 55855.441445585835, 57483.71258143683, 57735.0, 57749.845003099705, 57831.4216857826, 57840.0, 12730.427130778951, 14887.47893823711, 15141.318640661197, 15206.847931520764, 15320.846791531942, 10708.625198118028, 10933.28933619328, 10949.616763413242, 11638.476268567934, 11905.761884762256, 16974.236159372856, 17212.483625491255, 17252.0, 17302.307907683804, 17314.480565583053, 7629.580373079423, 7629.771106866803, 7671.043883809592, 7671.501352412075, 7737.806554836062, 673.723773252964, 856.3320609924269, 862.1206369503197, 887.1793590928495, 890.3455959869491, 29242.0, 29287.707122928925, 29696.0, 30146.698533014827, 30218.09345719632, 1038.408107378802, 1045.7385653586603, 1066.2163309967168, 1087.3041253597703, 1160.4719852467108, 14564.49024284145, 15068.773968390484, 15224.238788060553, 15537.990030647972, 15670.686586268212, 543869.0, 544008.0, 545453.5454645482, 549777.515573906, 551193.0, 47678.76160619244, 58377.416225838046, 58874.0, 58980.0, 59123.0, 1375.7867530532783, 1415.5257988573737, 1440.9711805764036, 1441.9206943617992, 1442.624917521431, 27661.0, 28450.57324140181, 29154.0, 29280.560791587715, 29446.0, 48789.0, 53172.0, 53195.73402132965, 53259.0, 53346.19980700215, 536968.0, 538611.0, 542737.2863135659, 543075.8309002945, 546044.0, 31901.36197276088, 32726.50910236301, 32880.50679239765, 34059.65940340664, 38061.4290785644, 39247.99744948786, 41594.37608435936, 42351.788241058595, 44403.55596443994, 44455.77772111119, 32625.673743262265, 34332.656673432946, 35074.947751567495, 35542.37949066605, 35720.64279357173, 33921.49117763285, 34223.657763422045, 34845.12887177841, 35661.28677426489, 35850.0, 34051.31897362089, 34898.65101348954, 34951.980522240265, 34992.47511287282, 35269.64730352664, 30399.696003039688, 31143.065708028797, 31414.842925785226, 31565.368692626478, 31745.682543174273, 23011.0, 23226.883865580563, 23503.0, 23761.52476950486, 23784.762152378946], "value": 19754.691737008638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.17829921385527, 384.57888611969884, 390.6972096625115, 395.4759943075424, 405.27455854021304, 19601.215951361944, 19995.800041999577, 21035.68446473304, 21085.68371474429, 21382.930853457343, 11250.2687325324, 12386.07104467164, 12623.92696620786, 20454.931760235973, 21678.34964951054, 5189.169732842746, 5409.756560954766, 5413.133898576229, 5418.539424148932, 5418.783248670048, 5638.40796716345, 5910.763569457216, 5964.761409543613, 6040.57715959883, 6054.334023257438, 5602.187682785993, 5913.349531551526, 6055.878882422349, 6066.39336066392, 6067.575269731121, 5855.560832937525, 5973.313068997078, 5977.820665380045, 5987.670678112702, 6003.519718422515, 5611.2144299798065, 5772.9711351442975, 5818.709064546756, 5829.271341082364, 5832.037713777222, 13379.331033448387, 13527.932360338134, 13543.525976590772, 24723.392979456457, 25617.35956601081, 2472.221250306148, 2509.648649189115, 2606.7784238339764, 2617.0, 2618.3454136465884, 10034.24743144267, 10488.842667359995, 10700.678979630624, 12468.251904885645, 14941.70116597662, 1808.4574627611664, 1865.5988962373156, 1869.5045812859603, 1870.1771220662865, 1872.3259626534436, 107821.46089269582, 114905.42547287294, 127256.0, 133158.99999999904, 149243.13623547758, 11104.61133860311, 11783.941080294544, 11855.347955862338, 11874.072260012172, 12039.040674865997, 14806.62983425423, 15501.922490387477, 15562.688746225012, 15589.142597157264, 15653.452129175652, 8441.0, 8523.147685231428, 8547.230749232598, 8605.440646357967, 8727.650893964297, 6726.360995705498, 8398.958005210057, 8468.957655211685, 8610.354223433267, 8623.0, 4683.086798074342, 4771.5228477152705, 4782.37829082224, 4853.490383509751, 4877.902441951142, 1696.7539706742452, 2004.168270167893, 2014.3956812956055, 2027.4120505053663, 2029.472337192311, 929.762910457829, 1011.858339832424, 1013.8847268005136, 1015.167562598662, 1058.1006144776877, 19764.40706778799, 21324.0, 22013.779862201493, 22119.115235390404, 22139.446513837283, 1033.8707661542308, 1037.5382954585289, 1049.275999560301, 1081.5457507846722, 1087.9401632910267, 11068.335899846035, 11449.599264025886, 11452.026577740986, 11468.483918223534, 11571.6528504145, 682051.0, 700862.0, 704168.0, 715785.0, 741273.2936335284, 126597.0, 146031.0, 146392.26803866125, 161151.0, 165569.88602279592, 940.1773448232797, 989.9010098990043, 1003.3377970539409, 1004.5830980143159, 1011.9291649584605, 19157.61684766325, 19749.0, 20094.397168084397, 20228.79771202269, 20248.79751202528, 46747.29879051885, 47747.28379074247, 48534.75732621314, 56608.71695641495, 59522.70238648779, 84280.57859710662, 85771.0, 85810.0, 86315.13684863322, 87756.5612171935, 8163.387745919199, 8224.465409748347, 8397.622107005322, 8472.57637118154, 8502.234798868132, 12393.545942280474, 12994.220346779224, 13504.324783760576, 13578.185308881499, 13792.793108103186, 9094.636214551609, 11113.871964855385, 11555.768884622428, 11632.011279041377, 11653.59212427561, 11200.663980080612, 11401.030912372542, 11504.597339093092, 11688.94155529217, 11761.941190293994, 11507.654770356903, 11564.479598417924, 11770.941145294219, 11989.22070065443, 12074.39628018578, 6720.831979200363, 8081.757547273356, 8183.877241841258, 8389.706360277361, 8449.915500844912, 5629.0712032514175, 8252.546109964009, 8412.957935210285, 8968.10318968098, 11122.499487522919], "value": 9699.9539664134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.8472975607808, 1458.7301349250383, 1465.3039806092108, 1487.9181645009523, 1488.4120772294943, 7406.296401841823, 7737.342325902298, 7980.840383192332, 8192.344612431007, 8215.424920255584, 8123.634436450359, 8181.0, 8209.179082091789, 8278.503289802617, 8278.668853245863, 2182.47620571063, 2217.002348942974, 2217.9112835486562, 2220.9222677206303, 2225.6995305633777, 2042.6221149087391, 2120.5334826338258, 2235.0, 2300.5283916797016, 2311.699479067719, 1889.6409682160415, 2230.364346161344, 2236.8546044507057, 2238.2613737466677, 2240.5294888073445, 2195.901184446696, 2229.398062523118, 2257.6726374675745, 2300.183434880627, 2302.838801283911, 1935.796741342167, 2268.727752669674, 2271.3526644906287, 2277.6583512473094, 2292.197730794225, 8177.713780017731, 8225.383096267804, 8290.792730181794, 8301.086880443147, 8301.29438997686, 4360.803763830635, 4990.82532111378, 5140.74296285188, 5159.17453207485, 5161.896762064775, 3089.7837151399413, 3298.142482954449, 3303.537504749337, 3423.9144021399416, 3500.8074555899416, 1145.6963904565298, 1230.809224570193, 1242.589945318043, 1703.5911381268406, 1746.2054765081857, 10541.52563134653, 10543.683689489328, 10655.360678359246, 10673.733156671145, 10676.252662313564, 4170.979145104255, 4367.497737760134, 4406.383106365111, 4430.5126436092005, 4441.20058389493, 8415.579221038923, 8469.915300847037, 8479.109693482218, 8489.533075680896, 8513.276371508367, 5033.5469807716745, 5038.899222015539, 5044.899102017939, 5046.369203849519, 5049.798008079709, 4522.29904364824, 4660.324252983299, 4732.858014259577, 4734.739589322551, 4743.739094349775, 3534.2578058607464, 3591.299696559146, 3592.479090531858, 3636.909077273089, 3656.287024030342, 1128.4808987865674, 1129.6272230164027, 1138.846255755479, 1139.1659428320397, 1140.703417111557, 853.4452605806151, 875.1336177184542, 883.2977782662798, 912.5802131019673, 936.8782058332373, 5247.422783493813, 5259.684418934876, 5487.42382049887, 5556.91664625031, 5588.91616625751, 488.65793944239175, 523.7486006716797, 528.6088294661922, 543.5271313956882, 563.9605227634027, 3304.438245498271, 3574.1422058705725, 3641.2717456508803, 3683.1160521474653, 3707.2029513654156, 9462.57418416173, 9745.707628771148, 9847.50762461874, 9847.950760246153, 9852.064053914866, 9431.90568094324, 9644.469554174448, 9789.657361992297, 9816.0, 9831.066048725359, 7618.69525218985, 7745.8450830983065, 7762.844743105219, 7770.728024519115, 7774.92225077742, 5256.4743525648655, 5256.947430525645, 5294.205869119663, 5321.866953326198, 5346.331708536433, 8961.955190224007, 8993.820123597361, 9020.368574200005, 9036.322275829207, 9190.31072669539, 9191.816163676824, 9250.398724083183, 9267.44395336282, 9307.441553506811, 9332.993406417652, 6539.673016349068, 6684.966575167093, 6686.632235227109, 6696.0960270362875, 6699.698513566998, 7364.631768411665, 7614.428917831296, 7677.462577619513, 7690.769276921701, 7703.037120359955, 6963.8607227854145, 7028.648567571703, 7040.542364746275, 7048.436125110082, 7098.041764361745, 6364.4908407326375, 6878.828029299308, 6951.44388448933, 7008.474364422586, 7034.5427547209265, 6204.627722336674, 6367.204099487564, 6384.07430922523, 6389.48884089281, 6394.71223794921, 3970.7021973351534, 4754.690945088558, 4889.657723959289, 4922.1140194765285, 4932.802687892444, 4849.127157111754, 4860.489648586848, 4983.177775666974, 5108.56577190943, 5133.486651334986], "value": 4242.1897300429855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.1037682691492, 349.8513131918934, 351.5219301749621, 363.21545461802503, 376.38905484526236, 4712.693674911128, 4726.149293127236, 4948.851534453967, 5107.693538387699, 5291.206319052144, 4237.110206856564, 4376.212281789277, 4788.138135135674, 5161.896762064756, 5185.318423919012, 3555.502229687833, 3606.9359538935946, 4112.362583799516, 4113.25961326961, 4114.917701645965, 3764.811759412032, 3847.865324713636, 4037.454943582623, 4038.2731108400476, 4114.691398145136, 3678.0, 4036.656884164835, 4038.374052021941, 4074.3684728866924, 4077.857274995376, 3504.526888869995, 3572.856685860526, 3792.829322680472, 4059.549383024435, 4079.653229475498, 3397.082787647346, 3409.232922592422, 3479.860805567774, 3586.2110335726097, 3605.3330133925306, 5045.394552653668, 5067.290579318898, 5087.389513258396, 5088.0, 5100.48995100487, 4718.41019872516, 4736.786844592001, 4738.431388233434, 4741.881452963704, 4750.0, 4236.9364459533135, 4561.954380456186, 5321.441248668912, 5387.811426600089, 5462.6449280797015, 3358.529805827186, 3980.9402858957137, 4001.379786133154, 4002.378442120416, 4006.2988976928923, 4524.660650451229, 5649.0, 5659.066254068115, 5775.5849816794735, 5780.942190578125, 3591.712662986955, 3680.895801181663, 3923.6076392361106, 4064.8577299794365, 4072.511298644182, 3573.26748016656, 3639.8170594556345, 4119.6910231732145, 4155.958440415558, 4162.979185104055, 3565.3404120237838, 4695.483496815347, 4719.4100737407825, 4733.786979585927, 4752.619790416758, 5248.396434410091, 5346.091164502044, 5585.357683866408, 5587.072460001293, 5606.523445507178, 1181.722295260613, 1257.8679238679806, 1263.7219811641423, 1266.1959655618748, 1273.6433798536425, 720.1358369956074, 809.8258874342044, 855.2772906893665, 864.7103220421103, 873.4279047224078, 4437.378766972626, 4439.4228750262255, 4787.928181077286, 4936.48166942473, 4960.776765045582, 5464.754086066137, 5476.398710612427, 5484.230463615849, 5498.697571633518, 5537.861553461195, 4553.089382123522, 4767.523247675274, 4925.4335751388335, 4945.406551213805, 4956.776945037482, 2385.6898603181476, 2506.922023529863, 2573.1823653099827, 2883.596296518489, 2918.5184444566835, 4879.975600122048, 5633.352164501053, 5679.488846003879, 5717.313922329264, 5718.4567466091485, 4896.902061958741, 4901.607871370282, 5413.320406398858, 5668.489835914705, 5674.631148975303, 4853.563179313879, 4965.031818795373, 5013.874653133701, 5079.74601269935, 5670.285962694442, 5023.196288593807, 5190.8183213587345, 5385.0, 5445.413428621373, 5465.480779325958, 4682.391289132391, 5368.00691872005, 5372.865678358073, 5382.465997190782, 5383.973080134574, 4179.644730197846, 4949.505049495166, 5603.187537807076, 5669.858253543694, 5733.885322293448, 3287.1289108385818, 3516.331896939573, 3768.736188466781, 3812.0279328770985, 3822.6177382262663, 4928.383952005999, 5219.9217011744095, 5406.378266499403, 5443.292371991616, 5644.915326270191, 4759.690620109682, 5193.0, 5448.782048718007, 5518.16487541155, 5614.85962850932, 4669.39297891272, 4825.445073816416, 5414.729263536886, 5540.340636494425, 5575.637583557056, 5226.626776364997, 5362.249285100011, 5436.320459942507, 5462.088269105781, 5493.560515158698, 4720.12677654635, 5142.714321419645, 5407.945920540744, 5503.009458297545, 5504.366997795305, 4888.804447822047, 5141.357330333708, 5232.613357460352, 5374.596905232202, 5502.422245664307], "value": 3977.4086724705658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.470682281466, 712.8431745016095, 721.4228617106313, 785.2226295966991, 839.4585492357431, 11575.42122893855, 15026.924865375686, 15070.698586028273, 15074.170920599363, 15086.170260635661, 14514.637134071654, 14609.561713148596, 14687.0, 14690.118592884435, 14695.559133226021, 668.9498287628423, 690.8721886450998, 820.1552401026952, 827.4084029918607, 846.2341580869293, 848.7623465429658, 852.7825404521839, 853.185208126238, 856.400519636254, 860.4450129666361, 904.669795524632, 910.3172620534599, 913.1005959130251, 913.5432283858071, 916.6516723645038, 904.4256896870469, 904.6019751309468, 905.9682911098146, 906.5603182456537, 907.5689047702322, 528.6114705691352, 541.7101850509958, 542.4412854759564, 543.562432242045, 547.7781498493117, 14447.0, 14984.550463486114, 15048.924755376263, 15414.22928853553, 15466.690666186612, 14462.0, 14517.637059073502, 14534.909881758911, 14610.853891461056, 14695.926520367437, 10279.845802312897, 11423.828642570368, 11825.822612660817, 11892.405379730979, 12101.152919295564, 3608.585012723544, 3772.8113594320175, 3790.6777923876502, 3861.4014827701753, 3866.709996750255, 110938.0, 116006.49768717951, 117031.4148429261, 117946.41026794897, 119318.4034079824, 10214.438205898747, 10869.29349592274, 11051.778964420666, 11310.321380717183, 11399.202055856176, 23544.882275588854, 23551.41121471977, 23552.7644723554, 23560.528789424116, 23566.175183868483, 7687.077550693953, 7786.0, 7793.220677932275, 7879.487833290817, 8005.879911801328, 4286.7856607169515, 4312.89217769552, 4366.541513141138, 4390.319500477431, 4489.618382437464, 3558.733095017884, 3653.9817300913323, 3660.816959152032, 3665.486831843544, 3667.431548110047, 620.8447888027993, 624.1418050181001, 634.1597383466925, 640.0591131037368, 647.799182253503, 624.865868448764, 669.3206395508563, 680.4352387518348, 697.3932678569677, 710.5807573531641, 8473.067962524117, 8646.43798153118, 8906.73279801607, 9213.90786092144, 10416.479176041168, 661.454300202335, 667.8263651450658, 686.629220221075, 706.2132804005771, 717.7631381644045, 4777.307290442866, 4946.431160416526, 4953.925691114636, 4959.792892162953, 4975.601951843843, 84410.15589844146, 100031.49984250033, 104092.47953760183, 104585.0, 105374.4193837093, 90522.54738726265, 92687.5365623181, 93969.5301523488, 94270.0, 96640.06719865563, 61047.694761525905, 78095.21904780994, 78127.60936195283, 78929.21070789218, 80897.59551202324, 9609.759756006155, 9654.951725241328, 9691.273154513581, 9753.561089750836, 9844.310898237054, 48610.29863954744, 53482.93034139373, 53700.73149634227, 54383.72808135934, 55040.72479637576, 63287.05069424054, 70218.94671579829, 71241.28758712554, 72401.0, 74450.62774686092, 12862.549810756578, 13332.466701331838, 13372.531961381304, 13597.0, 13781.51764688231, 13799.655008624864, 14918.925405372904, 15578.22108894528, 15581.98717083386, 15703.0, 13656.0, 13953.372098255806, 14058.01593888459, 14062.015658903778, 14265.71468570602, 12506.937465312616, 13030.41363138642, 13384.732305354033, 13474.258915759727, 14244.216568088854, 13380.735296320647, 13438.798418023933, 13454.192748435125, 13712.588622340947, 14160.008799383944, 10574.365538067741, 11031.338119712522, 11092.057175140204, 11169.441527923409, 11898.940505297418, 9267.304952128483, 9368.718938431857, 9529.380590261611, 9675.70972870815, 9684.854727178958], "value": 7494.111748971762, "unit": "score"}], "name": "dromaeo_css", "value": 7188.370493650259, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 116.0, 113.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 108.0, 108.0, 143.0, 111.0, 109.0, 111.0, 107.0, 128.0, 107.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 181.0, 184.0, 182.0, 183.0, 180.0, 181.0, 183.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 88.0, 76.0, 65.0, 59.0, 58.0, 74.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 86.0, 70.0, 74.0, 92.0, 116.0, 100.0, 85.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 87.0, 87.0, 84.0, 88.0, 85.0, 95.0, 130.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 107.0, 149.0, 120.0, 94.0, 141.0, 139.0, 95.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 88.0, 87.0, 88.0, 85.0, 88.0, 90.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 79.0, 81.0, 74.0, 69.0, 71.0, 71.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 87.0, 87.0, 86.0, 89.0, 90.0, 91.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 140.0, 136.0, 138.0, 137.0, 140.0, 138.0, 139.0, 206.0, 177.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 173.0, 171.0, 172.0, 171.0, 170.0, 175.0, 172.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 87.0, 87.0, 87.0, 66.0, 69.0, 66.0, 65.0, 67.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1470.8999999999999, "alertThreshold": 2.0}]} 08:17:18 INFO - Return code: 0 08:17:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:17:18 INFO - # TBPL SUCCESS # 08:17:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:18 INFO - 2017-01-10 08:17:18.684 screenresolution[1657:9769] starting screenresolution argv=screenresolution get 08:17:18 INFO - 2017-01-10 08:17:18.686 screenresolution[1657:9769] Display 0: 1600x1200x32@60 08:17:18 INFO - 2017-01-10 08:17:18.692 screenresolution[1658:9772] starting screenresolution argv=screenresolution list 08:17:18 INFO - Available Modes on Display 0 08:17:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:18 INFO - Intel Iris: 08:17:18 INFO - Chipset Model: Intel Iris 08:17:18 INFO - Type: GPU 08:17:18 INFO - Bus: Built-In 08:17:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:18 INFO - Vendor: Intel (0x8086) 08:17:18 INFO - Device ID: 0x0a2e 08:17:18 INFO - Revision ID: 0x0009 08:17:18 INFO - Displays: 08:17:18 INFO - Display: 08:17:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:18 INFO - Display Serial Number: 1600x1200 60 08:17:18 INFO - Main Display: Yes 08:17:18 INFO - Mirror: Off 08:17:18 INFO - Online: Yes 08:17:18 INFO - Rotation: Supported 08:17:18 INFO - Return code: 0 08:17:18 INFO - Running post-action listener: _resource_record_post_action 08:17:18 INFO - [mozharness: 2017-01-10 16:17:18.935124Z] Finished run-tests step (success) 08:17:18 INFO - Running post-run listener: _resource_record_post_run 08:17:18 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32025600; Write bytes: 550472192; Read time: 196; Write time: 1677 08:17:18 INFO - TinderboxPrint: CPU usage
53.7% 08:17:18 INFO - TinderboxPrint: I/O read bytes / time
32,025,600 / 196 08:17:18 INFO - TinderboxPrint: I/O write bytes / time
550,472,192 / 1,677 08:17:18 INFO - TinderboxPrint: CPU idle
2,224.7 (46.3%) 08:17:18 INFO - TinderboxPrint: CPU system
961.6 (20.0%) 08:17:18 INFO - TinderboxPrint: CPU user
1,623.4 (33.8%) 08:17:18 INFO - TinderboxPrint: Swap in / out
278,011,904 / 0 08:17:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 231475712; Write bytes: 223797248; Read time: 16400; Write time: 481 08:17:19 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31087616; Write bytes: 299735552; Read time: 184; Write time: 1130 08:17:19 INFO - Running post-run listener: _upload_blobber_files 08:17:19 INFO - Blob upload gear active. 08:17:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:19 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 08:17:19 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'] 08:17:19 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 08:17:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:21 INFO - (blobuploader) - INFO - Done attempting. 08:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:21 INFO - (blobuploader) - INFO - Done attempting. 08:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:22 INFO - (blobuploader) - INFO - Done attempting. 08:17:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:17:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:25 INFO - (blobuploader) - INFO - Done attempting. 08:17:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:25 INFO - Return code: 0 08:17:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/696d09e1b945d59268ecb258f04099b71265789d2995a7b60820cedff889736be8883606c2c9bd1d15b122c400d8f57a68bfaa3fb0bf4f492b02222280ee0c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b1ed9ad7473f58dcd80985012551967fa19ec7c50ff8522b1c2b23d0c9c53ffb5a2d4c8ea7234248786629f6fd12d5dbb788dd16b5d394e164d0379e1cb0e52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1466afcd7f313dd03e94ed758c8722994870610fd65000e0f74b2d943ae4f7135decb3ca9e91fc2f3a709eaa1edc6d8c0f15c6e4b62b019ba4b59eb4032a7594", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb7cd151b97791c5a6639b82d9bc77961692f00b24c1aa0e23fa8c46d806f43242dfd23fe1500618e7cc04ae4b816cbcb93c7950671364c138a21b926b04866"} 08:17:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:25 INFO - Contents: 08:17:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/696d09e1b945d59268ecb258f04099b71265789d2995a7b60820cedff889736be8883606c2c9bd1d15b122c400d8f57a68bfaa3fb0bf4f492b02222280ee0c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b1ed9ad7473f58dcd80985012551967fa19ec7c50ff8522b1c2b23d0c9c53ffb5a2d4c8ea7234248786629f6fd12d5dbb788dd16b5d394e164d0379e1cb0e52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1466afcd7f313dd03e94ed758c8722994870610fd65000e0f74b2d943ae4f7135decb3ca9e91fc2f3a709eaa1edc6d8c0f15c6e4b62b019ba4b59eb4032a7594", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb7cd151b97791c5a6639b82d9bc77961692f00b24c1aa0e23fa8c46d806f43242dfd23fe1500618e7cc04ae4b816cbcb93c7950671364c138a21b926b04866"} 08:17:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:25 INFO - Copying logs to upload dir... 08:17:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.751319 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-10 08:17:25.569635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 08:17:25.574224) ========= 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.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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/696d09e1b945d59268ecb258f04099b71265789d2995a7b60820cedff889736be8883606c2c9bd1d15b122c400d8f57a68bfaa3fb0bf4f492b02222280ee0c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b1ed9ad7473f58dcd80985012551967fa19ec7c50ff8522b1c2b23d0c9c53ffb5a2d4c8ea7234248786629f6fd12d5dbb788dd16b5d394e164d0379e1cb0e52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1466afcd7f313dd03e94ed758c8722994870610fd65000e0f74b2d943ae4f7135decb3ca9e91fc2f3a709eaa1edc6d8c0f15c6e4b62b019ba4b59eb4032a7594", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb7cd151b97791c5a6639b82d9bc77961692f00b24c1aa0e23fa8c46d806f43242dfd23fe1500618e7cc04ae4b816cbcb93c7950671364c138a21b926b04866"} build_url:https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/B3r5aM1GROSau3nVNCw5GA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/696d09e1b945d59268ecb258f04099b71265789d2995a7b60820cedff889736be8883606c2c9bd1d15b122c400d8f57a68bfaa3fb0bf4f492b02222280ee0c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b1ed9ad7473f58dcd80985012551967fa19ec7c50ff8522b1c2b23d0c9c53ffb5a2d4c8ea7234248786629f6fd12d5dbb788dd16b5d394e164d0379e1cb0e52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1466afcd7f313dd03e94ed758c8722994870610fd65000e0f74b2d943ae4f7135decb3ca9e91fc2f3a709eaa1edc6d8c0f15c6e4b62b019ba4b59eb4032a7594", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb7cd151b97791c5a6639b82d9bc77961692f00b24c1aa0e23fa8c46d806f43242dfd23fe1500618e7cc04ae4b816cbcb93c7950671364c138a21b926b04866"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 08:17:25.616096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 08:17:25.616417) ========= 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.ZcnFyIlELq/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.WuossSxI46/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 08:17:25.664760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 08:17:25.665081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 08:17:25.665393) ========= ========= Total master_lag: 0.34 =========