builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0145 starttime: 1481544650.46 results: success (0) buildid: 20161212025550 builduid: 30e632090ea24971a1ffb80f95d8dcb8 revision: 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.461592) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.462048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.462321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.488580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.488873) ========= 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.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-12 04:10:50-- 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% 15.5M=0.001s 2016-12-12 04:10:50 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156972 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.686788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.687447) ========= 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.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.029447 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:50.738652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 04:10:50.738959) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-12 04:10:50,833 truncating revision to first 12 chars 2016-12-12 04:10:50,833 Setting DEBUG logging. 2016-12-12 04:10:50,833 attempt 1/10 2016-12-12 04:10:50,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/829fcc7f60f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-12 04:10:51,571 unpacking tar archive at: mozilla-beta-829fcc7f60f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012490 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 04:10:51.779200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:51.779852) ========= script_repo_revision: 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:51.780821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:51.781562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 04:10:51.806813) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-12 04:10:51.807160) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:10:51 INFO - MultiFileLogger online at 20161212 04:10:51 in /builds/slave/test 04:10:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:10:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:52 INFO - {'append_to_log': False, 04:10:52 INFO - 'base_work_dir': '/builds/slave/test', 04:10:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:52 INFO - 'branch': 'Mozilla-Beta', 04:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:52 INFO - 'config_files': ('talos/mac_config.py',), 04:10:52 INFO - 'default_actions': ('clobber', 04:10:52 INFO - 'read-buildbot-config', 04:10:52 INFO - 'download-and-extract', 04:10:52 INFO - 'populate-webroot', 04:10:52 INFO - 'create-virtualenv', 04:10:52 INFO - 'install', 04:10:52 INFO - 'run-tests'), 04:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:52 INFO - 'download_minidump_stackwalk': True, 04:10:52 INFO - 'download_symbols': 'ondemand', 04:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:52 INFO - 'installer_path': 'installer.exe', 04:10:52 INFO - 'log_level': 'info', 04:10:52 INFO - 'log_name': 'talos', 04:10:52 INFO - 'log_to_console': True, 04:10:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:10:52 INFO - 'opt_config_files': (), 04:10:52 INFO - 'pip_index': False, 04:10:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:10:52 INFO - 'cmd': ('bash', 04:10:52 INFO - '-c', 04:10:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:10:52 INFO - 'enabled': True, 04:10:52 INFO - 'halt_on_failure': False, 04:10:52 INFO - 'name': 'check_screen_resolution'},), 04:10:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:10:52 INFO - 'cmd': ('bash', 04:10:52 INFO - '-c', 04:10:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:10:52 INFO - 'enabled': True, 04:10:52 INFO - 'halt_on_failure': False, 04:10:52 INFO - 'name': 'check_screen_resolution'},), 04:10:52 INFO - 'run_cmd_checks_enabled': True, 04:10:52 INFO - 'sps_profile': False, 04:10:52 INFO - 'sps_profile_interval': 0, 04:10:52 INFO - 'suite': 'dromaeojs', 04:10:52 INFO - 'system_bits': '32', 04:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:52 INFO - 'title': 't-yosemite-r7-0145', 04:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:52 INFO - 'use_talos_json': True, 04:10:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:52 INFO - 'work_dir': 'build'} 04:10:52 INFO - [mozharness: 2016-12-12 12:10:52.007293Z] Running clobber step. 04:10:52 INFO - Running pre-action listener: _resource_record_pre_action 04:10:52 INFO - Running main action method: clobber 04:10:52 INFO - rmtree: /builds/slave/test/build 04:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:54 INFO - Running post-action listener: _resource_record_post_action 04:10:54 INFO - [mozharness: 2016-12-12 12:10:54.391388Z] Finished clobber step (success) 04:10:54 INFO - [mozharness: 2016-12-12 12:10:54.391505Z] Running read-buildbot-config step. 04:10:54 INFO - Running pre-action listener: _resource_record_pre_action 04:10:54 INFO - Running main action method: read_buildbot_config 04:10:54 INFO - Using buildbot properties: 04:10:54 INFO - { 04:10:54 INFO - "project": "", 04:10:54 INFO - "product": "firefox", 04:10:54 INFO - "script_repo_revision": "production", 04:10:54 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:10:54 INFO - "repository": "", 04:10:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:10:54 INFO - "buildid": "20161212025550", 04:10:54 INFO - "pgo_build": "False", 04:10:54 INFO - "basedir": "/builds/slave/test", 04:10:54 INFO - "buildnumber": 6, 04:10:54 INFO - "slavename": "t-yosemite-r7-0145", 04:10:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:10:54 INFO - "platform": "yosemite_r7", 04:10:54 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:10:54 INFO - "branch": "mozilla-beta", 04:10:54 INFO - "repo_path": "releases/mozilla-beta", 04:10:54 INFO - "revision": "829fcc7f60f04dffff4d29b007ef8015a1cd2c99", 04:10:54 INFO - "stage_platform": "macosx64", 04:10:54 INFO - "builduid": "30e632090ea24971a1ffb80f95d8dcb8", 04:10:54 INFO - "slavebuilddir": "test" 04:10:54 INFO - } 04:10:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 04:10:54 INFO - Running post-action listener: _resource_record_post_action 04:10:54 INFO - [mozharness: 2016-12-12 12:10:54.394615Z] Finished read-buildbot-config step (success) 04:10:54 INFO - [mozharness: 2016-12-12 12:10:54.394726Z] Running download-and-extract step. 04:10:54 INFO - Running pre-action listener: _resource_record_pre_action 04:10:54 INFO - Running main action method: download_and_extract 04:10:54 INFO - mkdir: /builds/slave/test/build/tests 04:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:54 INFO - trying https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 04:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 04:10:55 INFO - Downloaded 1165 bytes. 04:10:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:10:55 INFO - Using the following test package requirements: 04:10:55 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:10:55 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 04:10:55 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 04:10:55 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:10:55 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 04:10:55 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:10:55 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 04:10:55 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 04:10:55 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 04:10:55 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:55 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 04:10:55 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 04:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:10:56 INFO - Expected file size: 16232460 04:11:03 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:11:03 INFO - Expected file size: 16232460 04:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 04:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 04:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 04:11:11 INFO - Expected file size: 14414089 04:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:11 INFO - trying https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:11:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 04:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 04:11:14 INFO - Downloaded 86073733 bytes. 04:11:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:11:14 INFO - mkdir: /builds/slave/test/properties 04:11:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:14 INFO - Contents: 04:11:14 INFO - build_url:https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - Running post-action listener: set_extra_try_arguments 04:11:14 INFO - [mozharness: 2016-12-12 12:11:14.851084Z] Finished download-and-extract step (success) 04:11:14 INFO - [mozharness: 2016-12-12 12:11:14.851203Z] Running populate-webroot step. 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: populate_webroot 04:11:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:14 INFO - '--tppagecycles', 04:11:14 INFO - '7'], 04:11:14 INFO - 'tests': ['tsvgm']}}, 04:11:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['damp', 'tps']}, 04:11:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'tests': ['damp', 'tps']}, 04:11:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['dromaeo_dom']}, 04:11:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['basic_compositor_video']}, 04:11:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['tsvgx', 04:11:14 INFO - 'tsvgr_opacity', 04:11:14 INFO - 'tart', 04:11:14 INFO - 'tscrollx', 04:11:14 INFO - 'cart']}, 04:11:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:14 INFO - 'tsvgr_opacity', 04:11:14 INFO - 'tart', 04:11:14 INFO - 'tscrollx', 04:11:14 INFO - 'cart']}, 04:11:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'talos_options': ['--disable-e10s'], 04:11:14 INFO - 'tests': ['tp5o']}, 04:11:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'tests': ['tp5o']}, 04:11:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'talos_options': ['--disable-e10s', 04:11:14 INFO - '--xperf_path', 04:11:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:14 INFO - 'tests': ['tp5n']}, 04:11:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:14 INFO - 'talos_options': ['--xperf_path', 04:11:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:14 INFO - 'tests': ['tp5n']}}, 04:11:14 INFO - 'talos.zip': {'path': '', 04:11:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - [mozharness: 2016-12-12 12:11:14.870284Z] Finished populate-webroot step (success) 04:11:14 INFO - [mozharness: 2016-12-12 12:11:14.870391Z] Running create-virtualenv step. 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: create_virtualenv 04:11:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:11:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:14 INFO - Using real prefix '/tools/python27' 04:11:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:15 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:18 INFO - Installing pip.................done. 04:11:18 INFO - Return code: 0 04:11:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:18 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:18 INFO - 'HOME': '/Users/cltbld', 04:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:18 INFO - 'LOGNAME': 'cltbld', 04:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:18 INFO - 'MOZ_NO_REMOTE': '1', 04:11:18 INFO - 'NO_EM_RESTART': '1', 04:11:18 INFO - 'PAGER': '/bin/cat', 04:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:18 INFO - 'PWD': '/builds/slave/test', 04:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:18 INFO - 'SHELL': '/bin/bash', 04:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:18 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:18 INFO - 'USER': 'cltbld', 04:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:18 INFO - 'XPC_FLAGS': '0x0', 04:11:18 INFO - 'XPC_SERVICE_NAME': '0', 04:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:11:19 INFO - Cleaning up... 04:11:19 INFO - Return code: 0 04:11:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:19 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:19 INFO - 'HOME': '/Users/cltbld', 04:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:19 INFO - 'LOGNAME': 'cltbld', 04:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:19 INFO - 'MOZ_NO_REMOTE': '1', 04:11:19 INFO - 'NO_EM_RESTART': '1', 04:11:19 INFO - 'PAGER': '/bin/cat', 04:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:19 INFO - 'PWD': '/builds/slave/test', 04:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:19 INFO - 'SHELL': '/bin/bash', 04:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:19 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:19 INFO - 'USER': 'cltbld', 04:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:19 INFO - 'XPC_FLAGS': '0x0', 04:11:19 INFO - 'XPC_SERVICE_NAME': '0', 04:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:19 INFO - Downloading/unpacking psutil>=3.1.1 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:23 INFO - Installing collected packages: psutil 04:11:23 INFO - Running setup.py install for psutil 04:11:23 INFO - building 'psutil._psutil_osx' extension 04:11:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:11:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:11:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:11:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:11:24 INFO - building 'psutil._psutil_posix' extension 04:11:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:11:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:24 INFO - ^ 04:11:24 INFO - 1 warning generated. 04:11:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:24 INFO - Successfully installed psutil 04:11:24 INFO - Cleaning up... 04:11:24 INFO - Return code: 0 04:11:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:24 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:24 INFO - 'HOME': '/Users/cltbld', 04:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:24 INFO - 'LOGNAME': 'cltbld', 04:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:24 INFO - 'MOZ_NO_REMOTE': '1', 04:11:24 INFO - 'NO_EM_RESTART': '1', 04:11:24 INFO - 'PAGER': '/bin/cat', 04:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:24 INFO - 'PWD': '/builds/slave/test', 04:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:24 INFO - 'SHELL': '/bin/bash', 04:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:24 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:24 INFO - 'USER': 'cltbld', 04:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:24 INFO - 'XPC_FLAGS': '0x0', 04:11:24 INFO - 'XPC_SERVICE_NAME': '0', 04:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:27 INFO - Installing collected packages: mozsystemmonitor 04:11:27 INFO - Running setup.py install for mozsystemmonitor 04:11:27 INFO - Successfully installed mozsystemmonitor 04:11:27 INFO - Cleaning up... 04:11:27 INFO - Return code: 0 04:11:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:27 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:27 INFO - 'HOME': '/Users/cltbld', 04:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:27 INFO - 'LOGNAME': 'cltbld', 04:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:27 INFO - 'MOZ_NO_REMOTE': '1', 04:11:27 INFO - 'NO_EM_RESTART': '1', 04:11:27 INFO - 'PAGER': '/bin/cat', 04:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:27 INFO - 'PWD': '/builds/slave/test', 04:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:27 INFO - 'SHELL': '/bin/bash', 04:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:27 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:27 INFO - 'USER': 'cltbld', 04:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:27 INFO - 'XPC_FLAGS': '0x0', 04:11:27 INFO - 'XPC_SERVICE_NAME': '0', 04:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:31 INFO - warning: no files found matching '*.txt' 04:11:31 INFO - no previously-included directories found matching 'build' 04:11:31 INFO - no previously-included directories found matching 'dist' 04:11:31 INFO - no previously-included directories found matching '.git*' 04:11:31 INFO - Installing collected packages: jsonschema, functools32 04:11:31 INFO - Running setup.py install for functools32 04:11:31 INFO - warning: no files found matching '*.txt' 04:11:31 INFO - no previously-included directories found matching 'build' 04:11:31 INFO - no previously-included directories found matching 'dist' 04:11:31 INFO - no previously-included directories found matching '.git*' 04:11:31 INFO - Successfully installed jsonschema functools32 04:11:31 INFO - Cleaning up... 04:11:31 INFO - Return code: 0 04:11:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:31 INFO - 'HOME': '/Users/cltbld', 04:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:31 INFO - 'LOGNAME': 'cltbld', 04:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:31 INFO - 'MOZ_NO_REMOTE': '1', 04:11:31 INFO - 'NO_EM_RESTART': '1', 04:11:31 INFO - 'PAGER': '/bin/cat', 04:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:31 INFO - 'PWD': '/builds/slave/test', 04:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:31 INFO - 'SHELL': '/bin/bash', 04:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:31 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:31 INFO - 'USER': 'cltbld', 04:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:31 INFO - 'XPC_FLAGS': '0x0', 04:11:31 INFO - 'XPC_SERVICE_NAME': '0', 04:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:11:31 INFO - Cleaning up... 04:11:31 INFO - Return code: 0 04:11:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:31 INFO - 'HOME': '/Users/cltbld', 04:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:31 INFO - 'LOGNAME': 'cltbld', 04:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:31 INFO - 'MOZ_NO_REMOTE': '1', 04:11:31 INFO - 'NO_EM_RESTART': '1', 04:11:31 INFO - 'PAGER': '/bin/cat', 04:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:31 INFO - 'PWD': '/builds/slave/test', 04:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:31 INFO - 'SHELL': '/bin/bash', 04:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:31 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:31 INFO - 'USER': 'cltbld', 04:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:31 INFO - 'XPC_FLAGS': '0x0', 04:11:31 INFO - 'XPC_SERVICE_NAME': '0', 04:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:35 INFO - Downloading docopt-0.6.1.tar.gz 04:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:35 INFO - Running setup.py install for blobuploader 04:11:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:35 INFO - Running setup.py install for requests 04:11:36 INFO - Running setup.py install for docopt 04:11:36 INFO - Successfully installed blobuploader requests docopt 04:11:36 INFO - Cleaning up... 04:11:36 INFO - Return code: 0 04:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:36 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:36 INFO - 'HOME': '/Users/cltbld', 04:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:36 INFO - 'LOGNAME': 'cltbld', 04:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:36 INFO - 'MOZ_NO_REMOTE': '1', 04:11:36 INFO - 'NO_EM_RESTART': '1', 04:11:36 INFO - 'PAGER': '/bin/cat', 04:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:36 INFO - 'PWD': '/builds/slave/test', 04:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:36 INFO - 'SHELL': '/bin/bash', 04:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:36 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:36 INFO - 'USER': 'cltbld', 04:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:36 INFO - 'XPC_FLAGS': '0x0', 04:11:36 INFO - 'XPC_SERVICE_NAME': '0', 04:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_T5kHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-EiowxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-xTDku9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-NmUxIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-PVn7S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-aMRa9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-GmHi7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-M6_Hox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-0B_h2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-1iXjBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-dyPsXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Rc3wYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vpBx33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CyABHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CH_U6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-YKz_9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:38 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-RkVFaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:38 INFO - Running setup.py install for manifestparser 04:11:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:38 INFO - Running setup.py install for mozcrash 04:11:39 INFO - Running setup.py install for mozdebug 04:11:39 INFO - Running setup.py install for mozdevice 04:11:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Running setup.py install for mozfile 04:11:39 INFO - Running setup.py install for mozhttpd 04:11:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Running setup.py install for mozinfo 04:11:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Running setup.py install for mozInstall 04:11:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:39 INFO - Running setup.py install for mozleak 04:11:40 INFO - Running setup.py install for mozlog 04:11:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Running setup.py install for moznetwork 04:11:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Running setup.py install for mozprocess 04:11:40 INFO - Running setup.py install for mozprofile 04:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Running setup.py install for mozrunner 04:11:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:40 INFO - Running setup.py install for mozscreenshot 04:11:41 INFO - Running setup.py install for moztest 04:11:41 INFO - Running setup.py install for mozversion 04:11:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:41 INFO - Cleaning up... 04:11:41 INFO - Return code: 0 04:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:41 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:41 INFO - 'HOME': '/Users/cltbld', 04:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:41 INFO - 'LOGNAME': 'cltbld', 04:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:41 INFO - 'MOZ_NO_REMOTE': '1', 04:11:41 INFO - 'NO_EM_RESTART': '1', 04:11:41 INFO - 'PAGER': '/bin/cat', 04:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:41 INFO - 'PWD': '/builds/slave/test', 04:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:41 INFO - 'SHELL': '/bin/bash', 04:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:41 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:41 INFO - 'USER': 'cltbld', 04:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:41 INFO - 'XPC_FLAGS': '0x0', 04:11:41 INFO - 'XPC_SERVICE_NAME': '0', 04:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-4WuwM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-fqtSm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CKeUM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-jI8_6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_qKuIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-GQddYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2Kk501-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-P9GTcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ASmHRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-AuBu9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-AQ832H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-D3Xlv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:42 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-k3Vl53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:43 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_AXPpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:43 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-F4bbtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:43 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-tNxNQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:43 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-xJjdPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:45 INFO - Downloading blessings-1.6.tar.gz 04:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:46 INFO - Installing collected packages: blessings 04:11:46 INFO - Running setup.py install for blessings 04:11:46 INFO - Successfully installed blessings 04:11:46 INFO - Cleaning up... 04:11:46 INFO - Return code: 0 04:11:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:46 INFO - Reading from file tmpfile_stdout 04:11:46 INFO - Current package versions: 04:11:46 INFO - blessings == 1.6 04:11:46 INFO - blobuploader == 1.2.4 04:11:46 INFO - docopt == 0.6.1 04:11:46 INFO - functools32 == 3.2.3-2 04:11:46 INFO - jsonschema == 2.5.1 04:11:46 INFO - manifestparser == 1.1 04:11:46 INFO - mozInstall == 1.12 04:11:46 INFO - mozcrash == 0.17 04:11:46 INFO - mozdebug == 0.1 04:11:46 INFO - mozdevice == 0.48 04:11:46 INFO - mozfile == 1.2 04:11:46 INFO - mozhttpd == 0.7 04:11:46 INFO - mozinfo == 0.9 04:11:46 INFO - mozleak == 0.1 04:11:46 INFO - mozlog == 3.4 04:11:46 INFO - moznetwork == 0.27 04:11:46 INFO - mozprocess == 0.23 04:11:46 INFO - mozprofile == 0.28 04:11:46 INFO - mozrunner == 6.12 04:11:46 INFO - mozscreenshot == 0.1 04:11:46 INFO - mozsystemmonitor == 0.3 04:11:46 INFO - moztest == 0.7 04:11:46 INFO - mozversion == 1.4 04:11:46 INFO - psutil == 3.1.1 04:11:46 INFO - requests == 1.2.3 04:11:46 INFO - wsgiref == 0.1.2 04:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 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 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:46 INFO - 'HOME': '/Users/cltbld', 04:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:46 INFO - 'LOGNAME': 'cltbld', 04:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:46 INFO - 'MOZ_NO_REMOTE': '1', 04:11:46 INFO - 'NO_EM_RESTART': '1', 04:11:46 INFO - 'PAGER': '/bin/cat', 04:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:46 INFO - 'PWD': '/builds/slave/test', 04:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:46 INFO - 'SHELL': '/bin/bash', 04:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:46 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:46 INFO - 'USER': 'cltbld', 04:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:46 INFO - 'XPC_FLAGS': '0x0', 04:11:46 INFO - 'XPC_SERVICE_NAME': '0', 04:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:46 INFO - Cleaning up... 04:11:46 INFO - Return code: 0 04:11:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10623b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061b1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf8bd91c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, '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.WL6QFZww5O/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.L72fIx0545/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:46 INFO - 'HOME': '/Users/cltbld', 04:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:46 INFO - 'LOGNAME': 'cltbld', 04:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:46 INFO - 'MOZ_NO_REMOTE': '1', 04:11:46 INFO - 'NO_EM_RESTART': '1', 04:11:46 INFO - 'PAGER': '/bin/cat', 04:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:46 INFO - 'PWD': '/builds/slave/test', 04:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:46 INFO - 'SHELL': '/bin/bash', 04:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:11:46 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:46 INFO - 'USER': 'cltbld', 04:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:46 INFO - 'XPC_FLAGS': '0x0', 04:11:46 INFO - 'XPC_SERVICE_NAME': '0', 04:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:47 INFO - Cleaning up... 04:11:47 INFO - Return code: 0 04:11:47 INFO - Running post-action listener: _resource_record_post_action 04:11:47 INFO - Running post-action listener: _start_resource_monitoring 04:11:47 INFO - Starting resource monitoring. 04:11:47 INFO - [mozharness: 2016-12-12 12:11:47.178890Z] Finished create-virtualenv step (success) 04:11:47 INFO - [mozharness: 2016-12-12 12:11:47.179861Z] Running install step. 04:11:47 INFO - Running pre-action listener: _resource_record_pre_action 04:11:47 INFO - Running main action method: install 04:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:47 INFO - Reading from file tmpfile_stdout 04:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:47 INFO - Reading from file tmpfile_stdout 04:11:47 INFO - Output received: 04:11:47 INFO - Usage: mozinstall [options] installer 04:11:47 INFO - Options: 04:11:47 INFO - -h, --help show this help message and exit 04:11:47 INFO - -d DEST, --destination=DEST 04:11:47 INFO - Directory to install application into. [default: 04:11:47 INFO - "/builds/slave/test"] 04:11:47 INFO - --app=APP Application being installed. [default: firefox] 04:11:47 INFO - mkdir: /builds/slave/test/build/application 04:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:12:09 INFO - Reading from file tmpfile_stdout 04:12:09 INFO - Output received: 04:12:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:12:09 INFO - Running post-action listener: _resource_record_post_action 04:12:09 INFO - [mozharness: 2016-12-12 12:12:09.344432Z] Finished install step (success) 04:12:09 INFO - [mozharness: 2016-12-12 12:12:09.344553Z] Running run-tests step. 04:12:09 INFO - Running pre-action listener: _resource_record_pre_action 04:12:09 INFO - Running main action method: run_tests 04:12:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:09 INFO - 2016-12-12 04:12:09.358 screenresolution[1628:7644] starting screenresolution argv=screenresolution get 04:12:09 INFO - 2016-12-12 04:12:09.361 screenresolution[1628:7644] Display 0: 1600x1200x32@60 04:12:09 INFO - 2016-12-12 04:12:09.367 screenresolution[1629:7646] starting screenresolution argv=screenresolution list 04:12:09 INFO - Available Modes on Display 0 04:12:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:09 INFO - Intel Iris: 04:12:09 INFO - Chipset Model: Intel Iris 04:12:09 INFO - Type: GPU 04:12:09 INFO - Bus: Built-In 04:12:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:09 INFO - Vendor: Intel (0x8086) 04:12:09 INFO - Device ID: 0x0a2e 04:12:09 INFO - Revision ID: 0x0009 04:12:09 INFO - Displays: 04:12:09 INFO - Display: 04:12:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:09 INFO - Display Serial Number: 1600x1200 60 04:12:09 INFO - Main Display: Yes 04:12:09 INFO - Mirror: Off 04:12:09 INFO - Online: Yes 04:12:09 INFO - Rotation: Supported 04:12:09 INFO - Return code: 0 04:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:09 INFO - Python 2.7.3 04:12:09 INFO - Return code: 0 04:12:09 INFO - grabbing minidump binary from tooltool 04:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:09 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 0x10604fd30>, '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 0x105eb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106047b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:12:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:12:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:12:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:09 INFO - Return code: 0 04:12:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:12:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:12:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WL6QFZww5O/Render', 04:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:09 INFO - 'HOME': '/Users/cltbld', 04:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:09 INFO - 'LOGNAME': 'cltbld', 04:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:09 INFO - 'MOZ_NO_REMOTE': '1', 04:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:09 INFO - 'NO_EM_RESTART': '1', 04:12:09 INFO - 'PAGER': '/bin/cat', 04:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:09 INFO - 'PWD': '/builds/slave/test', 04:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:09 INFO - 'SHELL': '/bin/bash', 04:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L72fIx0545/Listeners', 04:12:09 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:09 INFO - 'USER': 'cltbld', 04:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:09 INFO - 'XPC_FLAGS': '0x0', 04:12:09 INFO - 'XPC_SERVICE_NAME': '0', 04:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:12:09 INFO - mozversion application_buildid: 20161212025550 04:12:09 INFO - mozversion application_changeset: 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 04:12:09 INFO - mozversion application_display_name: Firefox 04:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:09 INFO - mozversion application_name: Firefox 04:12:09 INFO - mozversion application_remotingname: firefox 04:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:12:09 INFO - mozversion application_vendor: Mozilla 04:12:09 INFO - mozversion application_version: 51.0 04:12:09 INFO - mozversion platform_buildid: 20161212025550 04:12:09 INFO - mozversion platform_changeset: 829fcc7f60f04dffff4d29b007ef8015a1cd2c99 04:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:12:09 INFO - mozversion platform_version: 51.0 04:12:09 INFO - using testdate: 1481544729 04:12:09 INFO - actual date: 1481544729 04:12:09 INFO - starting webserver on 'localhost:49246' 04:12:09 INFO - SUITE-START | Running 2 tests 04:12:09 INFO - TEST-START | dromaeo_css 04:12:09 INFO - operating with platform_type : mac_ 04:12:09 INFO - Initialising browser for dromaeo_css test... 04:12:09 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpievW1k/profile http://localhost:49246/getInfo.html) 04:12:12 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 04:12:12 INFO - PROCESS | 1639 | colorDepth:24 04:12:12 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 04:12:12 INFO - PROCESS | 1639 | __metrics 04:12:12 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:12:12 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:12:13 INFO - TEST-INFO | 1639: exit 0 04:12:13 INFO - Browser initialized. 04:12:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:13 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpievW1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:24 INFO - PROCESS | 1642 | RSS: Main: 169086976 04:12:24 INFO - PROCESS | 1642 | 04:13:16 INFO - PROCESS | 1642 | 1481544796798 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:15:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 04:15:28 INFO - PROCESS | 1642 | RSS: Main: 282939392 04:15:28 INFO - PROCESS | 1642 | 04:18:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 04:18:31 INFO - PROCESS | 1642 | RSS: Main: 302161920 04:18:31 INFO - PROCESS | 1642 | 04:21:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 04:21:34 INFO - PROCESS | 1642 | RSS: Main: 284446720 04:21:34 INFO - PROCESS | 1642 | 04:24:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 04:24:37 INFO - PROCESS | 1642 | RSS: Main: 286879744 04:24:37 INFO - PROCESS | 1642 | 04:27:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 04:27:41 INFO - PROCESS | 1642 | RSS: Main: 261742592 04:27:41 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 04:30:44 INFO - PROCESS | 1642 | RSS: Main: 393109504 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | __start_tp_report 04:30:44 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 04:30:44 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 04:30:44 INFO - PROCESS | 1642 | |i|pagename|runs| 04:30:44 INFO - PROCESS | 1642 | |0;dojo.html;3427.0746898337457;3430.4511278195487;3466.9826650866744;3481.147118955856;3501.5973163086237;5666.631668941516;5747.994101032324;5785.7685692572295;5791.07342825148;5814.563907706923;5746.7413966371505;5747.023006088964;5760.56795740319;5772.826815195551;5780.364159942403;5182.714950677711;5231;5271.657342272759;5279.3928698199625;5281.339832520935;5183.844484665466;5200.6619569727845;5204.817831375903;5318.521333080022;5324.1747529133045;5277.894442111175;5297.337832770903;5301.045811753883;5303.363596368441;5310.681359118446;5289.523942845143;5305.071612467803;5345.518903298683;5348.465153484621;5369.704666243355;5154.38147422308;5243.575579523101;5307.124324486494;5313.1764576490705;5331.093714068617;5681.517071048966;5714;5721.914171287434;5771.163181338682;5794.043982742843;6216.440520353145;6292.182016337847;6292.433680968735;6331.2719037310835;6347.079673447324;6308.558400911938;6357.4914006879335;6363.681815909233;6382.042693595951;6390.584612000252;4766.618670506351;5803.738831752539;5825.854353641108;5863.9706801466145;5880.676562789087;6303.779367722108;6326.43062124411;6327.96836015817;6347.270063942613;6422.678866056678;6246.781362652286;6249.96875015622;6254.749810007549;6258;6276.152719382825;6188.659623720649;6224.284207316216;6276.905846412307;6277.121203031579;6311.936880631135;5216.400113986864;6234.2830574483605;6298.937010629835;6320.209973753281;6321.399467050623;6279.3720627937755;6327.145835312266;6342.302346741854;6346.524010699216;6347.492200623939;4966.329545511309;5023.572996295356;5054.393472783289;5056.797728090909;5081.771320290596;4523.253663145544;4529.68292219548;4573.153966516205;4579.404677391918;4582.991741816795;5866.794662186803;5871.442212989759;5872.706364681834;5883.882322353529;5900.675462849498;6225.439710425992;6272.435480806749;6342.429181373698;6346.428821406095;6353.872922541524;5716.428357164334;5813.447722466443;5816.41835816415;5880.059190529495;5917.378675239124;5488.56091512678;5549.889002220014;5554.2779438672715;5567.248421463131;5577.414371491016;5639.6334238274385;6277.623342599459;6342.39747224013;6390.7763228286785;6398.936010639834;6290.528210384148;6328.683565821782;6354.523410744305;6361.936380636134;6366.331535188739;6385.968070159805;6389.616623002635;6395.008773640093;6395.552311338348;6400.295967443671;6132.4166970161305;6270.184875966095;6349.49204063683;6364.77723279683;6374.808755737336;6256.749730010749;6283.874322513616;6287.591306565058;6292.276388215414;6334.081558174131;6073.089036644362;6296.496280297473;6311.842203944938;6319.46284565817;6329.145565348619;6250.218722659668;6273.37266273369;6284.560080794484;6289.433950944437;6296.685165741603;5939.376365481562;5979.133025711334;6075.210222671025;6115.125890831302;6133.938660613515;6265.780697675559;6274.717637706223;6275.686215689106;6284;6286.842828929313;5971.880562388641;6165.691715414122;6168.1056246844855;6168.629882207082;6181.103739957771 04:30:44 INFO - PROCESS | 1642 | |1;ext.html;470.7740284663362;481.8674864412284;503.2853348245491;526.0452279113409;546.8195495486489;31816.68183318169;41512.96217594561;43087;43423.131537369234;45266.547334526644;44729;45233.54766452334;45334;45334.093318133615;45395.546044539544;9102.590383432762;9896.653617123384;10069.244806639495;10088.142507886838;10094.949525252363;9172.449653020807;11972.461239244254;12479.438425270884;12497.500099995988;12643.43104560297;12424.689382765413;12493;12501.999840012777;12503.437345319437;12506.062045346636;12255.203411778206;12305.953993910529;12308.507659693601;12388;12395.690107747288;12222.511099556006;12305.692357691129;12317.568885088978;12330.19853709515;12338.136330456871;42133;42264.78867605642;42326.57673423257;42336.57663423357;43192;3500;3608.2963822054708;3666.138457462494;3724.422714479233;4403.559644035603;31577.526337104962;31599.2445684771;31603.36793264145;32158.678413215803;32336.514952275735;3240.659730728287;3307.355065762177;3397.524346591479;3414.7951122932704;3460.5155278260813;468694.62610747933;503264.48367758293;516135;525660;528689;57545.71227143921;61579.38420615737;61778.0733289001;61907.380926191065;62148.06777898335;36005.639943600756;36613;36800.07999800026;38284.2343153141;38384.04039898969;17600.38398656041;17763.555911102067;17771.378001769877;17811.73282400765;17819.19813608391;12413.627591172279;12612.81080783789;12613;13435.261060641564;13541.39063742134;16155.788315876356;17772.46682599524;17941.192646330946;19610.313639022566;20690.275840345515;6764.763233286812;7953.602319883983;7960.681572737141;8039;8055.113937466874;860.9397342185987;915.9496227707407;1000.5197505197546;1002.1631937332263;1023.8515415264745;27348.31629209246;30807.075787726404;31658.050258492283;31716.524252135776;32165.839170804466;1090.5583238788304;1110.74452875839;1115.1970581181536;1133.002957397485;1178.4763556964615;16357.018578885067;16469;16494.587635308973;16786.832131678526;16789.91605041967;623501;628067;629796;630271;630301;51697.48302516927;61964.69017654883;62219.6889015552;62495.375046248955;62521.68739156275;1293.489071816646;1327.9203247805162;1392.5474220878052;1413.1591702936737;1439.7336492748666;29731.810727570653;31037.379252415278;31833.8858139964;32106.35787284288;32342.35315293728;49626.75186624044;50297.4910752678;50312;50348.748256258485;50375;439949;441979.79010104743;442350.7882460567;442447;442886;24638;25280.873595631903;26922.192334230003;26986.595201072392;27282.181534553994;50293.74853125711;50391.4882553524;50453;50638.746806265735;50640.49359506358;37714.245715086094;40802.1839563213;41072.589274108075;41631.16737665169;42218.78890605527;40012;40866.1826763469;40876;42151.156976859675;42398.788006059774;38761.224775504896;39481.2103757929;39796.40305395363;39948.80153595397;40078.79960600178;34351.14122146966;35518;36308.63691363052;36385.454218187275;36468.635313646526;20838.583228335046;22799.544009120058;26600.201993940213;26731.732682672926;26767.86616066985 04:30:44 INFO - PROCESS | 1642 | |2;jquery.html;334.5366667165975;392.75452841973765;394.3257030477883;407.6575676431797;415.5864914410162;19791.109400076995;20926.26758063468;21231.57536849264;21525.03137358821;21954.121835126574;17090.401835935743;19232.903835480836;20774.376768696926;20803.687944680805;21339;5982.162497250389;6013.007853704155;6176.783812566561;6199.13212150297;6235.937640623603;4378.2775841986195;4483.058557702886;6125.479334256594;6233.968830155843;6234.064890266451;4455.799489022986;4540.704854184484;6797.082393876813;6869.210040845317;6893.655317234144;5602.691851948141;6745.898811517831;6853.897191542131;6878.65606719662;6887.035814985881;5920.407959204088;5924.200232968537;5925.851853703649;5929.911051334234;5937.050071988504;25534.74465255342;26094.34764130893;26094.608580871303;26117.477650446886;26340.86829565859;2104.6737755647746;2227.5878962392007;2302.125192426884;2348.060775689738;2773.9306517337227;9733.56198971048;10070.9496452518;10355.01627345401;10510.316829406063;10878.945605272002;1877.3898482992945;1882.218879165145;1889.896055716935;1913.5024893527643;1933.6132773445368;89312.6460957242;90767.09232907652;91416.99999999933;98765.5061724694;125504;10526.841997390517;11736.295822250693;11794.410279485992;11930.940345298392;11959.40202989847;14735.705285894222;14758;14922.552323430315;14949.925250373895;14958.252087395587;8824.558772061371;8830.116988301246;8854.690085846965;8878.245349145394;8975.685850995184;8880.777980550538;8941.910580894239;8944.68693595721;9044.502552359552;9095.31785116119;3742.8128593570214;4568.063546972862;4588.197065513522;4593.678442509059;4648.907021859612;1914.4926594452481;1959.2358979997812;1965.77393599735;1992.1433783472955;2002.3292197113838;843.3927572148043;895.2479916869861;934.1965909317981;970.679675707015;983.4640121133999;19725.704114438297;20877.79122208789;20917.790822091887;20958.580828383347;21080.472988175417;955.780170560761;973.1484950668165;984.960601575929;1003.3879333606494;1014.8173328800887;10586.311889727143;10924.672259832218;11169.497372618089;12061.939690301493;12358.011359091252;625573;627406;631013;638713.8064309742;639952;130763;131617;134002;134168;138775;992.538469611634;1018.5060245780791;1021.9795604087876;1059.7456610413599;1064.4730858225228;18652.81347186565;19086.7136992948;19533.023348832787;19613.70579441281;19661.11524981408;52615.94768104693;54493.72753136209;54609.72695136499;55099;56567;79239.60380198061;79632;81272;82812.3437531234;83075;7115.5730656160795;7135.928640713734;7364.742234021998;7446.478746487694;7892.0924093729955;9374.625014999323;10432.791344173225;11955.76088478243;12909;13038.348082596021;11346.825815571667;11612.88387116118;11639;11646.70883227926;11743.88256117428;11036.944815275872;11090.279131856403;11239.494222760159;11336.09311255081;11707.356095414834;11337.603183888525;11363.261388009752;11555.306681599131;11617.88382116168;11834.644960651194;7310.81722956909;7344.265573442826;7584.734534291273;7611.972383728126;7676.80807979805;10568.84146737815;10791.56833726642;10838.078763305208;11388.14588905852;11543.653690389301 04:30:44 INFO - PROCESS | 1642 | |3;mootools.html;1394.5049507424865;1396.5321617258219;1532.3564103076706;1710.7690461787654;1906.3994841624888;8039.155888631697;8594.269487093597;8647.783805404868;9100.226480749145;9100.36297459178;9073.909260907389;9079.273658107351;9080.182783549479;9080.27357811375;9135.68025119121;2204.8236141108673;2402.3393566769146;2433.9047428657086;2434.6713193718797;2435.257246539805;2238.8656680599133;2372.300171449418;2416.8066554675584;2416.9516609667794;2420.3465064432594;2370.7392186859433;2372.351215904947;2384.8688322142275;2406.0856874387796;2408.2654790288957;2352.094443639194;2372.2764556810166;2372.3630694820604;2376.9762302376926;2395.484970731301;2091.5294058836794;2369.277370402027;2372.893219805113;2376.4652953085592;2377.4413012941945;7586.544807311524;8095.797605059862;8635.266002389804;8652.264557512619;8652.437591556529;5289.576833853283;5532.972335138339;5536.501714845643;5572.498475137217;5576.944230557724;3055.7860949733526;3068.401661675974;3602.2975519773654;3610.277944411102;3654.9086272843124;1070.0530030922612;1085.2457542008308;1087.1357270969597;1105.182165197748;1109.312226419617;12056.758864822654;12121.151519393647;12205.38973051344;12212.389380530938;12222.938885305517;3951.427043078795;4542.0915816836105;4559.977200113978;4732.6687131900435;4738.147133515931;9515.57179926905;9529.285303602257;9539.18916892058;9549.713508594754;9557.426554406758;5391.4608539145775;5398.109311963561;5405.8107966221;5408.4050754416985;5414.945850541523;4286.357046443059;4507.887302817456;4670.789814458358;4685.5782979532005;5063.974680126649;3851.980740096282;3881.7088718346236;3931.977685801712;3972.900677483086;3981.6217459341315;1167.287954347847;1174.8590169179754;1174.9588764393377;1181.3048275724364;1189.601483503019;920.6212209143719;924.8011677489372;931.6413180925392;949.9335046546676;985.4629227071264;5832.358440571534;5872.17789509469;6046.667433291123;6168.383161683885;6185.288691800411;434.96520278377653;453.62575874903337;456.4818930513891;459.2193271438568;463.9257718764981;4036.798160091984;4058.939115913264;4094.7952602369764;4094.9385759213637;4167.97916010418;10597.735056623646;11117;11119;11123.666290011313;11134.777304453866;10972.835407468894;11039.172062095375;11040.116790656728;11067.778644427066;11087.83368249477;7957.920420795718;8402.075771665111;8496.107908669625;8497.405181637227;8518.679604661287;6037.154798328325;6092.238470191226;6132.540059495466;6250.406211409909;6318.336574659595;10346.689599312032;10378.117859981987;10495.317804342692;10524.421156836448;10528.473576321307;8831.293496520391;10332.741681458023;10493.737656558647;10510.421926794099;10656.9875861793;7208.387287080657;7479.2894675007965;7546.584937828472;7549.811254718676;7552.055993000875;8482.194191551793;8499.10759370282;8518.744437666632;8599.52702601363;8621.91378086211;7777.533347999138;7793.688252469838;7816.140224575406;7826.334761545105;7828.76513704567;7543.207963163789;7585;7588.962055189689;7613.124490683642;7637.6563054661565;6032.668203248863;7165.068541089625;7171.533850299714;7254.238304977901;7264.782056538313;5026.673266237683;5050.949490505195;5058.671186372874;5109.08036553424;5122.410922743783;5017.84946451607;5119.257707632447;5135.35808023997;5164.7417629119145;5192.247124166899 04:30:44 INFO - PROCESS | 1642 | |4;prototype.html;304.5827216713103;307.97382222511084;315.8247172819086;319.5925195375897;321.25148404218174;5178.11971964766;5478.397376288605;5504.972475137629;5504.990678402384;5512.669239845602;4257.936130958038;4318.352247162927;4806.327114204014;5077.8067154218825;5340.893182136365;4089.5092588889374;4096.487939007624;4112.547619761839;4118.588141185873;4163.188178305231;4084.5915408459214;4092.7339722917914;4103.712740108193;4152.771597562133;4166.208420400129;3808.6953043756434;4029.8992525186814;4082.2243773682903;4097.795110244476;4103.302438585432;4081.9387709184384;4088.284550203732;4099.077707515815;4132.194222126672;4142.984968682692;3476.0093373388463;3548.1661809475013;3553.6979356754705;3572.821358932069;3580.1765593913287;4064.5325787534516;4559.316102584606;5251.186066159751;5358.169483729989;5367.141257398836;4057.9594204057876;4526.0495295987885;4703.858884233444;4773.4510531289;4796.208625576811;5289.78334982956;5746.454086861741;5763.740631671585;5804.912926306067;5819.24349834523;3647.4893514907935;3748.850045998157;3756.7978246960984;3973.940390894139;4002.2795896738576;5915.112733090071;5987.37132601075;5994.97002514989;6002.118982888238;6009.699515024231;3330.816805075744;3701.0747313171705;3738.3924912287976;3963.4649322341693;3970.4242884781543;3907.6323286849374;4033.032072302626;4067.654249388835;4080.3063479208604;4089.85685501012;3640.180959284193;4097.09863829957;4709.175894218498;4752.669252609275;4754.4532378776885;5829.621074630136;5836.8540786479825;5836.941630583725;5912;5924.7333869975955;1205.3551350027692;1266.5503746169977;1299.142565906516;1364.40648317982;1405.4027038508593;734.9118105827334;755.8488302339554;779.3842864137381;841.6843683618642;857.6397912876607;3593.2152581748833;3764.6635444417384;3910.2961466936226;4402.939956730042;4408.2807704995075;4183.218159923677;4902.48523904992;4968.652194346361;5007.072277173314;5089.745512724349;4543.318502224693;4569.95430045702;4942.703437793743;5497.670139791625;5521.806736764194;2602.6986506746625;2989.805662631922;2993.580898674187;3113.4395808754643;3155.826429546397;5573.41479144692;5798.449147331081;6024.728887200086;6185.402131104946;6209.223847019122;5353.277307563507;6048.429417497546;6099.69501524922;6103.176071230416;6126.387361263838;4985.376827896513;6128;6137.232845894263;6179.320274769681;6230.345813689588;5226.712530810842;5536.7819079802375;5773.884522309446;5927.496162826208;6003.339632640494;5782.5254560086905;5827.038538641246;5869;5899.67551784656;5907.409259074058;5775.6823374714795;6123.479504242011;6136;6139.447449729546;6146.170267013896;3264.2002709336366;3992.5608183100417;4010.6911797766375;4016.59834016596;4025.9597404025585;4950.653454258168;5472.835814925558;5899.46904778572;5989.3711160329285;6042.728077236447;4878.682885612424;5814.360420353673;5888.528917686489;5925.674087925206;5945.910811337747;5015.498450154955;5054.646174767878;5606.775728970795;5778.157525245664;5787.826365209051;4903.656744027884;5227.790888364575;5584.581156413204;5658.5190258826815;5676.25367257608;5281.468374171447;5508.9724551376985;5826.82519524415;5830.950428922834;5853.590248682552;4422.65109141702;5305.938812237645;5404.567634589145;5408.432114627907;5548.889022219614 04:30:44 INFO - PROCESS | 1642 | |5;yui.html;703.8416356319832;714.8355878148026;740.9814754631135;768.6963649358504;808.7412028150992;15559.455419060321;16714.498565043068;16716.080615566156;16750;16761.664766704675;15085.472008479705;15215.78273738101;15238;15239.466618668348;15241.237938103079;720.1825927572204;734.1557209209399;735.3565630073685;877.7366789963017;892.5715656484891;901.2339511415311;908.7637214324291;913.9177474027337;915.6245939164944;917.7889085510336;968.109339407743;968.8207681578931;969.050330675938;970.6845275285525;972.3922548407245;961.2262128986198;962.8074385123003;963.4171326347599;964.3779762053506;965.2181732796457;715.7244460882546;716.4161208615014;716.9818857222756;718.0772707071388;719.1980941250521;15616.141112238822;15653.217339133113;15658.921705391514;15663.686726265525;15666.373345066184;11800.763984720343;12929.771671691175;13068.673283167902;13418;13761.587152385344;13387.263700496469;13552.457901683922;13683.24742139182;13690.794638080437;13759.587212383645;4716.056788642251;4759.309900064506;4763.928541071887;4804.543568361;4924.482929292444;99392.50911236338;123194;124149;125308;125618;10704.411257380763;10928.945355273172;11496.195266331444;11518.654440366803;11567.958883700507;21842.344729658136;21844.12623495074;21860.234891778713;21885;21904.89047554784;6641.672199729467;8276.131006244377;8305;8356.874646880302;8365.038020627584;4561.361409402686;4611.054733779567;4655.86032419028;4662.090892276042;4664.790084446208;3656.1590834108306;3815.1606646537716;3818.1790914953417;3819.8472061117245;3821.694264458892;686.993130068703;687.3470203306879;688.3426327856885;703.5005146346151;709.5742554467381;674.5918719174927;689.5971743335292;708.2846325211574;724.1635910523248;735.8565079809385;9820.705378838646;9932.851007234898;9978.101970822516;10165.339252948683;10196.286259961731;538.7629443045048;539.2746755613693;693.5353313280115;700.3626699703245;713.8358177619177;3917.9020524487114;4828.203346447867;4914.1054691009385;4945.128512841369;4987.900241995139;110936;152843.2357838226;153547;157454;162281.37718622663;131319;132794;135285;136267;137423;114727.37856542307;115135.84864151251;116052.41973790077;116722;117048.41475792737;9559.761005974906;9696.981816909405;9911.306208565331;9926.52155829745;9938.254630902567;55258.89482210253;59613.40386596078;62992;64107.39731506563;66749.66625166843;70920.29079709137;77209;89274;92003;95103.52448237715;12960.35198240103;13312.267825269702;13329.333533323488;13906.096103753223;13991.370388332753;15006.549803505912;15161.393544258106;15468.84531154674;15544.922275388551;16022.919885400499;14385;14461.421543138156;14530.854691453373;14711.485098021518;15411.61470963235;13875.79186312186;14796.48212312564;14992.175430351435;15401.768973465183;15566.533004009898;11426.714332141762;13992.720145597235;14834.851651483346;14845.331960061607;14963.476278330207;8831.558422078999;11344.489497972776;11552;11986.220895641756;12066.818997715216;10232.386056836614;11871.228370155912;11992.520299188283;12103.576374826838;12145.392730363623 04:30:44 INFO - PROCESS | 1642 | __end_tp_report 04:30:44 INFO - PROCESS | 1642 | __start_cc_report 04:30:44 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1132 04:30:44 INFO - PROCESS | 1642 | __end_cc_report 04:30:44 INFO - PROCESS | 1642 | __startTimestamp1481545844273__endTimestamp 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | ------- Summary: start ------- 04:30:44 INFO - PROCESS | 1642 | Number of tests: 6 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5829.04 Median:6115.13 stddev:643.79 (10.5%) stddev-sans-first:617.58 04:30:44 INFO - PROCESS | 1642 | Values: 3427.1 3430.5 3467.0 3481.1 3501.6 5666.6 5748.0 5785.8 5791.1 5814.6 5746.7 5747.0 5760.6 5772.8 5780.4 5182.7 5231.0 5271.7 5279.4 5281.3 5183.8 5200.7 5204.8 5318.5 5324.2 5277.9 5297.3 5301.0 5303.4 5310.7 5289.5 5305.1 5345.5 5348.5 5369.7 5154.4 5243.6 5307.1 5313.2 5331.1 5681.5 5714.0 5721.9 5771.2 5794.0 6216.4 6292.2 6292.4 6331.3 6347.1 6308.6 6357.5 6363.7 6382.0 6390.6 4766.6 5803.7 5825.9 5864.0 5880.7 6303.8 6326.4 6328.0 6347.3 6422.7 6246.8 6250.0 6254.7 6258.0 6276.2 6188.7 6224.3 6276.9 6277.1 6311.9 5216.4 6234.3 6298.9 6320.2 6321.4 6279.4 6327.1 6342.3 6346.5 6347.5 4966.3 5023.6 5054.4 5056.8 5081.8 4523.3 4529.7 4573.2 4579.4 4583.0 5866.8 5871.4 5872.7 5883.9 5900.7 6225.4 6272.4 6342.4 6346.4 6353.9 5716.4 5813.4 5816.4 5880.1 5917.4 5488.6 5549.9 5554.3 5567.2 5577.4 5639.6 6277.6 6342.4 6390.8 6398.9 6290.5 6328.7 6354.5 6361.9 6366.3 6386.0 6389.6 6395.0 6395.6 6400.3 6132.4 6270.2 6349.5 6364.8 6374.8 6256.7 6283.9 6287.6 6292.3 6334.1 6073.1 6296.5 6311.8 6319.5 6329.1 6250.2 6273.4 6284.6 6289.4 6296.7 5939.4 5979.1 6075.2 6115.1 6133.9 6265.8 6274.7 6275.7 6284.0 6286.8 5971.9 6165.7 6168.1 6168.6 6181.1 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:67004.43 Median:19958.47 stddev:141747.71 (710.2%) stddev-sans-first:142057.33 04:30:44 INFO - PROCESS | 1642 | Values: 470.8 481.9 503.3 526.0 546.8 31816.7 41513.0 43087.0 43423.1 45266.5 44729.0 45233.5 45334.0 45334.1 45395.5 9102.6 9896.7 10069.2 10088.1 10094.9 9172.4 11972.5 12479.4 12497.5 12643.4 12424.7 12493.0 12502.0 12503.4 12506.1 12255.2 12306.0 12308.5 12388.0 12395.7 12222.5 12305.7 12317.6 12330.2 12338.1 42133.0 42264.8 42326.6 42336.6 43192.0 3500.0 3608.3 3666.1 3724.4 4403.6 31577.5 31599.2 31603.4 32158.7 32336.5 3240.7 3307.4 3397.5 3414.8 3460.5 468694.6 503264.5 516135.0 525660.0 528689.0 57545.7 61579.4 61778.1 61907.4 62148.1 36005.6 36613.0 36800.1 38284.2 38384.0 17600.4 17763.6 17771.4 17811.7 17819.2 12413.6 12612.8 12613.0 13435.3 13541.4 16155.8 17772.5 17941.2 19610.3 20690.3 6764.8 7953.6 7960.7 8039.0 8055.1 860.9 915.9 1000.5 1002.2 1023.9 27348.3 30807.1 31658.1 31716.5 32165.8 1090.6 1110.7 1115.2 1133.0 1178.5 16357.0 16469.0 16494.6 16786.8 16789.9 623501.0 628067.0 629796.0 630271.0 630301.0 51697.5 61964.7 62219.7 62495.4 62521.7 1293.5 1327.9 1392.5 1413.2 1439.7 29731.8 31037.4 31833.9 32106.4 32342.4 49626.8 50297.5 50312.0 50348.7 50375.0 439949.0 441979.8 442350.8 442447.0 442886.0 24638.0 25280.9 26922.2 26986.6 27282.2 50293.7 50391.5 50453.0 50638.7 50640.5 37714.2 40802.2 41072.6 41631.2 42218.8 40012.0 40866.2 40876.0 42151.2 42398.8 38761.2 39481.2 39796.4 39948.8 40078.8 34351.1 35518.0 36308.6 36385.5 36468.6 20838.6 22799.5 26600.2 26731.7 26767.9 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35843.68 Median:26094.48 stddev:105102.56 (402.8%) stddev-sans-first:105363.58 04:30:44 INFO - PROCESS | 1642 | Values: 334.5 392.8 394.3 407.7 415.6 19791.1 20926.3 21231.6 21525.0 21954.1 17090.4 19232.9 20774.4 20803.7 21339.0 5982.2 6013.0 6176.8 6199.1 6235.9 4378.3 4483.1 6125.5 6234.0 6234.1 4455.8 4540.7 6797.1 6869.2 6893.7 5602.7 6745.9 6853.9 6878.7 6887.0 5920.4 5924.2 5925.9 5929.9 5937.1 25534.7 26094.3 26094.6 26117.5 26340.9 2104.7 2227.6 2302.1 2348.1 2773.9 9733.6 10070.9 10355.0 10510.3 10878.9 1877.4 1882.2 1889.9 1913.5 1933.6 89312.6 90767.1 91417.0 98765.5 125504.0 10526.8 11736.3 11794.4 11930.9 11959.4 14735.7 14758.0 14922.6 14949.9 14958.3 8824.6 8830.1 8854.7 8878.2 8975.7 8880.8 8941.9 8944.7 9044.5 9095.3 3742.8 4568.1 4588.2 4593.7 4648.9 1914.5 1959.2 1965.8 1992.1 2002.3 843.4 895.2 934.2 970.7 983.5 19725.7 20877.8 20917.8 20958.6 21080.5 955.8 973.1 985.0 1003.4 1014.8 10586.3 10924.7 11169.5 12061.9 12358.0 625573.0 627406.0 631013.0 638713.8 639952.0 130763.0 131617.0 134002.0 134168.0 138775.0 992.5 1018.5 1022.0 1059.7 1064.5 18652.8 19086.7 19533.0 19613.7 19661.1 52615.9 54493.7 54609.7 55099.0 56567.0 79239.6 79632.0 81272.0 82812.3 83075.0 7115.6 7135.9 7364.7 7446.5 7892.1 9374.6 10432.8 11955.8 12909.0 13038.3 11346.8 11612.9 11639.0 11646.7 11743.9 11036.9 11090.3 11239.5 11336.1 11707.4 11337.6 11363.3 11555.3 11617.9 11834.6 7310.8 7344.3 7584.7 7612.0 7676.8 10568.8 10791.6 10838.1 11388.1 11543.7 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5783.31 Median:4709.12 stddev:3307.15 (70.2%) stddev-sans-first:3299.98 04:30:44 INFO - PROCESS | 1642 | Values: 1394.5 1396.5 1532.4 1710.8 1906.4 8039.2 8594.3 8647.8 9100.2 9100.4 9073.9 9079.3 9080.2 9080.3 9135.7 2204.8 2402.3 2433.9 2434.7 2435.3 2238.9 2372.3 2416.8 2417.0 2420.3 2370.7 2372.4 2384.9 2406.1 2408.3 2352.1 2372.3 2372.4 2377.0 2395.5 2091.5 2369.3 2372.9 2376.5 2377.4 7586.5 8095.8 8635.3 8652.3 8652.4 5289.6 5533.0 5536.5 5572.5 5576.9 3055.8 3068.4 3602.3 3610.3 3654.9 1070.1 1085.2 1087.1 1105.2 1109.3 12056.8 12121.2 12205.4 12212.4 12222.9 3951.4 4542.1 4560.0 4732.7 4738.1 9515.6 9529.3 9539.2 9549.7 9557.4 5391.5 5398.1 5405.8 5408.4 5414.9 4286.4 4507.9 4670.8 4685.6 5064.0 3852.0 3881.7 3932.0 3972.9 3981.6 1167.3 1174.9 1175.0 1181.3 1189.6 920.6 924.8 931.6 949.9 985.5 5832.4 5872.2 6046.7 6168.4 6185.3 435.0 453.6 456.5 459.2 463.9 4036.8 4058.9 4094.8 4094.9 4168.0 10597.7 11117.0 11119.0 11123.7 11134.8 10972.8 11039.2 11040.1 11067.8 11087.8 7957.9 8402.1 8496.1 8497.4 8518.7 6037.2 6092.2 6132.5 6250.4 6318.3 10346.7 10378.1 10495.3 10524.4 10528.5 8831.3 10332.7 10493.7 10510.4 10657.0 7208.4 7479.3 7546.6 7549.8 7552.1 8482.2 8499.1 8518.7 8599.5 8621.9 7777.5 7793.7 7816.1 7826.3 7828.8 7543.2 7585.0 7589.0 7613.1 7637.7 6032.7 7165.1 7171.5 7254.2 7264.8 5026.7 5050.9 5058.7 5109.1 5122.4 5017.8 5119.3 5135.4 5164.7 5192.2 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4577.54 Median:4996.22 stddev:1447.76 (29.0%) stddev-sans-first:1415.85 04:30:44 INFO - PROCESS | 1642 | Values: 304.6 308.0 315.8 319.6 321.3 5178.1 5478.4 5505.0 5505.0 5512.7 4257.9 4318.4 4806.3 5077.8 5340.9 4089.5 4096.5 4112.5 4118.6 4163.2 4084.6 4092.7 4103.7 4152.8 4166.2 3808.7 4029.9 4082.2 4097.8 4103.3 4081.9 4088.3 4099.1 4132.2 4143.0 3476.0 3548.2 3553.7 3572.8 3580.2 4064.5 4559.3 5251.2 5358.2 5367.1 4058.0 4526.0 4703.9 4773.5 4796.2 5289.8 5746.5 5763.7 5804.9 5819.2 3647.5 3748.9 3756.8 3973.9 4002.3 5915.1 5987.4 5995.0 6002.1 6009.7 3330.8 3701.1 3738.4 3963.5 3970.4 3907.6 4033.0 4067.7 4080.3 4089.9 3640.2 4097.1 4709.2 4752.7 4754.5 5829.6 5836.9 5836.9 5912.0 5924.7 1205.4 1266.6 1299.1 1364.4 1405.4 734.9 755.8 779.4 841.7 857.6 3593.2 3764.7 3910.3 4402.9 4408.3 4183.2 4902.5 4968.7 5007.1 5089.7 4543.3 4570.0 4942.7 5497.7 5521.8 2602.7 2989.8 2993.6 3113.4 3155.8 5573.4 5798.4 6024.7 6185.4 6209.2 5353.3 6048.4 6099.7 6103.2 6126.4 4985.4 6128.0 6137.2 6179.3 6230.3 5226.7 5536.8 5773.9 5927.5 6003.3 5782.5 5827.0 5869.0 5899.7 5907.4 5775.7 6123.5 6136.0 6139.4 6146.2 3264.2 3992.6 4010.7 4016.6 4026.0 4950.7 5472.8 5899.5 5989.4 6042.7 4878.7 5814.4 5888.5 5925.7 5945.9 5015.5 5054.6 5606.8 5778.2 5787.8 4903.7 5227.8 5584.6 5658.5 5676.3 5281.5 5509.0 5826.8 5831.0 5853.6 4422.7 5305.9 5404.6 5408.4 5548.9 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:25542.00 Median:3735.66 stddev:40612.12 (1087.1%) stddev-sans-first:40683.22 04:30:44 INFO - PROCESS | 1642 | Values: 703.8 714.8 741.0 768.7 808.7 15559.5 16714.5 16716.1 16750.0 16761.7 15085.5 15215.8 15238.0 15239.5 15241.2 720.2 734.2 735.4 877.7 892.6 901.2 908.8 913.9 915.6 917.8 968.1 968.8 969.1 970.7 972.4 961.2 962.8 963.4 964.4 965.2 715.7 716.4 717.0 718.1 719.2 15616.1 15653.2 15658.9 15663.7 15666.4 11800.8 12929.8 13068.7 13418.0 13761.6 13387.3 13552.5 13683.2 13690.8 13759.6 4716.1 4759.3 4763.9 4804.5 4924.5 99392.5 123194.0 124149.0 125308.0 125618.0 10704.4 10928.9 11496.2 11518.7 11568.0 21842.3 21844.1 21860.2 21885.0 21904.9 6641.7 8276.1 8305.0 8356.9 8365.0 4561.4 4611.1 4655.9 4662.1 4664.8 3656.2 3815.2 3818.2 3819.8 3821.7 687.0 687.3 688.3 703.5 709.6 674.6 689.6 708.3 724.2 735.9 9820.7 9932.9 9978.1 10165.3 10196.3 538.8 539.3 693.5 700.4 713.8 3917.9 4828.2 4914.1 4945.1 4987.9 110936.0 152843.2 153547.0 157454.0 162281.4 131319.0 132794.0 135285.0 136267.0 137423.0 114727.4 115135.8 116052.4 116722.0 117048.4 9559.8 9697.0 9911.3 9926.5 9938.3 55258.9 59613.4 62992.0 64107.4 66749.7 70920.3 77209.0 89274.0 92003.0 95103.5 12960.4 13312.3 13329.3 13906.1 13991.4 15006.5 15161.4 15468.8 15544.9 16022.9 14385.0 14461.4 14530.9 14711.5 15411.6 13875.8 14796.5 14992.2 15401.8 15566.5 11426.7 13992.7 14834.9 14845.3 14963.5 8831.6 11344.5 11552.0 11986.2 12066.8 10232.4 11871.2 11992.5 12103.6 12145.4 04:30:44 INFO - PROCESS | 1642 | -------- Summary: end -------- 04:30:44 INFO - PROCESS | 1642 | 04:30:44 INFO - TEST-INFO | 1642: exit 0 04:30:44 INFO - TEST-OK | dromaeo_css | took 1114869ms 04:30:44 INFO - TEST-START | kraken 04:30:44 INFO - operating with platform_type : mac_ 04:30:44 INFO - Initialising browser for kraken test... 04:30:44 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpvfLIdy/profile http://localhost:49246/getInfo.html) 04:30:46 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:30:46 INFO - PROCESS | 1652 | colorDepth:24 04:30:46 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:30:46 INFO - PROCESS | 1652 | __metrics 04:30:46 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:30:46 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:30:47 INFO - TEST-INFO | 1652: exit 0 04:30:47 INFO - Browser initialized. 04:30:47 INFO - Running cycle 1/1 for kraken test... 04:30:47 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpvfLIdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:59 INFO - PROCESS | 1654 | RSS: Main: 169140224 04:30:59 INFO - PROCESS | 1654 | 04:31:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:03 INFO - PROCESS | 1654 | RSS: Main: 218849280 04:31:03 INFO - PROCESS | 1654 | 04:31:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 04:31:06 INFO - PROCESS | 1654 | RSS: Main: 233537536 04:31:06 INFO - PROCESS | 1654 | 04:31:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 04:31:10 INFO - PROCESS | 1654 | RSS: Main: 330706944 04:31:10 INFO - PROCESS | 1654 | 04:31:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 04:31:12 INFO - PROCESS | 1654 | RSS: Main: 230010880 04:31:12 INFO - PROCESS | 1654 | 04:31:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:15 INFO - PROCESS | 1654 | RSS: Main: 230395904 04:31:15 INFO - PROCESS | 1654 | 04:31:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:18 INFO - PROCESS | 1654 | RSS: Main: 266833920 04:31:18 INFO - PROCESS | 1654 | 04:31:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:22 INFO - PROCESS | 1654 | RSS: Main: 269414400 04:31:22 INFO - PROCESS | 1654 | 04:31:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 04:31:25 INFO - PROCESS | 1654 | RSS: Main: 265158656 04:31:25 INFO - PROCESS | 1654 | 04:31:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:27 INFO - PROCESS | 1654 | RSS: Main: 241405952 04:31:27 INFO - PROCESS | 1654 | 04:31:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:30 INFO - PROCESS | 1654 | RSS: Main: 246763520 04:31:30 INFO - PROCESS | 1654 | 04:31:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:33 INFO - PROCESS | 1654 | RSS: Main: 250400768 04:31:33 INFO - PROCESS | 1654 | 04:31:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:36 INFO - PROCESS | 1654 | RSS: Main: 263651328 04:31:36 INFO - PROCESS | 1654 | 04:31:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:40 INFO - PROCESS | 1654 | RSS: Main: 257474560 04:31:40 INFO - PROCESS | 1654 | 04:31:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 04:31:42 INFO - PROCESS | 1654 | RSS: Main: 301203456 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | __start_tp_report 04:31:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 04:31:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 04:31:42 INFO - PROCESS | 1654 | |i|pagename|runs| 04:31:42 INFO - PROCESS | 1654 | |0;ai-astar;115;113;112;112;112;114;114;112;114;112 04:31:42 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;107;112;168;134;108;107;106;137;107 04:31:42 INFO - PROCESS | 1654 | |2;audio-dft;182;183;179;185;183;181;182;184;183;184 04:31:42 INFO - PROCESS | 1654 | |3;audio-fft;79;59;58;89;61;62;58;59;81;58 04:31:42 INFO - PROCESS | 1654 | |4;audio-oscillator;89;70;92;71;68;70;91;68;69;90 04:31:42 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;85;89;85;86;84;88;85;87;84 04:31:42 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;93;93;93;97;93;93;94;103;93 04:31:42 INFO - PROCESS | 1654 | |7;imaging-desaturate;85;85;91;141;143;85;92;135;86;84 04:31:42 INFO - PROCESS | 1654 | |8;json-parse-financial;56;51;52;52;55;58;57;56;56;56 04:31:42 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;64;70;67;79;74;70;69;67;67;68 04:31:42 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;83;90;92;101;77;84;97;99;86;87 04:31:42 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;135;136;134;134;131;142;154;189;132 04:31:42 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;159;162;158;160;160;172;220;193;161;157 04:31:42 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;67;67;65;65;65;65;64;64;65 04:31:42 INFO - PROCESS | 1654 | __end_tp_report 04:31:42 INFO - PROCESS | 1654 | __start_cc_report 04:31:42 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1901 04:31:42 INFO - PROCESS | 1654 | __end_cc_report 04:31:42 INFO - PROCESS | 1654 | __startTimestamp1481545902116__endTimestamp 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | ------- Summary: start ------- 04:31:42 INFO - PROCESS | 1654 | Number of tests: 14 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.15 (1.0%) stddev-sans-first:0.97 04:31:42 INFO - PROCESS | 1654 | Values: 115.0 113.0 112.0 112.0 112.0 114.0 114.0 112.0 114.0 112.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:123.00 stddev:21.91 (17.8%) stddev-sans-first:21.49 04:31:42 INFO - PROCESS | 1654 | Values: 147.0 107.0 112.0 168.0 134.0 108.0 107.0 106.0 137.0 107.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.71 (0.9%) stddev-sans-first:1.80 04:31:42 INFO - PROCESS | 1654 | Values: 182.0 183.0 179.0 185.0 183.0 181.0 182.0 184.0 183.0 184.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:11.80 (19.2%) stddev-sans-first:11.60 04:31:42 INFO - PROCESS | 1654 | Values: 79.0 59.0 58.0 89.0 61.0 62.0 58.0 59.0 81.0 58.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:10.99 (13.7%) stddev-sans-first:10.89 04:31:42 INFO - PROCESS | 1654 | Values: 89.0 70.0 92.0 71.0 68.0 70.0 91.0 68.0 69.0 90.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.50 stddev:1.70 (2.0%) stddev-sans-first:1.76 04:31:42 INFO - PROCESS | 1654 | Values: 87.0 85.0 89.0 85.0 86.0 84.0 88.0 85.0 87.0 84.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:93.00 stddev:3.24 (3.5%) stddev-sans-first:3.39 04:31:42 INFO - PROCESS | 1654 | Values: 93.0 93.0 93.0 93.0 97.0 93.0 93.0 94.0 103.0 93.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:85.00 stddev:25.72 (30.3%) stddev-sans-first:26.47 04:31:42 INFO - PROCESS | 1654 | Values: 85.0 85.0 91.0 141.0 143.0 85.0 92.0 135.0 86.0 84.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:56.00 stddev:2.38 (4.2%) stddev-sans-first:2.49 04:31:42 INFO - PROCESS | 1654 | Values: 56.0 51.0 52.0 52.0 55.0 58.0 57.0 56.0 56.0 56.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:4.25 (6.1%) stddev-sans-first:4.01 04:31:42 INFO - PROCESS | 1654 | Values: 64.0 70.0 67.0 79.0 74.0 70.0 69.0 67.0 67.0 68.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:88.50 stddev:7.69 (8.7%) stddev-sans-first:7.78 04:31:42 INFO - PROCESS | 1654 | Values: 83.0 90.0 92.0 101.0 77.0 84.0 97.0 99.0 86.0 87.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:136.00 stddev:17.71 (13.0%) stddev-sans-first:18.63 04:31:42 INFO - PROCESS | 1654 | Values: 136.0 135.0 136.0 134.0 134.0 131.0 142.0 154.0 189.0 132.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:161.50 stddev:20.58 (12.7%) stddev-sans-first:21.42 04:31:42 INFO - PROCESS | 1654 | Values: 159.0 162.0 158.0 160.0 160.0 172.0 220.0 193.0 161.0 157.0 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 04:31:42 INFO - PROCESS | 1654 | Values: 66.0 67.0 67.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 04:31:42 INFO - PROCESS | 1654 | -------- Summary: end -------- 04:31:42 INFO - PROCESS | 1654 | 04:31:42 INFO - TEST-INFO | 1654: exit 0 04:31:43 INFO - TEST-OK | kraken | took 58188ms 04:31:43 INFO - SUITE-END | took 1173s 04:31:43 INFO - Completed test suite (00:19:33) 04:31:43 INFO - javascript benchmark 04:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.0746898337457, 3430.4511278195487, 3466.9826650866744, 3481.147118955856, 3501.5973163086237, 5666.631668941516, 5747.994101032324, 5785.7685692572295, 5791.07342825148, 5814.563907706923, 5746.7413966371505, 5747.023006088964, 5760.56795740319, 5772.826815195551, 5780.364159942403, 5182.714950677711, 5231.0, 5271.657342272759, 5279.3928698199625, 5281.339832520935, 5183.844484665466, 5200.6619569727845, 5204.817831375903, 5318.521333080022, 5324.1747529133045, 5277.894442111175, 5297.337832770903, 5301.045811753883, 5303.363596368441, 5310.681359118446, 5289.523942845143, 5305.071612467803, 5345.518903298683, 5348.465153484621, 5369.704666243355, 5154.38147422308, 5243.575579523101, 5307.124324486494, 5313.1764576490705, 5331.093714068617, 5681.517071048966, 5714.0, 5721.914171287434, 5771.163181338682, 5794.043982742843, 6216.440520353145, 6292.182016337847, 6292.433680968735, 6331.2719037310835, 6347.079673447324, 6308.558400911938, 6357.4914006879335, 6363.681815909233, 6382.042693595951, 6390.584612000252, 4766.618670506351, 5803.738831752539, 5825.854353641108, 5863.9706801466145, 5880.676562789087, 6303.779367722108, 6326.43062124411, 6327.96836015817, 6347.270063942613, 6422.678866056678, 6246.781362652286, 6249.96875015622, 6254.749810007549, 6258.0, 6276.152719382825, 6188.659623720649, 6224.284207316216, 6276.905846412307, 6277.121203031579, 6311.936880631135, 5216.400113986864, 6234.2830574483605, 6298.937010629835, 6320.209973753281, 6321.399467050623, 6279.3720627937755, 6327.145835312266, 6342.302346741854, 6346.524010699216, 6347.492200623939, 4966.329545511309, 5023.572996295356, 5054.393472783289, 5056.797728090909, 5081.771320290596, 4523.253663145544, 4529.68292219548, 4573.153966516205, 4579.404677391918, 4582.991741816795, 5866.794662186803, 5871.442212989759, 5872.706364681834, 5883.882322353529, 5900.675462849498, 6225.439710425992, 6272.435480806749, 6342.429181373698, 6346.428821406095, 6353.872922541524, 5716.428357164334, 5813.447722466443, 5816.41835816415, 5880.059190529495, 5917.378675239124, 5488.56091512678, 5549.889002220014, 5554.2779438672715, 5567.248421463131, 5577.414371491016, 5639.6334238274385, 6277.623342599459, 6342.39747224013, 6390.7763228286785, 6398.936010639834, 6290.528210384148, 6328.683565821782, 6354.523410744305, 6361.936380636134, 6366.331535188739, 6385.968070159805, 6389.616623002635, 6395.008773640093, 6395.552311338348, 6400.295967443671, 6132.4166970161305, 6270.184875966095, 6349.49204063683, 6364.77723279683, 6374.808755737336, 6256.749730010749, 6283.874322513616, 6287.591306565058, 6292.276388215414, 6334.081558174131, 6073.089036644362, 6296.496280297473, 6311.842203944938, 6319.46284565817, 6329.145565348619, 6250.218722659668, 6273.37266273369, 6284.560080794484, 6289.433950944437, 6296.685165741603, 5939.376365481562, 5979.133025711334, 6075.210222671025, 6115.125890831302, 6133.938660613515, 6265.780697675559, 6274.717637706223, 6275.686215689106, 6284.0, 6286.842828929313, 5971.880562388641, 6165.691715414122, 6168.1056246844855, 6168.629882207082, 6181.103739957771], "value": 5788.753797030615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.7740284663362, 481.8674864412284, 503.2853348245491, 526.0452279113409, 546.8195495486489, 31816.68183318169, 41512.96217594561, 43087.0, 43423.131537369234, 45266.547334526644, 44729.0, 45233.54766452334, 45334.0, 45334.093318133615, 45395.546044539544, 9102.590383432762, 9896.653617123384, 10069.244806639495, 10088.142507886838, 10094.949525252363, 9172.449653020807, 11972.461239244254, 12479.438425270884, 12497.500099995988, 12643.43104560297, 12424.689382765413, 12493.0, 12501.999840012777, 12503.437345319437, 12506.062045346636, 12255.203411778206, 12305.953993910529, 12308.507659693601, 12388.0, 12395.690107747288, 12222.511099556006, 12305.692357691129, 12317.568885088978, 12330.19853709515, 12338.136330456871, 42133.0, 42264.78867605642, 42326.57673423257, 42336.57663423357, 43192.0, 3500.0, 3608.2963822054708, 3666.138457462494, 3724.422714479233, 4403.559644035603, 31577.526337104962, 31599.2445684771, 31603.36793264145, 32158.678413215803, 32336.514952275735, 3240.659730728287, 3307.355065762177, 3397.524346591479, 3414.7951122932704, 3460.5155278260813, 468694.62610747933, 503264.48367758293, 516135.0, 525660.0, 528689.0, 57545.71227143921, 61579.38420615737, 61778.0733289001, 61907.380926191065, 62148.06777898335, 36005.639943600756, 36613.0, 36800.07999800026, 38284.2343153141, 38384.04039898969, 17600.38398656041, 17763.555911102067, 17771.378001769877, 17811.73282400765, 17819.19813608391, 12413.627591172279, 12612.81080783789, 12613.0, 13435.261060641564, 13541.39063742134, 16155.788315876356, 17772.46682599524, 17941.192646330946, 19610.313639022566, 20690.275840345515, 6764.763233286812, 7953.602319883983, 7960.681572737141, 8039.0, 8055.113937466874, 860.9397342185987, 915.9496227707407, 1000.5197505197546, 1002.1631937332263, 1023.8515415264745, 27348.31629209246, 30807.075787726404, 31658.050258492283, 31716.524252135776, 32165.839170804466, 1090.5583238788304, 1110.74452875839, 1115.1970581181536, 1133.002957397485, 1178.4763556964615, 16357.018578885067, 16469.0, 16494.587635308973, 16786.832131678526, 16789.91605041967, 623501.0, 628067.0, 629796.0, 630271.0, 630301.0, 51697.48302516927, 61964.69017654883, 62219.6889015552, 62495.375046248955, 62521.68739156275, 1293.489071816646, 1327.9203247805162, 1392.5474220878052, 1413.1591702936737, 1439.7336492748666, 29731.810727570653, 31037.379252415278, 31833.8858139964, 32106.35787284288, 32342.35315293728, 49626.75186624044, 50297.4910752678, 50312.0, 50348.748256258485, 50375.0, 439949.0, 441979.79010104743, 442350.7882460567, 442447.0, 442886.0, 24638.0, 25280.873595631903, 26922.192334230003, 26986.595201072392, 27282.181534553994, 50293.74853125711, 50391.4882553524, 50453.0, 50638.746806265735, 50640.49359506358, 37714.245715086094, 40802.1839563213, 41072.589274108075, 41631.16737665169, 42218.78890605527, 40012.0, 40866.1826763469, 40876.0, 42151.156976859675, 42398.788006059774, 38761.224775504896, 39481.2103757929, 39796.40305395363, 39948.80153595397, 40078.79960600178, 34351.14122146966, 35518.0, 36308.63691363052, 36385.454218187275, 36468.635313646526, 20838.583228335046, 22799.544009120058, 26600.201993940213, 26731.732682672926, 26767.86616066985], "value": 20628.32909229884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5366667165975, 392.75452841973765, 394.3257030477883, 407.6575676431797, 415.5864914410162, 19791.109400076995, 20926.26758063468, 21231.57536849264, 21525.03137358821, 21954.121835126574, 17090.401835935743, 19232.903835480836, 20774.376768696926, 20803.687944680805, 21339.0, 5982.162497250389, 6013.007853704155, 6176.783812566561, 6199.13212150297, 6235.937640623603, 4378.2775841986195, 4483.058557702886, 6125.479334256594, 6233.968830155843, 6234.064890266451, 4455.799489022986, 4540.704854184484, 6797.082393876813, 6869.210040845317, 6893.655317234144, 5602.691851948141, 6745.898811517831, 6853.897191542131, 6878.65606719662, 6887.035814985881, 5920.407959204088, 5924.200232968537, 5925.851853703649, 5929.911051334234, 5937.050071988504, 25534.74465255342, 26094.34764130893, 26094.608580871303, 26117.477650446886, 26340.86829565859, 2104.6737755647746, 2227.5878962392007, 2302.125192426884, 2348.060775689738, 2773.9306517337227, 9733.56198971048, 10070.9496452518, 10355.01627345401, 10510.316829406063, 10878.945605272002, 1877.3898482992945, 1882.218879165145, 1889.896055716935, 1913.5024893527643, 1933.6132773445368, 89312.6460957242, 90767.09232907652, 91416.99999999933, 98765.5061724694, 125504.0, 10526.841997390517, 11736.295822250693, 11794.410279485992, 11930.940345298392, 11959.40202989847, 14735.705285894222, 14758.0, 14922.552323430315, 14949.925250373895, 14958.252087395587, 8824.558772061371, 8830.116988301246, 8854.690085846965, 8878.245349145394, 8975.685850995184, 8880.777980550538, 8941.910580894239, 8944.68693595721, 9044.502552359552, 9095.31785116119, 3742.8128593570214, 4568.063546972862, 4588.197065513522, 4593.678442509059, 4648.907021859612, 1914.4926594452481, 1959.2358979997812, 1965.77393599735, 1992.1433783472955, 2002.3292197113838, 843.3927572148043, 895.2479916869861, 934.1965909317981, 970.679675707015, 983.4640121133999, 19725.704114438297, 20877.79122208789, 20917.790822091887, 20958.580828383347, 21080.472988175417, 955.780170560761, 973.1484950668165, 984.960601575929, 1003.3879333606494, 1014.8173328800887, 10586.311889727143, 10924.672259832218, 11169.497372618089, 12061.939690301493, 12358.011359091252, 625573.0, 627406.0, 631013.0, 638713.8064309742, 639952.0, 130763.0, 131617.0, 134002.0, 134168.0, 138775.0, 992.538469611634, 1018.5060245780791, 1021.9795604087876, 1059.7456610413599, 1064.4730858225228, 18652.81347186565, 19086.7136992948, 19533.023348832787, 19613.70579441281, 19661.11524981408, 52615.94768104693, 54493.72753136209, 54609.72695136499, 55099.0, 56567.0, 79239.60380198061, 79632.0, 81272.0, 82812.3437531234, 83075.0, 7115.5730656160795, 7135.928640713734, 7364.742234021998, 7446.478746487694, 7892.0924093729955, 9374.625014999323, 10432.791344173225, 11955.76088478243, 12909.0, 13038.348082596021, 11346.825815571667, 11612.88387116118, 11639.0, 11646.70883227926, 11743.88256117428, 11036.944815275872, 11090.279131856403, 11239.494222760159, 11336.09311255081, 11707.356095414834, 11337.603183888525, 11363.261388009752, 11555.306681599131, 11617.88382116168, 11834.644960651194, 7310.81722956909, 7344.265573442826, 7584.734534291273, 7611.972383728126, 7676.80807979805, 10568.84146737815, 10791.56833726642, 10838.078763305208, 11388.14588905852, 11543.653690389301], "value": 9681.2599967734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.5049507424865, 1396.5321617258219, 1532.3564103076706, 1710.7690461787654, 1906.3994841624888, 8039.155888631697, 8594.269487093597, 8647.783805404868, 9100.226480749145, 9100.36297459178, 9073.909260907389, 9079.273658107351, 9080.182783549479, 9080.27357811375, 9135.68025119121, 2204.8236141108673, 2402.3393566769146, 2433.9047428657086, 2434.6713193718797, 2435.257246539805, 2238.8656680599133, 2372.300171449418, 2416.8066554675584, 2416.9516609667794, 2420.3465064432594, 2370.7392186859433, 2372.351215904947, 2384.8688322142275, 2406.0856874387796, 2408.2654790288957, 2352.094443639194, 2372.2764556810166, 2372.3630694820604, 2376.9762302376926, 2395.484970731301, 2091.5294058836794, 2369.277370402027, 2372.893219805113, 2376.4652953085592, 2377.4413012941945, 7586.544807311524, 8095.797605059862, 8635.266002389804, 8652.264557512619, 8652.437591556529, 5289.576833853283, 5532.972335138339, 5536.501714845643, 5572.498475137217, 5576.944230557724, 3055.7860949733526, 3068.401661675974, 3602.2975519773654, 3610.277944411102, 3654.9086272843124, 1070.0530030922612, 1085.2457542008308, 1087.1357270969597, 1105.182165197748, 1109.312226419617, 12056.758864822654, 12121.151519393647, 12205.38973051344, 12212.389380530938, 12222.938885305517, 3951.427043078795, 4542.0915816836105, 4559.977200113978, 4732.6687131900435, 4738.147133515931, 9515.57179926905, 9529.285303602257, 9539.18916892058, 9549.713508594754, 9557.426554406758, 5391.4608539145775, 5398.109311963561, 5405.8107966221, 5408.4050754416985, 5414.945850541523, 4286.357046443059, 4507.887302817456, 4670.789814458358, 4685.5782979532005, 5063.974680126649, 3851.980740096282, 3881.7088718346236, 3931.977685801712, 3972.900677483086, 3981.6217459341315, 1167.287954347847, 1174.8590169179754, 1174.9588764393377, 1181.3048275724364, 1189.601483503019, 920.6212209143719, 924.8011677489372, 931.6413180925392, 949.9335046546676, 985.4629227071264, 5832.358440571534, 5872.17789509469, 6046.667433291123, 6168.383161683885, 6185.288691800411, 434.96520278377653, 453.62575874903337, 456.4818930513891, 459.2193271438568, 463.9257718764981, 4036.798160091984, 4058.939115913264, 4094.7952602369764, 4094.9385759213637, 4167.97916010418, 10597.735056623646, 11117.0, 11119.0, 11123.666290011313, 11134.777304453866, 10972.835407468894, 11039.172062095375, 11040.116790656728, 11067.778644427066, 11087.83368249477, 7957.920420795718, 8402.075771665111, 8496.107908669625, 8497.405181637227, 8518.679604661287, 6037.154798328325, 6092.238470191226, 6132.540059495466, 6250.406211409909, 6318.336574659595, 10346.689599312032, 10378.117859981987, 10495.317804342692, 10524.421156836448, 10528.473576321307, 8831.293496520391, 10332.741681458023, 10493.737656558647, 10510.421926794099, 10656.9875861793, 7208.387287080657, 7479.2894675007965, 7546.584937828472, 7549.811254718676, 7552.055993000875, 8482.194191551793, 8499.10759370282, 8518.744437666632, 8599.52702601363, 8621.91378086211, 7777.533347999138, 7793.688252469838, 7816.140224575406, 7826.334761545105, 7828.76513704567, 7543.207963163789, 7585.0, 7588.962055189689, 7613.124490683642, 7637.6563054661565, 6032.668203248863, 7165.068541089625, 7171.533850299714, 7254.238304977901, 7264.782056538313, 5026.673266237683, 5050.949490505195, 5058.671186372874, 5109.08036553424, 5122.410922743783, 5017.84946451607, 5119.257707632447, 5135.35808023997, 5164.7417629119145, 5192.247124166899], "value": 4543.915651020322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5827216713103, 307.97382222511084, 315.8247172819086, 319.5925195375897, 321.25148404218174, 5178.11971964766, 5478.397376288605, 5504.972475137629, 5504.990678402384, 5512.669239845602, 4257.936130958038, 4318.352247162927, 4806.327114204014, 5077.8067154218825, 5340.893182136365, 4089.5092588889374, 4096.487939007624, 4112.547619761839, 4118.588141185873, 4163.188178305231, 4084.5915408459214, 4092.7339722917914, 4103.712740108193, 4152.771597562133, 4166.208420400129, 3808.6953043756434, 4029.8992525186814, 4082.2243773682903, 4097.795110244476, 4103.302438585432, 4081.9387709184384, 4088.284550203732, 4099.077707515815, 4132.194222126672, 4142.984968682692, 3476.0093373388463, 3548.1661809475013, 3553.6979356754705, 3572.821358932069, 3580.1765593913287, 4064.5325787534516, 4559.316102584606, 5251.186066159751, 5358.169483729989, 5367.141257398836, 4057.9594204057876, 4526.0495295987885, 4703.858884233444, 4773.4510531289, 4796.208625576811, 5289.78334982956, 5746.454086861741, 5763.740631671585, 5804.912926306067, 5819.24349834523, 3647.4893514907935, 3748.850045998157, 3756.7978246960984, 3973.940390894139, 4002.2795896738576, 5915.112733090071, 5987.37132601075, 5994.97002514989, 6002.118982888238, 6009.699515024231, 3330.816805075744, 3701.0747313171705, 3738.3924912287976, 3963.4649322341693, 3970.4242884781543, 3907.6323286849374, 4033.032072302626, 4067.654249388835, 4080.3063479208604, 4089.85685501012, 3640.180959284193, 4097.09863829957, 4709.175894218498, 4752.669252609275, 4754.4532378776885, 5829.621074630136, 5836.8540786479825, 5836.941630583725, 5912.0, 5924.7333869975955, 1205.3551350027692, 1266.5503746169977, 1299.142565906516, 1364.40648317982, 1405.4027038508593, 734.9118105827334, 755.8488302339554, 779.3842864137381, 841.6843683618642, 857.6397912876607, 3593.2152581748833, 3764.6635444417384, 3910.2961466936226, 4402.939956730042, 4408.2807704995075, 4183.218159923677, 4902.48523904992, 4968.652194346361, 5007.072277173314, 5089.745512724349, 4543.318502224693, 4569.95430045702, 4942.703437793743, 5497.670139791625, 5521.806736764194, 2602.6986506746625, 2989.805662631922, 2993.580898674187, 3113.4395808754643, 3155.826429546397, 5573.41479144692, 5798.449147331081, 6024.728887200086, 6185.402131104946, 6209.223847019122, 5353.277307563507, 6048.429417497546, 6099.69501524922, 6103.176071230416, 6126.387361263838, 4985.376827896513, 6128.0, 6137.232845894263, 6179.320274769681, 6230.345813689588, 5226.712530810842, 5536.7819079802375, 5773.884522309446, 5927.496162826208, 6003.339632640494, 5782.5254560086905, 5827.038538641246, 5869.0, 5899.67551784656, 5907.409259074058, 5775.6823374714795, 6123.479504242011, 6136.0, 6139.447449729546, 6146.170267013896, 3264.2002709336366, 3992.5608183100417, 4010.6911797766375, 4016.59834016596, 4025.9597404025585, 4950.653454258168, 5472.835814925558, 5899.46904778572, 5989.3711160329285, 6042.728077236447, 4878.682885612424, 5814.360420353673, 5888.528917686489, 5925.674087925206, 5945.910811337747, 5015.498450154955, 5054.646174767878, 5606.775728970795, 5778.157525245664, 5787.826365209051, 4903.656744027884, 5227.790888364575, 5584.581156413204, 5658.5190258826815, 5676.25367257608, 5281.468374171447, 5508.9724551376985, 5826.82519524415, 5830.950428922834, 5853.590248682552, 4422.65109141702, 5305.938812237645, 5404.567634589145, 5408.432114627907, 5548.889022219614], "value": 4112.059935692442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8416356319832, 714.8355878148026, 740.9814754631135, 768.6963649358504, 808.7412028150992, 15559.455419060321, 16714.498565043068, 16716.080615566156, 16750.0, 16761.664766704675, 15085.472008479705, 15215.78273738101, 15238.0, 15239.466618668348, 15241.237938103079, 720.1825927572204, 734.1557209209399, 735.3565630073685, 877.7366789963017, 892.5715656484891, 901.2339511415311, 908.7637214324291, 913.9177474027337, 915.6245939164944, 917.7889085510336, 968.109339407743, 968.8207681578931, 969.050330675938, 970.6845275285525, 972.3922548407245, 961.2262128986198, 962.8074385123003, 963.4171326347599, 964.3779762053506, 965.2181732796457, 715.7244460882546, 716.4161208615014, 716.9818857222756, 718.0772707071388, 719.1980941250521, 15616.141112238822, 15653.217339133113, 15658.921705391514, 15663.686726265525, 15666.373345066184, 11800.763984720343, 12929.771671691175, 13068.673283167902, 13418.0, 13761.587152385344, 13387.263700496469, 13552.457901683922, 13683.24742139182, 13690.794638080437, 13759.587212383645, 4716.056788642251, 4759.309900064506, 4763.928541071887, 4804.543568361, 4924.482929292444, 99392.50911236338, 123194.0, 124149.0, 125308.0, 125618.0, 10704.411257380763, 10928.945355273172, 11496.195266331444, 11518.654440366803, 11567.958883700507, 21842.344729658136, 21844.12623495074, 21860.234891778713, 21885.0, 21904.89047554784, 6641.672199729467, 8276.131006244377, 8305.0, 8356.874646880302, 8365.038020627584, 4561.361409402686, 4611.054733779567, 4655.86032419028, 4662.090892276042, 4664.790084446208, 3656.1590834108306, 3815.1606646537716, 3818.1790914953417, 3819.8472061117245, 3821.694264458892, 686.993130068703, 687.3470203306879, 688.3426327856885, 703.5005146346151, 709.5742554467381, 674.5918719174927, 689.5971743335292, 708.2846325211574, 724.1635910523248, 735.8565079809385, 9820.705378838646, 9932.851007234898, 9978.101970822516, 10165.339252948683, 10196.286259961731, 538.7629443045048, 539.2746755613693, 693.5353313280115, 700.3626699703245, 713.8358177619177, 3917.9020524487114, 4828.203346447867, 4914.1054691009385, 4945.128512841369, 4987.900241995139, 110936.0, 152843.2357838226, 153547.0, 157454.0, 162281.37718622663, 131319.0, 132794.0, 135285.0, 136267.0, 137423.0, 114727.37856542307, 115135.84864151251, 116052.41973790077, 116722.0, 117048.41475792737, 9559.761005974906, 9696.981816909405, 9911.306208565331, 9926.52155829745, 9938.254630902567, 55258.89482210253, 59613.40386596078, 62992.0, 64107.39731506563, 66749.66625166843, 70920.29079709137, 77209.0, 89274.0, 92003.0, 95103.52448237715, 12960.35198240103, 13312.267825269702, 13329.333533323488, 13906.096103753223, 13991.370388332753, 15006.549803505912, 15161.393544258106, 15468.84531154674, 15544.922275388551, 16022.919885400499, 14385.0, 14461.421543138156, 14530.854691453373, 14711.485098021518, 15411.61470963235, 13875.79186312186, 14796.48212312564, 14992.175430351435, 15401.768973465183, 15566.533004009898, 11426.714332141762, 13992.720145597235, 14834.851651483346, 14845.331960061607, 14963.476278330207, 8831.558422078999, 11344.489497972776, 11552.0, 11986.220895641756, 12066.818997715216, 10232.386056836614, 11871.228370155912, 11992.520299188283, 12103.576374826838, 12145.392730363623], "value": 8182.377138870882, "unit": "score"}], "name": "dromaeo_css", "value": 7491.456476803472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 112.0, 112.0, 114.0, 114.0, 112.0, 114.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 107.0, 112.0, 168.0, 134.0, 108.0, 107.0, 106.0, 137.0, 107.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 179.0, 185.0, 183.0, 181.0, 182.0, 184.0, 183.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 89.0, 61.0, 62.0, 58.0, 59.0, 81.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 92.0, 71.0, 68.0, 70.0, 91.0, 68.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 85.0, 86.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 97.0, 93.0, 93.0, 94.0, 103.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 91.0, 141.0, 143.0, 85.0, 92.0, 135.0, 86.0, 84.0], "value": 102.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 52.0, 52.0, 55.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 67.0, 79.0, 74.0, 70.0, 69.0, 67.0, 67.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 92.0, 101.0, 77.0, 84.0, 97.0, 99.0, 86.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 136.0, 134.0, 134.0, 131.0, 142.0, 154.0, 189.0, 132.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 158.0, 160.0, 160.0, 172.0, 220.0, 193.0, 161.0, 157.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1438.1, "alertThreshold": 2.0}]} 04:31:43 INFO - Return code: 0 04:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:31:43 INFO - # TBPL SUCCESS # 04:31:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:43 INFO - 2016-12-12 04:31:43.445 screenresolution[1658:10206] starting screenresolution argv=screenresolution get 04:31:43 INFO - 2016-12-12 04:31:43.447 screenresolution[1658:10206] Display 0: 1600x1200x32@60 04:31:43 INFO - 2016-12-12 04:31:43.453 screenresolution[1659:10210] starting screenresolution argv=screenresolution list 04:31:43 INFO - Available Modes on Display 0 04:31:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:43 INFO - Intel Iris: 04:31:43 INFO - Chipset Model: Intel Iris 04:31:43 INFO - Type: GPU 04:31:43 INFO - Bus: Built-In 04:31:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:43 INFO - Vendor: Intel (0x8086) 04:31:43 INFO - Device ID: 0x0a2e 04:31:43 INFO - Revision ID: 0x0009 04:31:43 INFO - Displays: 04:31:43 INFO - Display: 04:31:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:43 INFO - Display Serial Number: 1600x1200 60 04:31:43 INFO - Main Display: Yes 04:31:43 INFO - Mirror: Off 04:31:43 INFO - Online: Yes 04:31:43 INFO - Rotation: Supported 04:31:43 INFO - Return code: 0 04:31:43 INFO - Running post-action listener: _resource_record_post_action 04:31:43 INFO - [mozharness: 2016-12-12 12:31:43.702586Z] Finished run-tests step (success) 04:31:43 INFO - Running post-run listener: _resource_record_post_run 04:31:43 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 38659072; Write bytes: 495876608; Read time: 374; Write time: 1705 04:31:43 INFO - TinderboxPrint: CPU usage
53.2% 04:31:43 INFO - TinderboxPrint: I/O read bytes / time
38,659,072 / 374 04:31:43 INFO - TinderboxPrint: I/O write bytes / time
495,876,608 / 1,705 04:31:43 INFO - TinderboxPrint: CPU idle
2,237.9 (46.8%) 04:31:43 INFO - TinderboxPrint: CPU system
957.2 (20.0%) 04:31:43 INFO - TinderboxPrint: CPU user
1,590.5 (33.2%) 04:31:43 INFO - TinderboxPrint: Swap in / out
233,742,336 / 0 04:31:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196135424; Write bytes: 198817792; Read time: 17853; Write time: 409 04:31:43 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 34448384; Write bytes: 295567872; Read time: 341; Write time: 1289 04:31:44 INFO - Running post-run listener: _upload_blobber_files 04:31:44 INFO - Blob upload gear active. 04:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:31:44 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:31:44 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:46 INFO - (blobuploader) - INFO - Done attempting. 04:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:47 INFO - (blobuploader) - INFO - Done attempting. 04:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:49 INFO - (blobuploader) - INFO - Done attempting. 04:31:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:49 INFO - Return code: 0 04:31:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/154272f3bc5f1dbfcf04ad5960617099113ed2d6240998a15e4d03ec94a3e48dc442d9a37e82c2dc3a950fd326ec0205f3bc476248ee4c0904f9b68770295147", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9411f7e70a1371dce5c76cab15355178c52b6e0317ad39b451b62c2da09f7da4040686e1be9e7f0b46e8d214a5a83d0f9487c9370a571f30d78c0b146280099d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3625ec567276ea14fbe4b773c49a3738c242651eae9aae8e045caeb3867f85e46539f245406dc7b0e79167297429dbb563515cb4230bfd65763d2a26b3322bd1"} 04:31:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:49 INFO - Contents: 04:31:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/154272f3bc5f1dbfcf04ad5960617099113ed2d6240998a15e4d03ec94a3e48dc442d9a37e82c2dc3a950fd326ec0205f3bc476248ee4c0904f9b68770295147", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9411f7e70a1371dce5c76cab15355178c52b6e0317ad39b451b62c2da09f7da4040686e1be9e7f0b46e8d214a5a83d0f9487c9370a571f30d78c0b146280099d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3625ec567276ea14fbe4b773c49a3738c242651eae9aae8e045caeb3867f85e46539f245406dc7b0e79167297429dbb563515cb4230bfd65763d2a26b3322bd1"} 04:31:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:49 INFO - Copying logs to upload dir... 04:31:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.179727 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-12 04:31:50.038145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 04:31:50.041443) ========= 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.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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/Mozilla-Beta/sha512/154272f3bc5f1dbfcf04ad5960617099113ed2d6240998a15e4d03ec94a3e48dc442d9a37e82c2dc3a950fd326ec0205f3bc476248ee4c0904f9b68770295147", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9411f7e70a1371dce5c76cab15355178c52b6e0317ad39b451b62c2da09f7da4040686e1be9e7f0b46e8d214a5a83d0f9487c9370a571f30d78c0b146280099d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3625ec567276ea14fbe4b773c49a3738c242651eae9aae8e045caeb3867f85e46539f245406dc7b0e79167297429dbb563515cb4230bfd65763d2a26b3322bd1"} build_url:https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011007 build_url: 'https://queue.taskcluster.net/v1/task/OclKG3NITqmjJgaSpRhxcA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/154272f3bc5f1dbfcf04ad5960617099113ed2d6240998a15e4d03ec94a3e48dc442d9a37e82c2dc3a950fd326ec0205f3bc476248ee4c0904f9b68770295147", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9411f7e70a1371dce5c76cab15355178c52b6e0317ad39b451b62c2da09f7da4040686e1be9e7f0b46e8d214a5a83d0f9487c9370a571f30d78c0b146280099d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3625ec567276ea14fbe4b773c49a3738c242651eae9aae8e045caeb3867f85e46539f245406dc7b0e79167297429dbb563515cb4230bfd65763d2a26b3322bd1"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 04:31:50.097560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:31:50.097903) ========= 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.WL6QFZww5O/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.L72fIx0545/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005141 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 04:31:50.174509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 04:31:50.174844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 04:31:50.175185) ========= ========= Total master_lag: 0.26 =========