builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0296 starttime: 1479145842.95 results: success (0) buildid: 20161114042748 builduid: 5d9b629788f647fca5ea5eddaffd68fd revision: f455459b2ae5e42e5fb29d90533095add226ca95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:42.950070) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:42.950575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:42.950900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:42.976764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:42.977210) ========= 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.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 09:50:42-- 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% 18.5M=0.001s 2016-11-14 09:50:43 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:43.080917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:43.081287) ========= 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.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.027021 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:43.130690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:50:43.131137) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f455459b2ae5e42e5fb29d90533095add226ca95 --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 f455459b2ae5e42e5fb29d90533095add226ca95 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 09:50:43,208 truncating revision to first 12 chars 2016-11-14 09:50:43,208 Setting DEBUG logging. 2016-11-14 09:50:43,208 attempt 1/10 2016-11-14 09:50:43,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f455459b2ae5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 09:50:44,196 unpacking tar archive at: mozilla-beta-f455459b2ae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.250832 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:50:44.404289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:44.404616) ========= script_repo_revision: f455459b2ae5e42e5fb29d90533095add226ca95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:44.405018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:44.405299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:44.423668) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-14 09:50:44.424111) ========= /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.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:50:44 INFO - MultiFileLogger online at 20161114 09:50:44 in /builds/slave/test 09:50:44 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 09:50:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:44 INFO - {'append_to_log': False, 09:50:44 INFO - 'base_work_dir': '/builds/slave/test', 09:50:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:50:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:44 INFO - 'branch': 'Mozilla-Beta', 09:50:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:44 INFO - 'config_files': ('talos/mac_config.py',), 09:50:44 INFO - 'default_actions': ('clobber', 09:50:44 INFO - 'read-buildbot-config', 09:50:44 INFO - 'download-and-extract', 09:50:44 INFO - 'populate-webroot', 09:50:44 INFO - 'create-virtualenv', 09:50:44 INFO - 'install', 09:50:44 INFO - 'run-tests'), 09:50:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:44 INFO - 'download_minidump_stackwalk': True, 09:50:44 INFO - 'download_symbols': 'ondemand', 09:50:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:44 INFO - 'installer_path': 'installer.exe', 09:50:44 INFO - 'log_level': 'info', 09:50:44 INFO - 'log_name': 'talos', 09:50:44 INFO - 'log_to_console': True, 09:50:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:44 INFO - 'opt_config_files': (), 09:50:44 INFO - 'pip_index': False, 09:50:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:44 INFO - 'cmd': ('bash', 09:50:44 INFO - '-c', 09:50:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:44 INFO - 'enabled': True, 09:50:44 INFO - 'halt_on_failure': False, 09:50:44 INFO - 'name': 'check_screen_resolution'},), 09:50:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:44 INFO - 'cmd': ('bash', 09:50:44 INFO - '-c', 09:50:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:44 INFO - 'enabled': True, 09:50:44 INFO - 'halt_on_failure': False, 09:50:44 INFO - 'name': 'check_screen_resolution'},), 09:50:44 INFO - 'run_cmd_checks_enabled': True, 09:50:44 INFO - 'sps_profile': False, 09:50:44 INFO - 'sps_profile_interval': 0, 09:50:44 INFO - 'suite': 'dromaeojs', 09:50:44 INFO - 'system_bits': '32', 09:50:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:44 INFO - 'title': 't-yosemite-r7-0296', 09:50:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:44 INFO - 'use_talos_json': True, 09:50:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:44 INFO - 'work_dir': 'build'} 09:50:44 INFO - [mozharness: 2016-11-14 17:50:44.611907Z] Running clobber step. 09:50:44 INFO - Running pre-action listener: _resource_record_pre_action 09:50:44 INFO - Running main action method: clobber 09:50:44 INFO - rmtree: /builds/slave/test/build 09:50:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - [mozharness: 2016-11-14 17:50:47.021060Z] Finished clobber step (success) 09:50:47 INFO - [mozharness: 2016-11-14 17:50:47.021197Z] Running read-buildbot-config step. 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: read_buildbot_config 09:50:47 INFO - Using buildbot properties: 09:50:47 INFO - { 09:50:47 INFO - "project": "", 09:50:47 INFO - "product": "firefox", 09:50:47 INFO - "script_repo_revision": "production", 09:50:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:50:47 INFO - "repository": "", 09:50:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:50:47 INFO - "buildid": "20161114042748", 09:50:47 INFO - "pgo_build": "False", 09:50:47 INFO - "basedir": "/builds/slave/test", 09:50:47 INFO - "buildnumber": 20, 09:50:47 INFO - "slavename": "t-yosemite-r7-0296", 09:50:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:50:47 INFO - "platform": "yosemite_r7", 09:50:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:50:47 INFO - "branch": "mozilla-beta", 09:50:47 INFO - "repo_path": "releases/mozilla-beta", 09:50:47 INFO - "revision": "f455459b2ae5e42e5fb29d90533095add226ca95", 09:50:47 INFO - "stage_platform": "macosx64", 09:50:47 INFO - "builduid": "5d9b629788f647fca5ea5eddaffd68fd", 09:50:47 INFO - "slavebuilddir": "test" 09:50:47 INFO - } 09:50:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - [mozharness: 2016-11-14 17:50:47.024558Z] Finished read-buildbot-config step (success) 09:50:47 INFO - [mozharness: 2016-11-14 17:50:47.024674Z] Running download-and-extract step. 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: download_and_extract 09:50:47 INFO - mkdir: /builds/slave/test/build/tests 09:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:47 INFO - trying https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:50:47 INFO - Downloading https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/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 09:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/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 09:50:48 INFO - Downloaded 1165 bytes. 09:50:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:50:48 INFO - Using the following test package requirements: 09:50:48 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:50:48 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:50:48 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:50:48 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:50:48 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:50:48 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:50:48 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:50:48 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:50:48 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:50:48 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:50:48 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:50:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:50:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:50:48 INFO - Fetch https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:50:48 INFO - Expected file size: 16231342 09:50:55 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 09:50:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:50:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:50:55 INFO - Fetch https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:50:56 INFO - Expected file size: 16231342 09:51:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:51:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:51:03 INFO - Fetch https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:51:03 INFO - Expected file size: 14414089 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:04 INFO - trying https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:51:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/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 09:51:06 INFO - Downloaded 86010447 bytes. 09:51:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:51:06 INFO - mkdir: /builds/slave/test/properties 09:51:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:06 INFO - Contents: 09:51:06 INFO - build_url:https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:51:07 INFO - Running post-action listener: _resource_record_post_action 09:51:07 INFO - Running post-action listener: set_extra_try_arguments 09:51:07 INFO - [mozharness: 2016-11-14 17:51:07.546673Z] Finished download-and-extract step (success) 09:51:07 INFO - [mozharness: 2016-11-14 17:51:07.546824Z] Running populate-webroot step. 09:51:07 INFO - Running pre-action listener: _resource_record_pre_action 09:51:07 INFO - Running main action method: populate_webroot 09:51:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:07 INFO - '--tppagecycles', 09:51:07 INFO - '7'], 09:51:07 INFO - 'tests': ['tsvgm']}}, 09:51:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['damp', 'tps']}, 09:51:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'tests': ['damp', 'tps']}, 09:51:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['dromaeo_dom']}, 09:51:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['basic_compositor_video']}, 09:51:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['a11yr', 09:51:07 INFO - 'ts_paint', 09:51:07 INFO - 'tpaint', 09:51:07 INFO - 'sessionrestore', 09:51:07 INFO - 'sessionrestore_no_auto_restore', 09:51:07 INFO - 'tabpaint']}, 09:51:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['tsvgx', 09:51:07 INFO - 'tsvgr_opacity', 09:51:07 INFO - 'tart', 09:51:07 INFO - 'tscrollx', 09:51:07 INFO - 'cart']}, 09:51:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:07 INFO - 'tsvgr_opacity', 09:51:07 INFO - 'tart', 09:51:07 INFO - 'tscrollx', 09:51:07 INFO - 'cart']}, 09:51:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'talos_options': ['--disable-e10s'], 09:51:07 INFO - 'tests': ['tp5o']}, 09:51:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'tests': ['tp5o']}, 09:51:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'talos_options': ['--disable-e10s', 09:51:07 INFO - '--xperf_path', 09:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:07 INFO - 'tests': ['tp5n']}, 09:51:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:07 INFO - 'talos_options': ['--xperf_path', 09:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:07 INFO - 'tests': ['tp5n']}}, 09:51:07 INFO - 'talos.zip': {'path': '', 09:51:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:07 INFO - Running post-action listener: _resource_record_post_action 09:51:07 INFO - [mozharness: 2016-11-14 17:51:07.565829Z] Finished populate-webroot step (success) 09:51:07 INFO - [mozharness: 2016-11-14 17:51:07.565941Z] Running create-virtualenv step. 09:51:07 INFO - Running pre-action listener: _resource_record_pre_action 09:51:07 INFO - Running main action method: create_virtualenv 09:51:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:07 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 09:51:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:07 INFO - Using real prefix '/tools/python27' 09:51:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:11 INFO - Installing pip.................done. 09:51:11 INFO - Return code: 0 09:51:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:11 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:11 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 09:51:11 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 09:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:11 INFO - 'HOME': '/Users/cltbld', 09:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:11 INFO - 'LOGNAME': 'cltbld', 09:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:11 INFO - 'MOZ_NO_REMOTE': '1', 09:51:11 INFO - 'NO_EM_RESTART': '1', 09:51:11 INFO - 'PAGER': '/bin/cat', 09:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:11 INFO - 'PWD': '/builds/slave/test', 09:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:11 INFO - 'SHELL': '/bin/bash', 09:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:11 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:11 INFO - 'USER': 'cltbld', 09:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:11 INFO - 'XPC_FLAGS': '0x0', 09:51:11 INFO - 'XPC_SERVICE_NAME': '0', 09:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:11 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 09:51:11 INFO - Cleaning up... 09:51:11 INFO - Return code: 0 09:51:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:11 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:11 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 09:51:11 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 09:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:11 INFO - 'HOME': '/Users/cltbld', 09:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:11 INFO - 'LOGNAME': 'cltbld', 09:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:11 INFO - 'MOZ_NO_REMOTE': '1', 09:51:11 INFO - 'NO_EM_RESTART': '1', 09:51:11 INFO - 'PAGER': '/bin/cat', 09:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:11 INFO - 'PWD': '/builds/slave/test', 09:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:11 INFO - 'SHELL': '/bin/bash', 09:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:11 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:11 INFO - 'USER': 'cltbld', 09:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:11 INFO - 'XPC_FLAGS': '0x0', 09:51:11 INFO - 'XPC_SERVICE_NAME': '0', 09:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:11 INFO - Downloading/unpacking psutil>=3.1.1 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:15 INFO - Installing collected packages: psutil 09:51:15 INFO - Running setup.py install for psutil 09:51:15 INFO - building 'psutil._psutil_osx' extension 09:51:15 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 09:51:15 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 09:51:15 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 09:51:16 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 09:51:16 INFO - building 'psutil._psutil_posix' extension 09:51:16 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 09:51:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:16 INFO - ^ 09:51:16 INFO - 1 warning generated. 09:51:16 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 09:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:16 INFO - Successfully installed psutil 09:51:16 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:16 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 09:51:16 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 09:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:16 INFO - 'HOME': '/Users/cltbld', 09:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:16 INFO - 'LOGNAME': 'cltbld', 09:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:16 INFO - 'MOZ_NO_REMOTE': '1', 09:51:16 INFO - 'NO_EM_RESTART': '1', 09:51:16 INFO - 'PAGER': '/bin/cat', 09:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:16 INFO - 'PWD': '/builds/slave/test', 09:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:16 INFO - 'SHELL': '/bin/bash', 09:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:16 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:16 INFO - 'USER': 'cltbld', 09:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:16 INFO - 'XPC_FLAGS': '0x0', 09:51:16 INFO - 'XPC_SERVICE_NAME': '0', 09:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:16 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 09:51:16 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 09:51:16 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 09:51:16 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 09:51:16 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 09:51:16 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 09:51:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:19 INFO - Installing collected packages: mozsystemmonitor 09:51:19 INFO - Running setup.py install for mozsystemmonitor 09:51:19 INFO - Successfully installed mozsystemmonitor 09:51:19 INFO - Cleaning up... 09:51:19 INFO - Return code: 0 09:51:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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', '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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51: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 jsonschema==2.5.1 09:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:19 INFO - 'HOME': '/Users/cltbld', 09:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:19 INFO - 'LOGNAME': 'cltbld', 09:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:19 INFO - 'MOZ_NO_REMOTE': '1', 09:51:19 INFO - 'NO_EM_RESTART': '1', 09:51:19 INFO - 'PAGER': '/bin/cat', 09:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:19 INFO - 'PWD': '/builds/slave/test', 09:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:19 INFO - 'SHELL': '/bin/bash', 09:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:19 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:19 INFO - 'USER': 'cltbld', 09:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:19 INFO - 'XPC_FLAGS': '0x0', 09:51:19 INFO - 'XPC_SERVICE_NAME': '0', 09:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:22 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 09:51:22 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 09:51:22 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 09:51:22 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 09:51:22 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 09:51:22 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 09:51:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:22 INFO - warning: no files found matching '*.txt' 09:51:22 INFO - no previously-included directories found matching 'build' 09:51:22 INFO - no previously-included directories found matching 'dist' 09:51:22 INFO - no previously-included directories found matching '.git*' 09:51:22 INFO - Installing collected packages: jsonschema, functools32 09:51:22 INFO - Running setup.py install for functools32 09:51:23 INFO - warning: no files found matching '*.txt' 09:51:23 INFO - no previously-included directories found matching 'build' 09:51:23 INFO - no previously-included directories found matching 'dist' 09:51:23 INFO - no previously-included directories found matching '.git*' 09:51:23 INFO - Successfully installed jsonschema functools32 09:51:23 INFO - Cleaning up... 09:51:23 INFO - Return code: 0 09:51:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:23 INFO - 'HOME': '/Users/cltbld', 09:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:23 INFO - 'LOGNAME': 'cltbld', 09:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:23 INFO - 'MOZ_NO_REMOTE': '1', 09:51:23 INFO - 'NO_EM_RESTART': '1', 09:51:23 INFO - 'PAGER': '/bin/cat', 09:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:23 INFO - 'PWD': '/builds/slave/test', 09:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:23 INFO - 'SHELL': '/bin/bash', 09:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:23 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:23 INFO - 'USER': 'cltbld', 09:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:23 INFO - 'XPC_FLAGS': '0x0', 09:51:23 INFO - 'XPC_SERVICE_NAME': '0', 09:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:23 INFO - Cleaning up... 09:51:23 INFO - Return code: 0 09:51:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:23 INFO - 'HOME': '/Users/cltbld', 09:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:23 INFO - 'LOGNAME': 'cltbld', 09:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:23 INFO - 'MOZ_NO_REMOTE': '1', 09:51:23 INFO - 'NO_EM_RESTART': '1', 09:51:23 INFO - 'PAGER': '/bin/cat', 09:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:23 INFO - 'PWD': '/builds/slave/test', 09:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:23 INFO - 'SHELL': '/bin/bash', 09:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:23 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:23 INFO - 'USER': 'cltbld', 09:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:23 INFO - 'XPC_FLAGS': '0x0', 09:51:23 INFO - 'XPC_SERVICE_NAME': '0', 09:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:23 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 09:51:23 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 09:51:23 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 09:51:23 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 09:51:23 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 09:51:23 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 09:51:26 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:26 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 09:51:27 INFO - Downloading docopt-0.6.1.tar.gz 09:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:27 INFO - Running setup.py install for blobuploader 09:51:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:27 INFO - Running setup.py install for requests 09:51:28 INFO - Running setup.py install for docopt 09:51:28 INFO - Successfully installed blobuploader requests docopt 09:51:28 INFO - Cleaning up... 09:51:28 INFO - Return code: 0 09:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:28 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')]} 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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')]} 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:28 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 09:51:28 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 09:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:28 INFO - 'HOME': '/Users/cltbld', 09:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:28 INFO - 'LOGNAME': 'cltbld', 09:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:28 INFO - 'MOZ_NO_REMOTE': '1', 09:51:28 INFO - 'NO_EM_RESTART': '1', 09:51:28 INFO - 'PAGER': '/bin/cat', 09:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:28 INFO - 'PWD': '/builds/slave/test', 09:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:28 INFO - 'SHELL': '/bin/bash', 09:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:28 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:28 INFO - 'USER': 'cltbld', 09:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:28 INFO - 'XPC_FLAGS': '0x0', 09:51:28 INFO - 'XPC_SERVICE_NAME': '0', 09:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:28 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-nWTACL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:28 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-6N9PdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:28 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-l7MsAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-IofaRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-peS4uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-s1jlFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-_an77x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-YAMHMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-dKnUJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-odtwLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-CWWVlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-xwWcoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:29 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-TfhanV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:30 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-eG1hXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:30 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-qEJX1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:30 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-6pbCCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:30 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-0grL7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:30 INFO - Running setup.py install for manifestparser 09:51:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:30 INFO - Running setup.py install for mozcrash 09:51:30 INFO - Running setup.py install for mozdebug 09:51:30 INFO - Running setup.py install for mozdevice 09:51:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for mozfile 09:51:31 INFO - Running setup.py install for mozhttpd 09:51:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for mozinfo 09:51:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for mozInstall 09:51:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for mozleak 09:51:31 INFO - Running setup.py install for mozlog 09:51:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for moznetwork 09:51:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozprocess 09:51:32 INFO - Running setup.py install for mozprofile 09:51:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozrunner 09:51:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozscreenshot 09:51:32 INFO - Running setup.py install for moztest 09:51:32 INFO - Running setup.py install for mozversion 09:51:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:33 INFO - Cleaning up... 09:51:33 INFO - Return code: 0 09:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:33 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')]} 09:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 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')]} 09:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:33 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 09:51:33 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 09:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:33 INFO - 'HOME': '/Users/cltbld', 09:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:33 INFO - 'LOGNAME': 'cltbld', 09:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:33 INFO - 'MOZ_NO_REMOTE': '1', 09:51:33 INFO - 'NO_EM_RESTART': '1', 09:51:33 INFO - 'PAGER': '/bin/cat', 09:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:33 INFO - 'PWD': '/builds/slave/test', 09:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:33 INFO - 'SHELL': '/bin/bash', 09:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:33 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:33 INFO - 'USER': 'cltbld', 09:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:33 INFO - 'XPC_FLAGS': '0x0', 09:51:33 INFO - 'XPC_SERVICE_NAME': '0', 09:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-kB4rjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-ItEPO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-pm0Bmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-6yVQtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-l2aZOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-UVms1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:33 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)) 09:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:33 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-rwv5YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-FWpetD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-0tURu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-2gDqml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Twpipf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-kPqkTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-byA3GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-6iLJVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-yXZRvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-jWjiyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:34 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)) 09:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:34 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-poeB_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:35 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)) 09:51:35 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)) 09:51:35 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)) 09:51:35 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)) 09:51:35 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)) 09:51:35 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)) 09:51:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:37 INFO - Downloading blessings-1.6.tar.gz 09:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:37 INFO - Installing collected packages: blessings 09:51:37 INFO - Running setup.py install for blessings 09:51:37 INFO - Successfully installed blessings 09:51:37 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:38 INFO - Reading from file tmpfile_stdout 09:51:38 INFO - Current package versions: 09:51:38 INFO - blessings == 1.6 09:51:38 INFO - blobuploader == 1.2.4 09:51:38 INFO - docopt == 0.6.1 09:51:38 INFO - functools32 == 3.2.3-2 09:51:38 INFO - jsonschema == 2.5.1 09:51:38 INFO - manifestparser == 1.1 09:51:38 INFO - mozInstall == 1.12 09:51:38 INFO - mozcrash == 0.17 09:51:38 INFO - mozdebug == 0.1 09:51:38 INFO - mozdevice == 0.48 09:51:38 INFO - mozfile == 1.2 09:51:38 INFO - mozhttpd == 0.7 09:51:38 INFO - mozinfo == 0.9 09:51:38 INFO - mozleak == 0.1 09:51:38 INFO - mozlog == 3.4 09:51:38 INFO - moznetwork == 0.27 09:51:38 INFO - mozprocess == 0.23 09:51:38 INFO - mozprofile == 0.28 09:51:38 INFO - mozrunner == 6.12 09:51:38 INFO - mozscreenshot == 0.1 09:51:38 INFO - mozsystemmonitor == 0.3 09:51:38 INFO - moztest == 0.7 09:51:38 INFO - mozversion == 1.4 09:51:38 INFO - psutil == 3.1.1 09:51:38 INFO - requests == 1.2.3 09:51:38 INFO - wsgiref == 0.1.2 09:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 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 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:38 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 09:51:38 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 09:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:38 INFO - 'HOME': '/Users/cltbld', 09:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:38 INFO - 'LOGNAME': 'cltbld', 09:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:38 INFO - 'MOZ_NO_REMOTE': '1', 09:51:38 INFO - 'NO_EM_RESTART': '1', 09:51:38 INFO - 'PAGER': '/bin/cat', 09:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:38 INFO - 'PWD': '/builds/slave/test', 09:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:38 INFO - 'SHELL': '/bin/bash', 09:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:38 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:38 INFO - 'USER': 'cltbld', 09:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:38 INFO - 'XPC_FLAGS': '0x0', 09:51:38 INFO - 'XPC_SERVICE_NAME': '0', 09:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 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)) 09:51:38 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105847490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa91598430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, '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.pWipwwk885/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.DaheOo4QOZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:38 INFO - 'HOME': '/Users/cltbld', 09:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:38 INFO - 'LOGNAME': 'cltbld', 09:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:38 INFO - 'MOZ_NO_REMOTE': '1', 09:51:38 INFO - 'NO_EM_RESTART': '1', 09:51:38 INFO - 'PAGER': '/bin/cat', 09:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:38 INFO - 'PWD': '/builds/slave/test', 09:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:38 INFO - 'SHELL': '/bin/bash', 09:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:51:38 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:38 INFO - 'USER': 'cltbld', 09:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:38 INFO - 'XPC_FLAGS': '0x0', 09:51:38 INFO - 'XPC_SERVICE_NAME': '0', 09:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:38 INFO - Cleaning up... 09:51:38 INFO - Return code: 0 09:51:38 INFO - Running post-action listener: _resource_record_post_action 09:51:38 INFO - Running post-action listener: _start_resource_monitoring 09:51:38 INFO - Starting resource monitoring. 09:51:38 INFO - [mozharness: 2016-11-14 17:51:38.869982Z] Finished create-virtualenv step (success) 09:51:38 INFO - [mozharness: 2016-11-14 17:51:38.870951Z] Running install step. 09:51:38 INFO - Running pre-action listener: _resource_record_pre_action 09:51:38 INFO - Running main action method: install 09:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:39 INFO - Reading from file tmpfile_stdout 09:51:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:39 INFO - Reading from file tmpfile_stdout 09:51:39 INFO - Output received: 09:51:39 INFO - Usage: mozinstall [options] installer 09:51:39 INFO - Options: 09:51:39 INFO - -h, --help show this help message and exit 09:51:39 INFO - -d DEST, --destination=DEST 09:51:39 INFO - Directory to install application into. [default: 09:51:39 INFO - "/builds/slave/test"] 09:51:39 INFO - --app=APP Application being installed. [default: firefox] 09:51:39 INFO - mkdir: /builds/slave/test/build/application 09:51:39 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'] 09:51:39 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 09:52:01 INFO - Reading from file tmpfile_stdout 09:52:01 INFO - Output received: 09:52:01 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:52:01 INFO - Running post-action listener: _resource_record_post_action 09:52:01 INFO - [mozharness: 2016-11-14 17:52:01.492912Z] Finished install step (success) 09:52:01 INFO - [mozharness: 2016-11-14 17:52:01.493035Z] Running run-tests step. 09:52:01 INFO - Running pre-action listener: _resource_record_pre_action 09:52:01 INFO - Running main action method: run_tests 09:52:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:01 INFO - 2016-11-14 09:52:01.507 screenresolution[1636:7440] starting screenresolution argv=screenresolution get 09:52:01 INFO - 2016-11-14 09:52:01.510 screenresolution[1636:7440] Display 0: 1600x1200x32@60 09:52:01 INFO - 2016-11-14 09:52:01.516 screenresolution[1637:7443] starting screenresolution argv=screenresolution list 09:52:01 INFO - Available Modes on Display 0 09:52:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:01 INFO - Intel Iris: 09:52:01 INFO - Chipset Model: Intel Iris 09:52:01 INFO - Type: GPU 09:52:01 INFO - Bus: Built-In 09:52:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:01 INFO - Vendor: Intel (0x8086) 09:52:01 INFO - Device ID: 0x0a2e 09:52:01 INFO - Revision ID: 0x0009 09:52:01 INFO - Displays: 09:52:01 INFO - Display: 09:52:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:01 INFO - Display Serial Number: 1600x1200 60 09:52:01 INFO - Main Display: Yes 09:52:01 INFO - Mirror: Off 09:52:01 INFO - Online: Yes 09:52:01 INFO - Rotation: Supported 09:52:01 INFO - Return code: 0 09:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:01 INFO - Python 2.7.3 09:52:01 INFO - Return code: 0 09:52:01 INFO - grabbing minidump binary from tooltool 09:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:01 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 0x10565bd30>, '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 0x1054c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105653b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:01 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 09:52:01 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 09:52:01 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 09:52:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:01 INFO - Return code: 0 09:52:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:01 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/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--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 09:52:01 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/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0296 --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 09:52:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pWipwwk885/Render', 09:52:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:01 INFO - 'HOME': '/Users/cltbld', 09:52:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:01 INFO - 'LOGNAME': 'cltbld', 09:52:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:01 INFO - 'MOZ_NO_REMOTE': '1', 09:52:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:01 INFO - 'NO_EM_RESTART': '1', 09:52:01 INFO - 'PAGER': '/bin/cat', 09:52:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:01 INFO - 'PWD': '/builds/slave/test', 09:52:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:01 INFO - 'SHELL': '/bin/bash', 09:52:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaheOo4QOZ/Listeners', 09:52:01 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:52:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:01 INFO - 'USER': 'cltbld', 09:52:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:01 INFO - 'XPC_FLAGS': '0x0', 09:52:01 INFO - 'XPC_SERVICE_NAME': '0', 09:52:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:01 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/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--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 09:52:02 INFO - mozversion application_buildid: 20161114042748 09:52:02 INFO - mozversion application_changeset: f455459b2ae5e42e5fb29d90533095add226ca95 09:52:02 INFO - mozversion application_display_name: Firefox 09:52:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:02 INFO - mozversion application_name: Firefox 09:52:02 INFO - mozversion application_remotingname: firefox 09:52:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:02 INFO - mozversion application_vendor: Mozilla 09:52:02 INFO - mozversion application_version: 51.0 09:52:02 INFO - mozversion platform_buildid: 20161114042748 09:52:02 INFO - mozversion platform_changeset: f455459b2ae5e42e5fb29d90533095add226ca95 09:52:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:02 INFO - mozversion platform_version: 51.0 09:52:02 INFO - using testdate: 1479145922 09:52:02 INFO - actual date: 1479145922 09:52:02 INFO - starting webserver on 'localhost:49277' 09:52:02 INFO - SUITE-START | Running 2 tests 09:52:02 INFO - TEST-START | dromaeo_css 09:52:02 INFO - operating with platform_type : mac_ 09:52:02 INFO - Initialising browser for dromaeo_css test... 09:52:02 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp47LJPL/profile http://localhost:49277/getInfo.html) 09:52:04 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 09:52:04 INFO - PROCESS | 1647 | colorDepth:24 09:52:04 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 09:52:04 INFO - PROCESS | 1647 | __metrics 09:52:04 INFO - PROCESS | 1647 | 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" 09:52:04 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:05 INFO - TEST-INFO | 1647: exit 0 09:52:05 INFO - Browser initialized. 09:52:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:05 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp47LJPL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:16 INFO - PROCESS | 1650 | RSS: Main: 168185856 09:52:16 INFO - PROCESS | 1650 | 09:53:08 INFO - PROCESS | 1650 | 1479145988396 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] 09:55:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 09:55:20 INFO - PROCESS | 1650 | RSS: Main: 313061376 09:55:20 INFO - PROCESS | 1650 | 09:58:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 09:58:23 INFO - PROCESS | 1650 | RSS: Main: 303685632 09:58:23 INFO - PROCESS | 1650 | 10:01:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 10:01:26 INFO - PROCESS | 1650 | RSS: Main: 263442432 10:01:26 INFO - PROCESS | 1650 | 10:04:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 10:04:29 INFO - PROCESS | 1650 | RSS: Main: 275357696 10:04:29 INFO - PROCESS | 1650 | 10:07:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 10:07:32 INFO - PROCESS | 1650 | RSS: Main: 265965568 10:07:32 INFO - PROCESS | 1650 | 10:10:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 10:10:36 INFO - PROCESS | 1650 | RSS: Main: 314597376 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | __start_tp_report 10:10:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:10:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:10:36 INFO - PROCESS | 1650 | |i|pagename|runs| 10:10:36 INFO - PROCESS | 1650 | |0;dojo.html;2967.7625789936806;3311.2880730642905;3409.5738032745912;3453.7064349530287;3457.2566898116916;4427.800748966296;5708.885822283562;5725.656460612367;5732.48407643312;5763.625364351319;5643.209950606918;5751.482366587006;5763.193152958589;5766;5829.562782791297;5214.582833373331;5228.320318358608;5257.579393648499;5281.762320695559;5284.180951952453;5183.974080129594;5185.066687996159;5185.662931909433;5369.776201199716;5387.838364849061;5209.531142197202;5287.47125287472;5295.0468915595175;5296.390915044762;5332.413434522199;5236.266922630834;5278.630495865291;5281.9207711884355;5329.067413202674;5341.599380046473;5197.8440646780655;5298.36419629643;5303.098473259516;5305.8938821223355;5306.151015837486;5554.000279949608;5592.105263157916;5624.971875140639;5627.915581266284;5782.624129431616;6133.548895741652;6231;6236.906446403307;6241;6263.749450021994;6267.811965641038;6306;6313.210848643919;6321.6523091229965;6330.556861019731;5671.06427439472;5725.341585717612;5729.541636669056;5762.567807414461;5765.4522820332;6234.438900498977;6270.7491700331475;6281.937180628227;6282.654454004982;6291.087792270096;6168.722407491674;6169.56813023093;6197.659128747962;6200.658963756947;6202.782902598477;6132.324915438597;6197.03945888388;6306.810795676137;6330.366963303725;6338.207724034496;6079.908801367983;6112.103317728923;6175.258968923668;6190.2571691397325;6277.466415354655;6264.029075493306;6271.560990730696;6274.403931626488;6274.937250627435;6279.874402512016;4997.350344455198;5042.546170844642;5047.570956468668;5053.46938571452;5057.620678449058;4394.560543945579;4402.515723270438;4412.161689279027;4454.643628509776;4489.7979590918485;5719;5818.272715910512;5818.389069147764;5819.185314056035;5853.034249348895;6278.4035516625845;6278.6546739929745;6287.559870809091;6287.685615719196;6320.146780184708;4825.4933232010835;5581.134924086773;5630.85922851932;5660.5471562274915;5808.983427900185;4888.557875426758;5435.83692489226;5457.181422786534;5476.479734425223;5546.168074788733;6311.27420346666;6333.65164915934;6353.269374021954;6373.490120790326;6402.327755585597;6267.6866156692895;6278.905816412849;6307.810765677037;6314.494840412848;6332.651704156131;6203.875922481616;6220.440160385587;6226.501879849692;6255;6298.905516417349;6231.5637905348;6257.655828929271;6264.49884009269;6269.655168965751;6273.309935906956;6228;6293.559450838397;6299.842503937438;6312.779052733133;6315.5263355247625;4974.427940786711;6000.189974353407;6056.848578785565;6154.353792851686;6168.845778855564;6016.157737916783;6149.569530133027;6159.692015399301;6175.228096487939;6210.472109870711;6012.308584512837;6013.308469525886;6014.338422773579;6039.506320413507;6076.483498902643;5737.225474560881;5924.763009479572;6130.788151533453;6165.784197553064;6189.319174890668;5660.745266463102;5943.970280148572;5971.641701497924;6098.908516372347;6120.571559990758 10:10:36 INFO - PROCESS | 1650 | |1;ext.html;499.2237071354043;510.90292844359567;531.9946800531994;549.7636016512898;563.3268244447884;26240.999999999975;36135.4579681305;42359;43866.56133438665;45708.3143752844;44870.55129448713;45115.77442112785;45200.773996129974;45269.09461810762;45269.7736511317;10063.849042264372;10253.897461025368;10254.487275636226;10257.281990260684;10261.743456413613;9302.069793020677;9540.666076687317;12181.634550963441;12428.62714118578;12465.501379944792;12410.131290809646;12491.875081249207;12505.624831255076;12566.24602523847;12580.874191258108;12487.31319777412;12575.811362829565;12576.937115314366;12577.245365278113;12580.308083055428;12386.876131238752;12454;12458.626241212778;12476.625701228977;12491.750164996649;42525.93685157865;42602;42858.78570607158;42869.78565107154;43000.1399972002;3506.140995456104;3588.6052534221217;3642.9981755017316;3690.55713314404;4464.8214071437105;28325.57511637327;32159.83920080408;32416.513752293733;32545.295613477396;33038.17404564905;3248.10677063807;3365.495175723661;3388.762786604939;3395.2530443302435;3419.2990436960363;538086;543473;544933.2753336208;545707.2714636441;545868;63903;64057.35942640514;64186;64397;64442;35432;36037;36266.8186659065;37180.256394871954;37200.62799371972;14705.779413308808;17943.641127177645;17952.281908723504;17959.191836367394;17973.550661233574;11811.173217874666;12153.392330383445;12570.811437828439;13430.798538021938;13528.526501572398;19687.704684429744;20183.293584724463;20209.797902021084;20228.393148205578;20412.897935510227;6849.863002739918;6905.723771049102;8079.959600201962;8158.898548695969;8220.506284829044;907.6278725722422;925.6112432778249;986.1420564109128;1096.4846522134744;1118.7426891814928;30853.228669283;31315.5552889182;31319;31768.531726635174;31876.840615796773;1111.3554138599593;1122.4331712485307;1152.8213126965334;1156.9074474042056;1175.9588414405455;15980.360785568679;16295.348186072424;16398.426055088254;16425.507234782977;16802.663946720997;734835;740737;741860;742117.2894135495;743788.281058602;62331.688341558;62607.686961565814;62653;62785.37214627795;63063;1284.344984058137;1309.7184105417382;1422.239102080382;1433.1401159304542;1459.4454107439105;28274.858625707562;29619;32833.179170520925;32852.835735822126;32949.67050329466;51300.71748206325;51892;51938.74030629974;52056.73971630118;52076.95846083133;630882;637744;637820.4326935007;637921;656961;22520.436989075406;24832.627510586994;25219.747802522474;26986;27527;49508;49526.75236623794;49692;50062;50075.499245007086;40081;41364.1727165449;41891.41402821985;42402;42599;41052.1789564213;41114.1777164461;41856.79071604623;41884.23938960429;42359.576404236795;39031;39841.80079099586;40021.19957600773;40370;40426;35196.648033519334;35646.57413703526;35650.28699426049;36382.63617363898;36468.45297320595;24067.398315042265;26488.2302786738;26531.60202596924;26617.334566635214;27031.1890643281 10:10:36 INFO - PROCESS | 1650 | |2;jquery.html;325.3736557127529;379.1809691067297;386.82012864018225;387.15793149898974;409.4533797380497;17115.486535403943;20035.699464508027;21873;22387.32838014858;22675.773242267573;21129.260475883348;21456.463588410297;21817.23639672612;22047.33857984259;22078.22726204583;5930.318013428468;5987.940120598803;6109.450149486545;6177.413145751147;6185.845353866144;4440.689151759379;4521.502634710179;6129.969350153243;6135.539834512407;6213;4489.4612646482465;4534.070515544306;6834.521583489158;6921.031055652213;6925.272846351136;6903.206131294915;6903.344182302673;6913.377795998334;7863;8282.544460054694;7730.420218483636;7988.081370642392;8094.838103237902;8132.471389359673;8134.227248411451;30739.38521229563;31054.53418198729;31323;31618.735250589947;32093.839530802197;2339.4619237575284;2504.0484615846044;2633.2231991562344;2644.338915271182;2710.417260289047;13417.530386436525;17402.738958915626;17776.37782677613;17862.92822430645;18906.96011719355;1884.1615481110912;2094.7591027031935;2108.1988844239245;2109.862858914166;2130.840186985982;76310.23689763142;129906.350468248;131236.71908202276;134222.3288883559;142923.57076429206;21126.683099753514;22427.663585046237;22526.66210006851;22902.770972290396;23028.539429211323;38170;38190.61809381926;38780.80609596991;38985.805070974464;39034.41448378276;9259.35184537076;9446.38598491096;9576.186024188022;9702;9778.902210977942;6723.865522689616;7013.053237812932;7344.48588598793;7433.85132297351;7554.526867260941;10235.744106397251;10258.743531411774;10405.84391234132;10523.736906577244;10524.36853788775;3635.1457407509215;3648.5621725392593;3897.5322961244265;3913.25648126855;3983.661388781986;875.3085062800444;944.6646440513656;970.2819913264275;975.9853602195831;1015.2385710716962;16879;20364.185432582828;21884.343469695934;21902.45243868884;22136.22523211712;937.9812403752023;947.9857802132974;1006.808706345792;1020.4846552491093;1021.5556233038652;10704.090152336983;11472;11502.252353596989;11529.481173347052;11575;630457;643695.7815210894;647810;660496;663901;132330;133360.3331983334;134923.32538337246;135176;136096;1028.6759670703705;1059.2638116509106;1066.4774260612244;1074.1084899533369;1075.0378411321824;18807;19501.609967800847;20188.59622807565;20286.89856550767;20303.79696203078;55357.50891209986;56503.58741031343;57506;57843.71078144751;60101.699491502266;67425;79628;80978;83607;84052.15947840443;7395.556266624019;7781.92218077812;7805.063392392949;8121.4721043132;8138.796530086558;11983;12193.634190974284;12557;13028.869711302767;13111.737765244832;11340.659780206606;11478.426078696199;11535.711607209887;11546.19176657626;11605.446801703612;11127.387993660426;11222.943885280847;11271.323720576791;11326.923942225476;11328.207025508465;11484.82772758426;11531.423428828357;11580.594679186188;11785.823212651645;11898.76202475963;7104.573725576482;7846.254605812439;7883.802904927423;8285.917140828757;8348.66605335804;9383.765405864908;11679.06567474583;11821.290722556674;11929.880701192877;11950.34273114987 10:10:36 INFO - PROCESS | 1650 | |3;mootools.html;1393.3590548347759;1536.1704679473085;1563.351209248162;1773.6098058427149;1921.9327323543678;8283.627236774344;8794.164554367333;9267.860982085265;9522.333436659437;9576.80846383072;9250.121238482334;9330.44017358959;9333.90666093339;9342.299327550427;9350.205232555241;2427.757224277576;2465.0755966512556;2465.7287698353166;2466.2477944227003;2468.7037555493366;2405.2423486601665;2466.2971053249826;2468.3582268610203;2470.28361775085;2474.8886300116537;2414.4326083370393;2442.023190723707;2456.914008009711;2457.054034196838;2458.4960083182996;2403.286308205365;2420.878956052199;2432.2946345559853;2441.389652586853;2442.3527765142253;2351.3651314145254;2425.4300239443714;2429.6112621980396;2433.6471211674384;2437.2566367257978;8350.70772522965;8601.010883748324;9222.584983675752;9409.529523523865;9427.858582121273;5410.1614249790955;5595;5620.91568626471;5672.34768001681;5684.2326285951285;3767.585565587783;3813.389857622767;3816.7709937403843;3889.8055097245024;3899.337112690849;1111.3276467736985;1115.1134847796022;1118.9048930840888;1127.21095233337;1134.2967360236623;12431.316277604728;12531.624051278477;12568.183068100545;12574.245545267313;12586.811197831948;4806.927896081562;4831.227003679394;4907.9263811042865;4991.575716064175;4997.150484417658;8881.689140880038;10629.468526573795;10641.467926603638;10647.414392208348;10669.519871605797;5616.97191514048;5625.915611265835;5627.099664053731;5628.60599758013;5636.04187288162;5042.4705405931845;5061.139606266944;5140.280360749498;5160.612954028388;5173.327467429285;4092.242935057024;4115.855945041909;4157.812898419578;4187.309093999456;4194.664426845845;1297.5588299978053;1300.1224173682726;1301.1087405127519;1315.526410492222;1319.399673148715;830.3772170871846;872.254222639634;909.5861383070819;932.6176267730198;970.8058388322364;5864.824055278348;6070.605410648293;6195.96902015487;6230;6332.018537126753;417.0969850274183;434.2444147183877;438.48040072514175;447.95296493868324;450.9458864936163;4069.328560787496;4087.1621317629815;4116.115035267372;4120.91758164835;4187.644050255702;11002.724931876766;11343.149263805082;11471.655850324503;11501.482433290523;11511.424428778528;11380.146489013192;11409.48657310423;11420.31478111316;11421.371824549564;11429.257098288585;8603.612837422332;8663.133686631412;8674.913250867537;8696.260817830555;8697.521636309937;6104.32852386246;6120.234970628671;6142.57002009855;6230.158928544589;6491.707873145625;10409.583616655249;10543.525541350811;10653.733656658645;10737.731556711145;10738.14094872424;8309.459885107448;10449.634262800766;10520.053195212467;10743.731406714895;10784.892151078702;7790.104138023973;8043.19568043191;8050.114487406264;8070.556119413489;8075.273225409741;8223.09545949933;8267.751967440987;8286.254237118688;8297.419180657296;8306.87539686893;6742.797716068526;7904.565248911365;7933.087694914928;7961.203879612224;8055.476394034369;7748.8450230996195;7785.727499537489;7809.921900781147;7848.686052558062;7938.841223175388;7333.083364579427;7333.779986600411;7347.595882226529;7350.117985841734;7410.6665200065045;5324.068288049653;5333.120035194304;5337.813176538958;5358.732063396893;5389.51494365509;5249.238860365302;5284;5428.592855535771;5442.210879422382;5454.2091396746455 10:10:36 INFO - PROCESS | 1650 | |4;prototype.html;272.64011504813647;303.4492396300714;307.5770815129197;314.2834337710022;317.1943264109163;4818.45809341011;5269.130593452085;5443.564514838813;5496.862578435541;5533.778648854051;5092.643514953955;5386.245925570413;5387.117891927819;5402.189671549269;5430.266913966613;3946.6320207875333;4123.79381030948;4124.752514849119;4125.422440858282;4162.687798415116;3883.9513331400503;4092.7135100542973;4103.343465045593;4153.750774953497;4185.142045880602;3230.370077834823;3367.54538137352;4078.3678529827926;4088.4889388826396;4129.29801933672;4070.4911886014247;4077.5106987161435;4102.3026085565525;4141.689373296985;4151.792410379499;3544.556930383702;3556.413191823372;3564.3940530109944;3588.9282214355567;3607.4228123500375;4946.752662366867;5279.128943724281;5302.3637163540625;5333.57331413486;5371.328583927009;3917.8432862685745;4466.218411777958;4582.1064892346;4618.552167351276;4717.646176536739;5160.432352441228;5217.5565076968505;5632.014397480466;5674.489295963342;5689.004424225785;3428.919890234568;3641.4719865619336;3736.5702944161226;3850.1144736710435;3910.2179564087296;4962.379702537183;5032.874178145539;5825.79609713658;5992.1237805853;6014.398560143951;3926.8821935341984;3927.666148377363;3932;3946.4474973503734;3955.110100227483;3391.372596069735;3403.030136411111;3946;4009.258287216874;4012.1945124694003;3887.9805600971813;4626;4650.6046986005895;4668.972825978347;4676.012694604779;5694.60137790359;5714.685692286881;5719.484336650791;5738.311402631711;5753.367129615739;1093.9288946218471;1145.5360578965533;1166.3235323512342;1274.8024056271292;1352.8038434426953;872.7868263114276;885.2781340293068;903.9107875010596;904.3398319227001;908.1100521488978;5251.081060814342;5268.525832675077;5273.736313184326;5279.788808447619;5296.788128474895;4870.366852309248;5717.199592057115;5717.485426311652;5753.942460575425;5758.165066065397;4762.54715331382;4974.846003586973;5287.915977224659;5336.91994620081;5357.705326207096;2222.75549689534;2528.532221539021;2539.273294159989;2540.7459254074442;2543.8219324647466;4538.614217791459;4726.132083953534;4751.809927602926;4950.8762280943265;4992.500749924979;3885.320068987916;4194.87415377533;4245.596668316505;4719.362886010414;4719.4100737407825;4151.626353628128;4504.527024662429;4707.9868883915005;4967.254911763264;5012.821986833092;4268.423762791983;4587.908241835212;4667.953320466752;4761.952380476151;4848.8302909398;3896.636177337909;4397.912041759211;4724.747727045687;4739.265413860857;4759.381280433521;4623.075384923096;4660.440747110369;4774.3554620127225;4979;5063.594912407072;2855.0721015669574;3330.868244323683;3341.565596472443;3353.413152698317;3365.5120007599253;4428.54573432723;4744.240921452551;4760.668051782026;4802.639802014793;4876.975615121902;4627.490975992706;4940.505949405031;5470.753816078366;5489.725513724377;5680.715964201856;4696.788644510937;5057.418396884258;5065.240213967934;5748.45389687979;5778.537716982715;5454.645448045864;5475.698836564027;5541.7808082221845;5678.4605462480995;5709.457601527848;4572.565606267399;5693;5747.885042299215;5761.423857614205;5765.452282033368;5619.2133101365025;5645.125005624135;5666.546676265972;5672.829815105553;5678.517326027334 10:10:36 INFO - PROCESS | 1650 | |5;yui.html;658.0984051848967;674.5109795398337;786.7246463737692;835.4569529805622;836.3457359792753;13639.795403068962;16204.513864584067;16333.5916602085;17029.233684484214;17089.40187093452;15226.619334516643;15336.61658458539;15491.147986860718;15492.457763978264;15527.611809704764;584.2959234122893;745.9776206713807;879.551428771328;898.7483504618684;902.0618556701023;888.9022207557164;909.2271569166222;918.701422037837;921.8617207418907;924.2513564013137;960.519740129935;963.9228861691083;966.2752935298527;968.2592816495352;968.2689569375112;960.1646567486262;960.7886265021684;961.3510880155936;964.1708131007329;964.8263312603729;713.2688993781363;714.139461948351;714.3499415531893;714.4248879651878;715.2597062040763;15824.28790704421;15862.889597728165;15865.762013569805;15884.364625415084;15894.76157857633;13462.326883655778;13627.591172264847;13758.793618095737;13989.580312590639;14020.298985050707;13406.262655553941;13409.128406653535;13790.724185516234;13852.376643051088;13868.653283667889;4586.01400698848;4592.6555508337005;4650.813967441332;4857.514248575149;4862.927056094161;119175;119784;125481;128180;128254;9412.67055653049;10860.511276992554;11300.095992320594;11420.486078126503;11570;22697.659535106657;22828.31515054551;23081.538369232523;23148.53702925932;23150.18974335924;7176.318249766368;8463.830723385498;8502.36232282569;8539.48763074205;8583;4540.636749060067;4573.108243892409;4667.766611669471;4719.150552900511;4734.810607575659;3718.851245950186;3866.3233934061427;3866.7873266970023;3868.6905047596124;3868.903277418031;698.7135274537517;701.2671758012889;706.1138271469273;727.6361819090455;732.6373445144687;595.8986972214648;653.921529416473;703.7712743358429;708.6633848921824;739.3567596191348;9777.511124443892;10119.9494002531;10124.797504049879;10144.188464922789;10198.898011019943;662.8556619336442;674.8312921769558;708.553611224925;710.8827043537862;718.2960698515484;4643.535646435329;4962.826301079517;4964.627652926045;4966.826161084345;4984.626153038536;101232.49383753182;139587.30206349105;153546;161716;163395;138057;138369.30815345858;141262.2936885309;143123;148064.2596787009;99456.50271748594;99952;101703.4914825436;111176.99999999838;113915;8279.95860020696;9647.469389183661;10128;10213.521888613282;10244.692659220234;57025.148742561876;59690;62760.68619656873;63170.68414658081;64393;90858;91330;92884.53557732438;95065.5246723762;98625;13626.318684065955;13772.03595748288;13844.37700303509;13864;14141.787873182117;14901.478448254258;14906.627334316729;15205.77191342153;15419.691606168039;15797.68404631878;14340.641483962985;14540.854591454374;14809.407623694931;14868.553943381716;15510;14446.205458699453;14537.41850325975;14589.197594132425;14636.268186590842;14797;14011.789823152458;14223.573292801233;14258.073225240327;14479.638009049859;14996.850031499982;11502.712432189262;11635.087649738054;11725.237859539102;12001.63995080149;12298.938505307417;11545.711357216136;11627.941860290644;11735.47190376418;11735.47190376418;11735.647930562096 10:10:36 INFO - PROCESS | 1650 | __end_tp_report 10:10:36 INFO - PROCESS | 1650 | __start_cc_report 10:10:36 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1364 10:10:36 INFO - PROCESS | 1650 | __end_cc_report 10:10:36 INFO - PROCESS | 1650 | __startTimestamp1479147036024__endTimestamp 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:10:36 INFO - PROCESS | 1650 | Number of tests: 6 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5754.01 Median:6012.31 stddev:658.26 (10.9%) stddev-sans-first:622.93 10:10:36 INFO - PROCESS | 1650 | Values: 2967.8 3311.3 3409.6 3453.7 3457.3 4427.8 5708.9 5725.7 5732.5 5763.6 5643.2 5751.5 5763.2 5766.0 5829.6 5214.6 5228.3 5257.6 5281.8 5284.2 5184.0 5185.1 5185.7 5369.8 5387.8 5209.5 5287.5 5295.0 5296.4 5332.4 5236.3 5278.6 5281.9 5329.1 5341.6 5197.8 5298.4 5303.1 5305.9 5306.2 5554.0 5592.1 5625.0 5627.9 5782.6 6133.5 6231.0 6236.9 6241.0 6263.7 6267.8 6306.0 6313.2 6321.7 6330.6 5671.1 5725.3 5729.5 5762.6 5765.5 6234.4 6270.7 6281.9 6282.7 6291.1 6168.7 6169.6 6197.7 6200.7 6202.8 6132.3 6197.0 6306.8 6330.4 6338.2 6079.9 6112.1 6175.3 6190.3 6277.5 6264.0 6271.6 6274.4 6274.9 6279.9 4997.4 5042.5 5047.6 5053.5 5057.6 4394.6 4402.5 4412.2 4454.6 4489.8 5719.0 5818.3 5818.4 5819.2 5853.0 6278.4 6278.7 6287.6 6287.7 6320.1 4825.5 5581.1 5630.9 5660.5 5809.0 4888.6 5435.8 5457.2 5476.5 5546.2 6311.3 6333.7 6353.3 6373.5 6402.3 6267.7 6278.9 6307.8 6314.5 6332.7 6203.9 6220.4 6226.5 6255.0 6298.9 6231.6 6257.7 6264.5 6269.7 6273.3 6228.0 6293.6 6299.8 6312.8 6315.5 4974.4 6000.2 6056.8 6154.4 6168.8 6016.2 6149.6 6159.7 6175.2 6210.5 6012.3 6013.3 6014.3 6039.5 6076.5 5737.2 5924.8 6130.8 6165.8 6189.3 5660.7 5944.0 5971.6 6098.9 6120.6 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:76824.63 Median:19619.45 stddev:173223.90 (882.9%) stddev-sans-first:173615.04 10:10:36 INFO - PROCESS | 1650 | Values: 499.2 510.9 532.0 549.8 563.3 26241.0 36135.5 42359.0 43866.6 45708.3 44870.6 45115.8 45200.8 45269.1 45269.8 10063.8 10253.9 10254.5 10257.3 10261.7 9302.1 9540.7 12181.6 12428.6 12465.5 12410.1 12491.9 12505.6 12566.2 12580.9 12487.3 12575.8 12576.9 12577.2 12580.3 12386.9 12454.0 12458.6 12476.6 12491.8 42525.9 42602.0 42858.8 42869.8 43000.1 3506.1 3588.6 3643.0 3690.6 4464.8 28325.6 32159.8 32416.5 32545.3 33038.2 3248.1 3365.5 3388.8 3395.3 3419.3 538086.0 543473.0 544933.3 545707.3 545868.0 63903.0 64057.4 64186.0 64397.0 64442.0 35432.0 36037.0 36266.8 37180.3 37200.6 14705.8 17943.6 17952.3 17959.2 17973.6 11811.2 12153.4 12570.8 13430.8 13528.5 19687.7 20183.3 20209.8 20228.4 20412.9 6849.9 6905.7 8080.0 8158.9 8220.5 907.6 925.6 986.1 1096.5 1118.7 30853.2 31315.6 31319.0 31768.5 31876.8 1111.4 1122.4 1152.8 1156.9 1176.0 15980.4 16295.3 16398.4 16425.5 16802.7 734835.0 740737.0 741860.0 742117.3 743788.3 62331.7 62607.7 62653.0 62785.4 63063.0 1284.3 1309.7 1422.2 1433.1 1459.4 28274.9 29619.0 32833.2 32852.8 32949.7 51300.7 51892.0 51938.7 52056.7 52077.0 630882.0 637744.0 637820.4 637921.0 656961.0 22520.4 24832.6 25219.7 26986.0 27527.0 49508.0 49526.8 49692.0 50062.0 50075.5 40081.0 41364.2 41891.4 42402.0 42599.0 41052.2 41114.2 41856.8 41884.2 42359.6 39031.0 39841.8 40021.2 40370.0 40426.0 35196.6 35646.6 35650.3 36382.6 36468.5 24067.4 26488.2 26531.6 26617.3 27031.2 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:38692.74 Median:2677.38 stddev:108001.73 (4033.9%) stddev-sans-first:108266.28 10:10:36 INFO - PROCESS | 1650 | Values: 325.4 379.2 386.8 387.2 409.5 17115.5 20035.7 21873.0 22387.3 22675.8 21129.3 21456.5 21817.2 22047.3 22078.2 5930.3 5987.9 6109.5 6177.4 6185.8 4440.7 4521.5 6130.0 6135.5 6213.0 4489.5 4534.1 6834.5 6921.0 6925.3 6903.2 6903.3 6913.4 7863.0 8282.5 7730.4 7988.1 8094.8 8132.5 8134.2 30739.4 31054.5 31323.0 31618.7 32093.8 2339.5 2504.0 2633.2 2644.3 2710.4 13417.5 17402.7 17776.4 17862.9 18907.0 1884.2 2094.8 2108.2 2109.9 2130.8 76310.2 129906.4 131236.7 134222.3 142923.6 21126.7 22427.7 22526.7 22902.8 23028.5 38170.0 38190.6 38780.8 38985.8 39034.4 9259.4 9446.4 9576.2 9702.0 9778.9 6723.9 7013.1 7344.5 7433.9 7554.5 10235.7 10258.7 10405.8 10523.7 10524.4 3635.1 3648.6 3897.5 3913.3 3983.7 875.3 944.7 970.3 976.0 1015.2 16879.0 20364.2 21884.3 21902.5 22136.2 938.0 948.0 1006.8 1020.5 1021.6 10704.1 11472.0 11502.3 11529.5 11575.0 630457.0 643695.8 647810.0 660496.0 663901.0 132330.0 133360.3 134923.3 135176.0 136096.0 1028.7 1059.3 1066.5 1074.1 1075.0 18807.0 19501.6 20188.6 20286.9 20303.8 55357.5 56503.6 57506.0 57843.7 60101.7 67425.0 79628.0 80978.0 83607.0 84052.2 7395.6 7781.9 7805.1 8121.5 8138.8 11983.0 12193.6 12557.0 13028.9 13111.7 11340.7 11478.4 11535.7 11546.2 11605.4 11127.4 11222.9 11271.3 11326.9 11328.2 11484.8 11531.4 11580.6 11785.8 11898.8 7104.6 7846.3 7883.8 8285.9 8348.7 9383.8 11679.1 11821.3 11929.9 11950.3 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5991.36 Median:4949.75 stddev:3401.05 (68.7%) stddev-sans-first:3393.03 10:10:36 INFO - PROCESS | 1650 | Values: 1393.4 1536.2 1563.4 1773.6 1921.9 8283.6 8794.2 9267.9 9522.3 9576.8 9250.1 9330.4 9333.9 9342.3 9350.2 2427.8 2465.1 2465.7 2466.2 2468.7 2405.2 2466.3 2468.4 2470.3 2474.9 2414.4 2442.0 2456.9 2457.1 2458.5 2403.3 2420.9 2432.3 2441.4 2442.4 2351.4 2425.4 2429.6 2433.6 2437.3 8350.7 8601.0 9222.6 9409.5 9427.9 5410.2 5595.0 5620.9 5672.3 5684.2 3767.6 3813.4 3816.8 3889.8 3899.3 1111.3 1115.1 1118.9 1127.2 1134.3 12431.3 12531.6 12568.2 12574.2 12586.8 4806.9 4831.2 4907.9 4991.6 4997.2 8881.7 10629.5 10641.5 10647.4 10669.5 5617.0 5625.9 5627.1 5628.6 5636.0 5042.5 5061.1 5140.3 5160.6 5173.3 4092.2 4115.9 4157.8 4187.3 4194.7 1297.6 1300.1 1301.1 1315.5 1319.4 830.4 872.3 909.6 932.6 970.8 5864.8 6070.6 6196.0 6230.0 6332.0 417.1 434.2 438.5 448.0 450.9 4069.3 4087.2 4116.1 4120.9 4187.6 11002.7 11343.1 11471.7 11501.5 11511.4 11380.1 11409.5 11420.3 11421.4 11429.3 8603.6 8663.1 8674.9 8696.3 8697.5 6104.3 6120.2 6142.6 6230.2 6491.7 10409.6 10543.5 10653.7 10737.7 10738.1 8309.5 10449.6 10520.1 10743.7 10784.9 7790.1 8043.2 8050.1 8070.6 8075.3 8223.1 8267.8 8286.3 8297.4 8306.9 6742.8 7904.6 7933.1 7961.2 8055.5 7748.8 7785.7 7809.9 7848.7 7938.8 7333.1 7333.8 7347.6 7350.1 7410.7 5324.1 5333.1 5337.8 5358.7 5389.5 5249.2 5284.0 5428.6 5442.2 5454.2 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4347.62 Median:4725.44 stddev:1340.59 (28.4%) stddev-sans-first:1309.00 10:10:36 INFO - PROCESS | 1650 | Values: 272.6 303.4 307.6 314.3 317.2 4818.5 5269.1 5443.6 5496.9 5533.8 5092.6 5386.2 5387.1 5402.2 5430.3 3946.6 4123.8 4124.8 4125.4 4162.7 3884.0 4092.7 4103.3 4153.8 4185.1 3230.4 3367.5 4078.4 4088.5 4129.3 4070.5 4077.5 4102.3 4141.7 4151.8 3544.6 3556.4 3564.4 3588.9 3607.4 4946.8 5279.1 5302.4 5333.6 5371.3 3917.8 4466.2 4582.1 4618.6 4717.6 5160.4 5217.6 5632.0 5674.5 5689.0 3428.9 3641.5 3736.6 3850.1 3910.2 4962.4 5032.9 5825.8 5992.1 6014.4 3926.9 3927.7 3932.0 3946.4 3955.1 3391.4 3403.0 3946.0 4009.3 4012.2 3888.0 4626.0 4650.6 4669.0 4676.0 5694.6 5714.7 5719.5 5738.3 5753.4 1093.9 1145.5 1166.3 1274.8 1352.8 872.8 885.3 903.9 904.3 908.1 5251.1 5268.5 5273.7 5279.8 5296.8 4870.4 5717.2 5717.5 5753.9 5758.2 4762.5 4974.8 5287.9 5336.9 5357.7 2222.8 2528.5 2539.3 2540.7 2543.8 4538.6 4726.1 4751.8 4950.9 4992.5 3885.3 4194.9 4245.6 4719.4 4719.4 4151.6 4504.5 4708.0 4967.3 5012.8 4268.4 4587.9 4668.0 4762.0 4848.8 3896.6 4397.9 4724.7 4739.3 4759.4 4623.1 4660.4 4774.4 4979.0 5063.6 2855.1 3330.9 3341.6 3353.4 3365.5 4428.5 4744.2 4760.7 4802.6 4877.0 4627.5 4940.5 5470.8 5489.7 5680.7 4696.8 5057.4 5065.2 5748.5 5778.5 5454.6 5475.7 5541.8 5678.5 5709.5 4572.6 5693.0 5747.9 5761.4 5765.5 5619.2 5645.1 5666.5 5672.8 5678.5 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25796.23 Median:22954.93 stddev:40931.91 (178.3%) stddev-sans-first:41003.21 10:10:36 INFO - PROCESS | 1650 | Values: 658.1 674.5 786.7 835.5 836.3 13639.8 16204.5 16333.6 17029.2 17089.4 15226.6 15336.6 15491.1 15492.5 15527.6 584.3 746.0 879.6 898.7 902.1 888.9 909.2 918.7 921.9 924.3 960.5 963.9 966.3 968.3 968.3 960.2 960.8 961.4 964.2 964.8 713.3 714.1 714.3 714.4 715.3 15824.3 15862.9 15865.8 15884.4 15894.8 13462.3 13627.6 13758.8 13989.6 14020.3 13406.3 13409.1 13790.7 13852.4 13868.7 4586.0 4592.7 4650.8 4857.5 4862.9 119175.0 119784.0 125481.0 128180.0 128254.0 9412.7 10860.5 11300.1 11420.5 11570.0 22697.7 22828.3 23081.5 23148.5 23150.2 7176.3 8463.8 8502.4 8539.5 8583.0 4540.6 4573.1 4667.8 4719.2 4734.8 3718.9 3866.3 3866.8 3868.7 3868.9 698.7 701.3 706.1 727.6 732.6 595.9 653.9 703.8 708.7 739.4 9777.5 10119.9 10124.8 10144.2 10198.9 662.9 674.8 708.6 710.9 718.3 4643.5 4962.8 4964.6 4966.8 4984.6 101232.5 139587.3 153546.0 161716.0 163395.0 138057.0 138369.3 141262.3 143123.0 148064.3 99456.5 99952.0 101703.5 111177.0 113915.0 8280.0 9647.5 10128.0 10213.5 10244.7 57025.1 59690.0 62760.7 63170.7 64393.0 90858.0 91330.0 92884.5 95065.5 98625.0 13626.3 13772.0 13844.4 13864.0 14141.8 14901.5 14906.6 15205.8 15419.7 15797.7 14340.6 14540.9 14809.4 14868.6 15510.0 14446.2 14537.4 14589.2 14636.3 14797.0 14011.8 14223.6 14258.1 14479.6 14996.9 11502.7 11635.1 11725.2 12001.6 12298.9 11545.7 11627.9 11735.5 11735.5 11735.6 10:10:36 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:10:36 INFO - PROCESS | 1650 | 10:10:36 INFO - TEST-INFO | 1650: exit 0 10:10:36 INFO - TEST-OK | dromaeo_css | took 1114498ms 10:10:36 INFO - TEST-START | kraken 10:10:36 INFO - operating with platform_type : mac_ 10:10:36 INFO - Initialising browser for kraken test... 10:10:36 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpK22ssY/profile http://localhost:49277/getInfo.html) 10:10:38 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 10:10:38 INFO - PROCESS | 1660 | colorDepth:24 10:10:38 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 10:10:38 INFO - PROCESS | 1660 | __metrics 10:10:38 INFO - PROCESS | 1660 | 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" 10:10:38 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:39 INFO - TEST-INFO | 1660: exit 0 10:10:39 INFO - Browser initialized. 10:10:39 INFO - Running cycle 1/1 for kraken test... 10:10:39 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpK22ssY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:51 INFO - PROCESS | 1662 | RSS: Main: 168493056 10:10:51 INFO - PROCESS | 1662 | 10:10:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:55 INFO - PROCESS | 1662 | RSS: Main: 218324992 10:10:55 INFO - PROCESS | 1662 | 10:10:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 10:10:58 INFO - PROCESS | 1662 | RSS: Main: 230064128 10:10:58 INFO - PROCESS | 1662 | 10:11:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 10:11:02 INFO - PROCESS | 1662 | RSS: Main: 325799936 10:11:02 INFO - PROCESS | 1662 | 10:11:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 10:11:04 INFO - PROCESS | 1662 | RSS: Main: 229326848 10:11:04 INFO - PROCESS | 1662 | 10:11:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:07 INFO - PROCESS | 1662 | RSS: Main: 230072320 10:11:07 INFO - PROCESS | 1662 | 10:11:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:10 INFO - PROCESS | 1662 | RSS: Main: 268922880 10:11:10 INFO - PROCESS | 1662 | 10:11:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:14 INFO - PROCESS | 1662 | RSS: Main: 266878976 10:11:14 INFO - PROCESS | 1662 | 10:11:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 10:11:17 INFO - PROCESS | 1662 | RSS: Main: 263454720 10:11:17 INFO - PROCESS | 1662 | 10:11:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:19 INFO - PROCESS | 1662 | RSS: Main: 240988160 10:11:19 INFO - PROCESS | 1662 | 10:11:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:22 INFO - PROCESS | 1662 | RSS: Main: 244174848 10:11:22 INFO - PROCESS | 1662 | 10:11:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:25 INFO - PROCESS | 1662 | RSS: Main: 248516608 10:11:25 INFO - PROCESS | 1662 | 10:11:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:28 INFO - PROCESS | 1662 | RSS: Main: 261910528 10:11:28 INFO - PROCESS | 1662 | 10:11:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:32 INFO - PROCESS | 1662 | RSS: Main: 255672320 10:11:32 INFO - PROCESS | 1662 | 10:11:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 10:11:34 INFO - PROCESS | 1662 | RSS: Main: 299802624 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | __start_tp_report 10:11:34 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 10:11:34 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 10:11:34 INFO - PROCESS | 1662 | |i|pagename|runs| 10:11:34 INFO - PROCESS | 1662 | |0;ai-astar;115;110;113;113;112;113;112;111;112;113 10:11:34 INFO - PROCESS | 1662 | |1;audio-beat-detection;142;110;107;140;107;105;107;105;135;107 10:11:34 INFO - PROCESS | 1662 | |2;audio-dft;176;182;181;184;184;184;187;184;183;183 10:11:34 INFO - PROCESS | 1662 | |3;audio-fft;76;60;59;88;58;58;58;58;94;57 10:11:34 INFO - PROCESS | 1662 | |4;audio-oscillator;89;93;126;103;68;69;93;67;67;89 10:11:34 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;90;87;89;86;90;87;90;86 10:11:34 INFO - PROCESS | 1662 | |6;imaging-darkroom;94;93;96;95;94;94;94;94;100;95 10:11:34 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;84;84;85;84;87;83;89;84;84 10:11:34 INFO - PROCESS | 1662 | |8;json-parse-financial;55;53;52;51;55;55;53;52;75;87 10:11:34 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;71;68;75;73;67;68;69;69;70 10:11:34 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;95;99;101;99;76;80;83;80;81 10:11:34 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;135;154;141;129;134;136;136;148;190;165 10:11:34 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;160;160;160;164;162;156;212;176;157;160 10:11:34 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;65;67;65;64;65;66;73;59;81 10:11:34 INFO - PROCESS | 1662 | __end_tp_report 10:11:34 INFO - PROCESS | 1662 | __start_cc_report 10:11:34 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1852 10:11:34 INFO - PROCESS | 1662 | __end_cc_report 10:11:34 INFO - PROCESS | 1662 | __startTimestamp1479147094145__endTimestamp 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | ------- Summary: start ------- 10:11:34 INFO - PROCESS | 1662 | Number of tests: 14 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 10:11:34 INFO - PROCESS | 1662 | Values: 115.0 110.0 113.0 113.0 112.0 113.0 112.0 111.0 112.0 113.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:108.50 stddev:15.68 (14.5%) stddev-sans-first:13.65 10:11:34 INFO - PROCESS | 1662 | Values: 142.0 110.0 107.0 140.0 107.0 105.0 107.0 105.0 135.0 107.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.80 Median:184.00 stddev:2.86 (1.6%) stddev-sans-first:1.67 10:11:34 INFO - PROCESS | 1662 | Values: 176.0 182.0 181.0 184.0 184.0 184.0 187.0 184.0 183.0 183.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.60 Median:59.50 stddev:14.09 (23.7%) stddev-sans-first:14.53 10:11:34 INFO - PROCESS | 1662 | Values: 76.0 60.0 59.0 88.0 58.0 58.0 58.0 58.0 94.0 57.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:79.00 stddev:19.26 (24.4%) stddev-sans-first:20.40 10:11:34 INFO - PROCESS | 1662 | Values: 89.0 93.0 126.0 103.0 68.0 69.0 93.0 67.0 67.0 89.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.50 stddev:1.75 (2.0%) stddev-sans-first:1.73 10:11:34 INFO - PROCESS | 1662 | Values: 90.0 87.0 90.0 87.0 89.0 86.0 90.0 87.0 90.0 86.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.00 stddev:1.97 (2.1%) stddev-sans-first:2.06 10:11:34 INFO - PROCESS | 1662 | Values: 94.0 93.0 96.0 95.0 94.0 94.0 94.0 94.0 100.0 95.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:84.50 stddev:1.79 (2.1%) stddev-sans-first:1.90 10:11:34 INFO - PROCESS | 1662 | Values: 85.0 84.0 84.0 85.0 84.0 87.0 83.0 89.0 84.0 84.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:55.00 stddev:12.12 (22.0%) stddev-sans-first:12.77 10:11:34 INFO - PROCESS | 1662 | Values: 55.0 53.0 52.0 51.0 55.0 55.0 53.0 52.0 75.0 87.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:3.10 (4.5%) stddev-sans-first:2.60 10:11:34 INFO - PROCESS | 1662 | Values: 64.0 71.0 68.0 75.0 73.0 67.0 68.0 69.0 69.0 70.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.00 stddev:9.60 (11.6%) stddev-sans-first:10.03 10:11:34 INFO - PROCESS | 1662 | Values: 83.0 95.0 99.0 101.0 99.0 76.0 80.0 83.0 80.0 81.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:144.50 stddev:18.67 (12.9%) stddev-sans-first:19.31 10:11:34 INFO - PROCESS | 1662 | Values: 135.0 154.0 141.0 129.0 134.0 136.0 136.0 148.0 190.0 165.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:161.00 stddev:16.85 (10.5%) stddev-sans-first:17.70 10:11:34 INFO - PROCESS | 1662 | Values: 160.0 160.0 160.0 164.0 162.0 156.0 212.0 176.0 157.0 160.0 10:11:34 INFO - PROCESS | 1662 | 10:11:34 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.00 stddev:5.95 (9.0%) stddev-sans-first:6.30 10:11:34 INFO - PROCESS | 1662 | Values: 66.0 65.0 67.0 65.0 64.0 65.0 66.0 73.0 59.0 81.0 10:11:34 INFO - PROCESS | 1662 | -------- Summary: end -------- 10:11:34 INFO - PROCESS | 1662 | 10:11:35 INFO - TEST-INFO | 1662: exit 0 10:11:35 INFO - TEST-OK | kraken | took 58463ms 10:11:35 INFO - SUITE-END | took 1172s 10:11:35 INFO - Completed test suite (00:19:33) 10:11:35 INFO - javascript benchmark 10:11:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2967.7625789936806, 3311.2880730642905, 3409.5738032745912, 3453.7064349530287, 3457.2566898116916, 4427.800748966296, 5708.885822283562, 5725.656460612367, 5732.48407643312, 5763.625364351319, 5643.209950606918, 5751.482366587006, 5763.193152958589, 5766.0, 5829.562782791297, 5214.582833373331, 5228.320318358608, 5257.579393648499, 5281.762320695559, 5284.180951952453, 5183.974080129594, 5185.066687996159, 5185.662931909433, 5369.776201199716, 5387.838364849061, 5209.531142197202, 5287.47125287472, 5295.0468915595175, 5296.390915044762, 5332.413434522199, 5236.266922630834, 5278.630495865291, 5281.9207711884355, 5329.067413202674, 5341.599380046473, 5197.8440646780655, 5298.36419629643, 5303.098473259516, 5305.8938821223355, 5306.151015837486, 5554.000279949608, 5592.105263157916, 5624.971875140639, 5627.915581266284, 5782.624129431616, 6133.548895741652, 6231.0, 6236.906446403307, 6241.0, 6263.749450021994, 6267.811965641038, 6306.0, 6313.210848643919, 6321.6523091229965, 6330.556861019731, 5671.06427439472, 5725.341585717612, 5729.541636669056, 5762.567807414461, 5765.4522820332, 6234.438900498977, 6270.7491700331475, 6281.937180628227, 6282.654454004982, 6291.087792270096, 6168.722407491674, 6169.56813023093, 6197.659128747962, 6200.658963756947, 6202.782902598477, 6132.324915438597, 6197.03945888388, 6306.810795676137, 6330.366963303725, 6338.207724034496, 6079.908801367983, 6112.103317728923, 6175.258968923668, 6190.2571691397325, 6277.466415354655, 6264.029075493306, 6271.560990730696, 6274.403931626488, 6274.937250627435, 6279.874402512016, 4997.350344455198, 5042.546170844642, 5047.570956468668, 5053.46938571452, 5057.620678449058, 4394.560543945579, 4402.515723270438, 4412.161689279027, 4454.643628509776, 4489.7979590918485, 5719.0, 5818.272715910512, 5818.389069147764, 5819.185314056035, 5853.034249348895, 6278.4035516625845, 6278.6546739929745, 6287.559870809091, 6287.685615719196, 6320.146780184708, 4825.4933232010835, 5581.134924086773, 5630.85922851932, 5660.5471562274915, 5808.983427900185, 4888.557875426758, 5435.83692489226, 5457.181422786534, 5476.479734425223, 5546.168074788733, 6311.27420346666, 6333.65164915934, 6353.269374021954, 6373.490120790326, 6402.327755585597, 6267.6866156692895, 6278.905816412849, 6307.810765677037, 6314.494840412848, 6332.651704156131, 6203.875922481616, 6220.440160385587, 6226.501879849692, 6255.0, 6298.905516417349, 6231.5637905348, 6257.655828929271, 6264.49884009269, 6269.655168965751, 6273.309935906956, 6228.0, 6293.559450838397, 6299.842503937438, 6312.779052733133, 6315.5263355247625, 4974.427940786711, 6000.189974353407, 6056.848578785565, 6154.353792851686, 6168.845778855564, 6016.157737916783, 6149.569530133027, 6159.692015399301, 6175.228096487939, 6210.472109870711, 6012.308584512837, 6013.308469525886, 6014.338422773579, 6039.506320413507, 6076.483498902643, 5737.225474560881, 5924.763009479572, 6130.788151533453, 6165.784197553064, 6189.319174890668, 5660.745266463102, 5943.970280148572, 5971.641701497924, 6098.908516372347, 6120.571559990758], "value": 5711.670055682675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2237071354043, 510.90292844359567, 531.9946800531994, 549.7636016512898, 563.3268244447884, 26240.999999999975, 36135.4579681305, 42359.0, 43866.56133438665, 45708.3143752844, 44870.55129448713, 45115.77442112785, 45200.773996129974, 45269.09461810762, 45269.7736511317, 10063.849042264372, 10253.897461025368, 10254.487275636226, 10257.281990260684, 10261.743456413613, 9302.069793020677, 9540.666076687317, 12181.634550963441, 12428.62714118578, 12465.501379944792, 12410.131290809646, 12491.875081249207, 12505.624831255076, 12566.24602523847, 12580.874191258108, 12487.31319777412, 12575.811362829565, 12576.937115314366, 12577.245365278113, 12580.308083055428, 12386.876131238752, 12454.0, 12458.626241212778, 12476.625701228977, 12491.750164996649, 42525.93685157865, 42602.0, 42858.78570607158, 42869.78565107154, 43000.1399972002, 3506.140995456104, 3588.6052534221217, 3642.9981755017316, 3690.55713314404, 4464.8214071437105, 28325.57511637327, 32159.83920080408, 32416.513752293733, 32545.295613477396, 33038.17404564905, 3248.10677063807, 3365.495175723661, 3388.762786604939, 3395.2530443302435, 3419.2990436960363, 538086.0, 543473.0, 544933.2753336208, 545707.2714636441, 545868.0, 63903.0, 64057.35942640514, 64186.0, 64397.0, 64442.0, 35432.0, 36037.0, 36266.8186659065, 37180.256394871954, 37200.62799371972, 14705.779413308808, 17943.641127177645, 17952.281908723504, 17959.191836367394, 17973.550661233574, 11811.173217874666, 12153.392330383445, 12570.811437828439, 13430.798538021938, 13528.526501572398, 19687.704684429744, 20183.293584724463, 20209.797902021084, 20228.393148205578, 20412.897935510227, 6849.863002739918, 6905.723771049102, 8079.959600201962, 8158.898548695969, 8220.506284829044, 907.6278725722422, 925.6112432778249, 986.1420564109128, 1096.4846522134744, 1118.7426891814928, 30853.228669283, 31315.5552889182, 31319.0, 31768.531726635174, 31876.840615796773, 1111.3554138599593, 1122.4331712485307, 1152.8213126965334, 1156.9074474042056, 1175.9588414405455, 15980.360785568679, 16295.348186072424, 16398.426055088254, 16425.507234782977, 16802.663946720997, 734835.0, 740737.0, 741860.0, 742117.2894135495, 743788.281058602, 62331.688341558, 62607.686961565814, 62653.0, 62785.37214627795, 63063.0, 1284.344984058137, 1309.7184105417382, 1422.239102080382, 1433.1401159304542, 1459.4454107439105, 28274.858625707562, 29619.0, 32833.179170520925, 32852.835735822126, 32949.67050329466, 51300.71748206325, 51892.0, 51938.74030629974, 52056.73971630118, 52076.95846083133, 630882.0, 637744.0, 637820.4326935007, 637921.0, 656961.0, 22520.436989075406, 24832.627510586994, 25219.747802522474, 26986.0, 27527.0, 49508.0, 49526.75236623794, 49692.0, 50062.0, 50075.499245007086, 40081.0, 41364.1727165449, 41891.41402821985, 42402.0, 42599.0, 41052.1789564213, 41114.1777164461, 41856.79071604623, 41884.23938960429, 42359.576404236795, 39031.0, 39841.80079099586, 40021.19957600773, 40370.0, 40426.0, 35196.648033519334, 35646.57413703526, 35650.28699426049, 36382.63617363898, 36468.45297320595, 24067.398315042265, 26488.2302786738, 26531.60202596924, 26617.334566635214, 27031.1890643281], "value": 21138.619909252033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3736557127529, 379.1809691067297, 386.82012864018225, 387.15793149898974, 409.4533797380497, 17115.486535403943, 20035.699464508027, 21873.0, 22387.32838014858, 22675.773242267573, 21129.260475883348, 21456.463588410297, 21817.23639672612, 22047.33857984259, 22078.22726204583, 5930.318013428468, 5987.940120598803, 6109.450149486545, 6177.413145751147, 6185.845353866144, 4440.689151759379, 4521.502634710179, 6129.969350153243, 6135.539834512407, 6213.0, 4489.4612646482465, 4534.070515544306, 6834.521583489158, 6921.031055652213, 6925.272846351136, 6903.206131294915, 6903.344182302673, 6913.377795998334, 7863.0, 8282.544460054694, 7730.420218483636, 7988.081370642392, 8094.838103237902, 8132.471389359673, 8134.227248411451, 30739.38521229563, 31054.53418198729, 31323.0, 31618.735250589947, 32093.839530802197, 2339.4619237575284, 2504.0484615846044, 2633.2231991562344, 2644.338915271182, 2710.417260289047, 13417.530386436525, 17402.738958915626, 17776.37782677613, 17862.92822430645, 18906.96011719355, 1884.1615481110912, 2094.7591027031935, 2108.1988844239245, 2109.862858914166, 2130.840186985982, 76310.23689763142, 129906.350468248, 131236.71908202276, 134222.3288883559, 142923.57076429206, 21126.683099753514, 22427.663585046237, 22526.66210006851, 22902.770972290396, 23028.539429211323, 38170.0, 38190.61809381926, 38780.80609596991, 38985.805070974464, 39034.41448378276, 9259.35184537076, 9446.38598491096, 9576.186024188022, 9702.0, 9778.902210977942, 6723.865522689616, 7013.053237812932, 7344.48588598793, 7433.85132297351, 7554.526867260941, 10235.744106397251, 10258.743531411774, 10405.84391234132, 10523.736906577244, 10524.36853788775, 3635.1457407509215, 3648.5621725392593, 3897.5322961244265, 3913.25648126855, 3983.661388781986, 875.3085062800444, 944.6646440513656, 970.2819913264275, 975.9853602195831, 1015.2385710716962, 16879.0, 20364.185432582828, 21884.343469695934, 21902.45243868884, 22136.22523211712, 937.9812403752023, 947.9857802132974, 1006.808706345792, 1020.4846552491093, 1021.5556233038652, 10704.090152336983, 11472.0, 11502.252353596989, 11529.481173347052, 11575.0, 630457.0, 643695.7815210894, 647810.0, 660496.0, 663901.0, 132330.0, 133360.3331983334, 134923.32538337246, 135176.0, 136096.0, 1028.6759670703705, 1059.2638116509106, 1066.4774260612244, 1074.1084899533369, 1075.0378411321824, 18807.0, 19501.609967800847, 20188.59622807565, 20286.89856550767, 20303.79696203078, 55357.50891209986, 56503.58741031343, 57506.0, 57843.71078144751, 60101.699491502266, 67425.0, 79628.0, 80978.0, 83607.0, 84052.15947840443, 7395.556266624019, 7781.92218077812, 7805.063392392949, 8121.4721043132, 8138.796530086558, 11983.0, 12193.634190974284, 12557.0, 13028.869711302767, 13111.737765244832, 11340.659780206606, 11478.426078696199, 11535.711607209887, 11546.19176657626, 11605.446801703612, 11127.387993660426, 11222.943885280847, 11271.323720576791, 11326.923942225476, 11328.207025508465, 11484.82772758426, 11531.423428828357, 11580.594679186188, 11785.823212651645, 11898.76202475963, 7104.573725576482, 7846.254605812439, 7883.802904927423, 8285.917140828757, 8348.66605335804, 9383.765405864908, 11679.06567474583, 11821.290722556674, 11929.880701192877, 11950.34273114987], "value": 11085.29352637978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.3590548347759, 1536.1704679473085, 1563.351209248162, 1773.6098058427149, 1921.9327323543678, 8283.627236774344, 8794.164554367333, 9267.860982085265, 9522.333436659437, 9576.80846383072, 9250.121238482334, 9330.44017358959, 9333.90666093339, 9342.299327550427, 9350.205232555241, 2427.757224277576, 2465.0755966512556, 2465.7287698353166, 2466.2477944227003, 2468.7037555493366, 2405.2423486601665, 2466.2971053249826, 2468.3582268610203, 2470.28361775085, 2474.8886300116537, 2414.4326083370393, 2442.023190723707, 2456.914008009711, 2457.054034196838, 2458.4960083182996, 2403.286308205365, 2420.878956052199, 2432.2946345559853, 2441.389652586853, 2442.3527765142253, 2351.3651314145254, 2425.4300239443714, 2429.6112621980396, 2433.6471211674384, 2437.2566367257978, 8350.70772522965, 8601.010883748324, 9222.584983675752, 9409.529523523865, 9427.858582121273, 5410.1614249790955, 5595.0, 5620.91568626471, 5672.34768001681, 5684.2326285951285, 3767.585565587783, 3813.389857622767, 3816.7709937403843, 3889.8055097245024, 3899.337112690849, 1111.3276467736985, 1115.1134847796022, 1118.9048930840888, 1127.21095233337, 1134.2967360236623, 12431.316277604728, 12531.624051278477, 12568.183068100545, 12574.245545267313, 12586.811197831948, 4806.927896081562, 4831.227003679394, 4907.9263811042865, 4991.575716064175, 4997.150484417658, 8881.689140880038, 10629.468526573795, 10641.467926603638, 10647.414392208348, 10669.519871605797, 5616.97191514048, 5625.915611265835, 5627.099664053731, 5628.60599758013, 5636.04187288162, 5042.4705405931845, 5061.139606266944, 5140.280360749498, 5160.612954028388, 5173.327467429285, 4092.242935057024, 4115.855945041909, 4157.812898419578, 4187.309093999456, 4194.664426845845, 1297.5588299978053, 1300.1224173682726, 1301.1087405127519, 1315.526410492222, 1319.399673148715, 830.3772170871846, 872.254222639634, 909.5861383070819, 932.6176267730198, 970.8058388322364, 5864.824055278348, 6070.605410648293, 6195.96902015487, 6230.0, 6332.018537126753, 417.0969850274183, 434.2444147183877, 438.48040072514175, 447.95296493868324, 450.9458864936163, 4069.328560787496, 4087.1621317629815, 4116.115035267372, 4120.91758164835, 4187.644050255702, 11002.724931876766, 11343.149263805082, 11471.655850324503, 11501.482433290523, 11511.424428778528, 11380.146489013192, 11409.48657310423, 11420.31478111316, 11421.371824549564, 11429.257098288585, 8603.612837422332, 8663.133686631412, 8674.913250867537, 8696.260817830555, 8697.521636309937, 6104.32852386246, 6120.234970628671, 6142.57002009855, 6230.158928544589, 6491.707873145625, 10409.583616655249, 10543.525541350811, 10653.733656658645, 10737.731556711145, 10738.14094872424, 8309.459885107448, 10449.634262800766, 10520.053195212467, 10743.731406714895, 10784.892151078702, 7790.104138023973, 8043.19568043191, 8050.114487406264, 8070.556119413489, 8075.273225409741, 8223.09545949933, 8267.751967440987, 8286.254237118688, 8297.419180657296, 8306.87539686893, 6742.797716068526, 7904.565248911365, 7933.087694914928, 7961.203879612224, 8055.476394034369, 7748.8450230996195, 7785.727499537489, 7809.921900781147, 7848.686052558062, 7938.841223175388, 7333.083364579427, 7333.779986600411, 7347.595882226529, 7350.117985841734, 7410.6665200065045, 5324.068288049653, 5333.120035194304, 5337.813176538958, 5358.732063396893, 5389.51494365509, 5249.238860365302, 5284.0, 5428.592855535771, 5442.210879422382, 5454.2091396746455], "value": 4706.477140117824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.64011504813647, 303.4492396300714, 307.5770815129197, 314.2834337710022, 317.1943264109163, 4818.45809341011, 5269.130593452085, 5443.564514838813, 5496.862578435541, 5533.778648854051, 5092.643514953955, 5386.245925570413, 5387.117891927819, 5402.189671549269, 5430.266913966613, 3946.6320207875333, 4123.79381030948, 4124.752514849119, 4125.422440858282, 4162.687798415116, 3883.9513331400503, 4092.7135100542973, 4103.343465045593, 4153.750774953497, 4185.142045880602, 3230.370077834823, 3367.54538137352, 4078.3678529827926, 4088.4889388826396, 4129.29801933672, 4070.4911886014247, 4077.5106987161435, 4102.3026085565525, 4141.689373296985, 4151.792410379499, 3544.556930383702, 3556.413191823372, 3564.3940530109944, 3588.9282214355567, 3607.4228123500375, 4946.752662366867, 5279.128943724281, 5302.3637163540625, 5333.57331413486, 5371.328583927009, 3917.8432862685745, 4466.218411777958, 4582.1064892346, 4618.552167351276, 4717.646176536739, 5160.432352441228, 5217.5565076968505, 5632.014397480466, 5674.489295963342, 5689.004424225785, 3428.919890234568, 3641.4719865619336, 3736.5702944161226, 3850.1144736710435, 3910.2179564087296, 4962.379702537183, 5032.874178145539, 5825.79609713658, 5992.1237805853, 6014.398560143951, 3926.8821935341984, 3927.666148377363, 3932.0, 3946.4474973503734, 3955.110100227483, 3391.372596069735, 3403.030136411111, 3946.0, 4009.258287216874, 4012.1945124694003, 3887.9805600971813, 4626.0, 4650.6046986005895, 4668.972825978347, 4676.012694604779, 5694.60137790359, 5714.685692286881, 5719.484336650791, 5738.311402631711, 5753.367129615739, 1093.9288946218471, 1145.5360578965533, 1166.3235323512342, 1274.8024056271292, 1352.8038434426953, 872.7868263114276, 885.2781340293068, 903.9107875010596, 904.3398319227001, 908.1100521488978, 5251.081060814342, 5268.525832675077, 5273.736313184326, 5279.788808447619, 5296.788128474895, 4870.366852309248, 5717.199592057115, 5717.485426311652, 5753.942460575425, 5758.165066065397, 4762.54715331382, 4974.846003586973, 5287.915977224659, 5336.91994620081, 5357.705326207096, 2222.75549689534, 2528.532221539021, 2539.273294159989, 2540.7459254074442, 2543.8219324647466, 4538.614217791459, 4726.132083953534, 4751.809927602926, 4950.8762280943265, 4992.500749924979, 3885.320068987916, 4194.87415377533, 4245.596668316505, 4719.362886010414, 4719.4100737407825, 4151.626353628128, 4504.527024662429, 4707.9868883915005, 4967.254911763264, 5012.821986833092, 4268.423762791983, 4587.908241835212, 4667.953320466752, 4761.952380476151, 4848.8302909398, 3896.636177337909, 4397.912041759211, 4724.747727045687, 4739.265413860857, 4759.381280433521, 4623.075384923096, 4660.440747110369, 4774.3554620127225, 4979.0, 5063.594912407072, 2855.0721015669574, 3330.868244323683, 3341.565596472443, 3353.413152698317, 3365.5120007599253, 4428.54573432723, 4744.240921452551, 4760.668051782026, 4802.639802014793, 4876.975615121902, 4627.490975992706, 4940.505949405031, 5470.753816078366, 5489.725513724377, 5680.715964201856, 4696.788644510937, 5057.418396884258, 5065.240213967934, 5748.45389687979, 5778.537716982715, 5454.645448045864, 5475.698836564027, 5541.7808082221845, 5678.4605462480995, 5709.457601527848, 4572.565606267399, 5693.0, 5747.885042299215, 5761.423857614205, 5765.452282033368, 5619.2133101365025, 5645.125005624135, 5666.546676265972, 5672.829815105553, 5678.517326027334], "value": 3922.8641261157777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.0984051848967, 674.5109795398337, 786.7246463737692, 835.4569529805622, 836.3457359792753, 13639.795403068962, 16204.513864584067, 16333.5916602085, 17029.233684484214, 17089.40187093452, 15226.619334516643, 15336.61658458539, 15491.147986860718, 15492.457763978264, 15527.611809704764, 584.2959234122893, 745.9776206713807, 879.551428771328, 898.7483504618684, 902.0618556701023, 888.9022207557164, 909.2271569166222, 918.701422037837, 921.8617207418907, 924.2513564013137, 960.519740129935, 963.9228861691083, 966.2752935298527, 968.2592816495352, 968.2689569375112, 960.1646567486262, 960.7886265021684, 961.3510880155936, 964.1708131007329, 964.8263312603729, 713.2688993781363, 714.139461948351, 714.3499415531893, 714.4248879651878, 715.2597062040763, 15824.28790704421, 15862.889597728165, 15865.762013569805, 15884.364625415084, 15894.76157857633, 13462.326883655778, 13627.591172264847, 13758.793618095737, 13989.580312590639, 14020.298985050707, 13406.262655553941, 13409.128406653535, 13790.724185516234, 13852.376643051088, 13868.653283667889, 4586.01400698848, 4592.6555508337005, 4650.813967441332, 4857.514248575149, 4862.927056094161, 119175.0, 119784.0, 125481.0, 128180.0, 128254.0, 9412.67055653049, 10860.511276992554, 11300.095992320594, 11420.486078126503, 11570.0, 22697.659535106657, 22828.31515054551, 23081.538369232523, 23148.53702925932, 23150.18974335924, 7176.318249766368, 8463.830723385498, 8502.36232282569, 8539.48763074205, 8583.0, 4540.636749060067, 4573.108243892409, 4667.766611669471, 4719.150552900511, 4734.810607575659, 3718.851245950186, 3866.3233934061427, 3866.7873266970023, 3868.6905047596124, 3868.903277418031, 698.7135274537517, 701.2671758012889, 706.1138271469273, 727.6361819090455, 732.6373445144687, 595.8986972214648, 653.921529416473, 703.7712743358429, 708.6633848921824, 739.3567596191348, 9777.511124443892, 10119.9494002531, 10124.797504049879, 10144.188464922789, 10198.898011019943, 662.8556619336442, 674.8312921769558, 708.553611224925, 710.8827043537862, 718.2960698515484, 4643.535646435329, 4962.826301079517, 4964.627652926045, 4966.826161084345, 4984.626153038536, 101232.49383753182, 139587.30206349105, 153546.0, 161716.0, 163395.0, 138057.0, 138369.30815345858, 141262.2936885309, 143123.0, 148064.2596787009, 99456.50271748594, 99952.0, 101703.4914825436, 111176.99999999838, 113915.0, 8279.95860020696, 9647.469389183661, 10128.0, 10213.521888613282, 10244.692659220234, 57025.148742561876, 59690.0, 62760.68619656873, 63170.68414658081, 64393.0, 90858.0, 91330.0, 92884.53557732438, 95065.5246723762, 98625.0, 13626.318684065955, 13772.03595748288, 13844.37700303509, 13864.0, 14141.787873182117, 14901.478448254258, 14906.627334316729, 15205.77191342153, 15419.691606168039, 15797.68404631878, 14340.641483962985, 14540.854591454374, 14809.407623694931, 14868.553943381716, 15510.0, 14446.205458699453, 14537.41850325975, 14589.197594132425, 14636.268186590842, 14797.0, 14011.789823152458, 14223.573292801233, 14258.073225240327, 14479.638009049859, 14996.850031499982, 11502.712432189262, 11635.087649738054, 11725.237859539102, 12001.63995080149, 12298.938505307417, 11545.711357216136, 11627.941860290644, 11735.47190376418, 11735.47190376418, 11735.647930562096], "value": 8271.058032105733, "unit": "score"}], "name": "dromaeo_css", "value": 7675.084382525254, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 113.0, 112.0, 113.0, 112.0, 111.0, 112.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 107.0, 140.0, 107.0, 105.0, 107.0, 105.0, 135.0, 107.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 181.0, 184.0, 184.0, 184.0, 187.0, 184.0, 183.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 60.0, 59.0, 88.0, 58.0, 58.0, 58.0, 58.0, 94.0, 57.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 126.0, 103.0, 68.0, 69.0, 93.0, 67.0, 67.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 96.0, 95.0, 94.0, 94.0, 94.0, 94.0, 100.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 87.0, 83.0, 89.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 51.0, 55.0, 55.0, 53.0, 52.0, 75.0, 87.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 75.0, 73.0, 67.0, 68.0, 69.0, 69.0, 70.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 95.0, 99.0, 101.0, 99.0, 76.0, 80.0, 83.0, 80.0, 81.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 154.0, 141.0, 129.0, 134.0, 136.0, 136.0, 148.0, 190.0, 165.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 164.0, 162.0, 156.0, 212.0, 176.0, 157.0, 160.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 64.0, 65.0, 66.0, 73.0, 59.0, 81.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1429.1999999999998, "alertThreshold": 2.0}]} 10:11:35 INFO - Return code: 0 10:11:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:35 INFO - # TBPL SUCCESS # 10:11:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:35 INFO - 2016-11-14 10:11:35.458 screenresolution[1666:9872] starting screenresolution argv=screenresolution get 10:11:35 INFO - 2016-11-14 10:11:35.462 screenresolution[1666:9872] Display 0: 1600x1200x32@60 10:11:35 INFO - 2016-11-14 10:11:35.468 screenresolution[1667:9875] starting screenresolution argv=screenresolution list 10:11:35 INFO - Available Modes on Display 0 10:11:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:35 INFO - Intel Iris: 10:11:35 INFO - Chipset Model: Intel Iris 10:11:35 INFO - Type: GPU 10:11:35 INFO - Bus: Built-In 10:11:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:35 INFO - Vendor: Intel (0x8086) 10:11:35 INFO - Device ID: 0x0a2e 10:11:35 INFO - Revision ID: 0x0009 10:11:35 INFO - Displays: 10:11:35 INFO - Display: 10:11:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:35 INFO - Display Serial Number: 1600x1200 60 10:11:35 INFO - Main Display: Yes 10:11:35 INFO - Mirror: Off 10:11:35 INFO - Online: Yes 10:11:35 INFO - Rotation: Supported 10:11:35 INFO - Return code: 0 10:11:35 INFO - Running post-action listener: _resource_record_post_action 10:11:35 INFO - [mozharness: 2016-11-14 18:11:35.708761Z] Finished run-tests step (success) 10:11:35 INFO - Running post-run listener: _resource_record_post_run 10:11:35 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 37536768; Write bytes: 494594048; Read time: 240; Write time: 1546 10:11:35 INFO - TinderboxPrint: CPU usage
53.3% 10:11:35 INFO - TinderboxPrint: I/O read bytes / time
37,536,768 / 240 10:11:35 INFO - TinderboxPrint: I/O write bytes / time
494,594,048 / 1,546 10:11:35 INFO - TinderboxPrint: CPU idle
2,232.8 (46.7%) 10:11:35 INFO - TinderboxPrint: CPU system
955.1 (20.0%) 10:11:35 INFO - TinderboxPrint: CPU user
1,597.8 (33.4%) 10:11:35 INFO - TinderboxPrint: Swap in / out
233,013,248 / 0 10:11:35 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188170752; Write bytes: 187770880; Read time: 17832; Write time: 407 10:11:35 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35746816; Write bytes: 295825408; Read time: 225; Write time: 1097 10:11:36 INFO - Running post-run listener: _upload_blobber_files 10:11:36 INFO - Blob upload gear active. 10:11:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:36 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 10:11:36 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'] 10:11:36 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 10:11:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:37 INFO - (blobuploader) - INFO - Done attempting. 10:11:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:39 INFO - (blobuploader) - INFO - Done attempting. 10:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:42 INFO - (blobuploader) - INFO - Done attempting. 10:11:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:42 INFO - Return code: 0 10:11:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbb3deef458dc0dd0e47e7e9466300d612a4002647cb0696b59a873e9283ed7cc97f9adaf2c79ff7fb92fb67a86923903389c9764fcbb8be6afb85c53e8ae001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa18eea583b3c3d965bda9615260144f0447641cbd53bc01fdcafd0622b61122ed527b80a05e04fbfc0938c6e364f03b1d00bdb4ba2959e5173fb02894e5ec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59f86e516fd223f6e274cfdbc66748e1cf361dd23b22d9d61d2af7767249f7672581998b4669e46d74a299dcff0e6c733b0ac11ff3ce997e9a51f194142d8331"} 10:11:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:42 INFO - Contents: 10:11:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbb3deef458dc0dd0e47e7e9466300d612a4002647cb0696b59a873e9283ed7cc97f9adaf2c79ff7fb92fb67a86923903389c9764fcbb8be6afb85c53e8ae001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa18eea583b3c3d965bda9615260144f0447641cbd53bc01fdcafd0622b61122ed527b80a05e04fbfc0938c6e364f03b1d00bdb4ba2959e5173fb02894e5ec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59f86e516fd223f6e274cfdbc66748e1cf361dd23b22d9d61d2af7767249f7672581998b4669e46d74a299dcff0e6c733b0ac11ff3ce997e9a51f194142d8331"} 10:11:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:42 INFO - Copying logs to upload dir... 10:11:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.810795 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-14 10:11:42.302458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:42.306362) ========= 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.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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/dbb3deef458dc0dd0e47e7e9466300d612a4002647cb0696b59a873e9283ed7cc97f9adaf2c79ff7fb92fb67a86923903389c9764fcbb8be6afb85c53e8ae001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa18eea583b3c3d965bda9615260144f0447641cbd53bc01fdcafd0622b61122ed527b80a05e04fbfc0938c6e364f03b1d00bdb4ba2959e5173fb02894e5ec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59f86e516fd223f6e274cfdbc66748e1cf361dd23b22d9d61d2af7767249f7672581998b4669e46d74a299dcff0e6c733b0ac11ff3ce997e9a51f194142d8331"} build_url:https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010769 build_url: 'https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/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/dbb3deef458dc0dd0e47e7e9466300d612a4002647cb0696b59a873e9283ed7cc97f9adaf2c79ff7fb92fb67a86923903389c9764fcbb8be6afb85c53e8ae001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa18eea583b3c3d965bda9615260144f0447641cbd53bc01fdcafd0622b61122ed527b80a05e04fbfc0938c6e364f03b1d00bdb4ba2959e5173fb02894e5ec70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59f86e516fd223f6e274cfdbc66748e1cf361dd23b22d9d61d2af7767249f7672581998b4669e46d74a299dcff0e6c733b0ac11ff3ce997e9a51f194142d8331"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:42.338762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:42.339099) ========= 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.pWipwwk885/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.DaheOo4QOZ/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.005074 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:42.387769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:42.388091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:42.388412) ========= ========= Total master_lag: 0.20 =========