builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1479145854.8 results: success (0) buildid: 20161114042748 builduid: 5d9b629788f647fca5ea5eddaffd68fd revision: f455459b2ae5e42e5fb29d90533095add226ca95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.803140) ========= 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:54.803570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.803848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.829934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.830396) ========= 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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:54-- 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% 27.3M=0s 2016-11-14 09:50:54 (27.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.943578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.944012) ========= 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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.024358 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:54.992940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:50:54.993297) ========= 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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:55,070 truncating revision to first 12 chars 2016-11-14 09:50:55,070 Setting DEBUG logging. 2016-11-14 09:50:55,070 attempt 1/10 2016-11-14 09:50:55,070 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:56,116 unpacking tar archive at: mozilla-beta-f455459b2ae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:50:56.326922) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:56.327632) ========= script_repo_revision: f455459b2ae5e42e5fb29d90533095add226ca95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:56.328510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:56.328978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:50:56.615588) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-14 09:50:56.616122) ========= /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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:56 INFO - MultiFileLogger online at 20161114 09:50:56 in /builds/slave/test 09:50:56 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:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:56 INFO - {'append_to_log': False, 09:50:56 INFO - 'base_work_dir': '/builds/slave/test', 09:50:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:50:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:56 INFO - 'branch': 'Mozilla-Beta', 09:50:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:56 INFO - 'config_files': ('talos/mac_config.py',), 09:50:56 INFO - 'default_actions': ('clobber', 09:50:56 INFO - 'read-buildbot-config', 09:50:56 INFO - 'download-and-extract', 09:50:56 INFO - 'populate-webroot', 09:50:56 INFO - 'create-virtualenv', 09:50:56 INFO - 'install', 09:50:56 INFO - 'run-tests'), 09:50:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:56 INFO - 'download_minidump_stackwalk': True, 09:50:56 INFO - 'download_symbols': 'ondemand', 09:50:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:56 INFO - 'installer_path': 'installer.exe', 09:50:56 INFO - 'log_level': 'info', 09:50:56 INFO - 'log_name': 'talos', 09:50:56 INFO - 'log_to_console': True, 09:50:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:56 INFO - 'opt_config_files': (), 09:50:56 INFO - 'pip_index': False, 09:50:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:56 INFO - 'cmd': ('bash', 09:50:56 INFO - '-c', 09:50:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:56 INFO - 'enabled': True, 09:50:56 INFO - 'halt_on_failure': False, 09:50:56 INFO - 'name': 'check_screen_resolution'},), 09:50:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:56 INFO - 'cmd': ('bash', 09:50:56 INFO - '-c', 09:50:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:56 INFO - 'enabled': True, 09:50:56 INFO - 'halt_on_failure': False, 09:50:56 INFO - 'name': 'check_screen_resolution'},), 09:50:56 INFO - 'run_cmd_checks_enabled': True, 09:50:56 INFO - 'sps_profile': False, 09:50:56 INFO - 'sps_profile_interval': 0, 09:50:56 INFO - 'suite': 'dromaeojs', 09:50:56 INFO - 'system_bits': '32', 09:50:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:56 INFO - 'title': 't-yosemite-r7-0274', 09:50:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:56 INFO - 'use_talos_json': True, 09:50:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:56 INFO - 'work_dir': 'build'} 09:50:56 INFO - [mozharness: 2016-11-14 17:50:56.804869Z] Running clobber step. 09:50:56 INFO - Running pre-action listener: _resource_record_pre_action 09:50:56 INFO - Running main action method: clobber 09:50:56 INFO - rmtree: /builds/slave/test/build 09:50:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:59 INFO - Running post-action listener: _resource_record_post_action 09:50:59 INFO - [mozharness: 2016-11-14 17:50:59.222554Z] Finished clobber step (success) 09:50:59 INFO - [mozharness: 2016-11-14 17:50:59.222762Z] Running read-buildbot-config step. 09:50:59 INFO - Running pre-action listener: _resource_record_pre_action 09:50:59 INFO - Running main action method: read_buildbot_config 09:50:59 INFO - Using buildbot properties: 09:50:59 INFO - { 09:50:59 INFO - "project": "", 09:50:59 INFO - "product": "firefox", 09:50:59 INFO - "script_repo_revision": "production", 09:50:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:50:59 INFO - "repository": "", 09:50:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:50:59 INFO - "buildid": "20161114042748", 09:50:59 INFO - "pgo_build": "False", 09:50:59 INFO - "basedir": "/builds/slave/test", 09:50:59 INFO - "buildnumber": 21, 09:50:59 INFO - "slavename": "t-yosemite-r7-0274", 09:50:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:50:59 INFO - "platform": "yosemite_r7", 09:50:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:50:59 INFO - "branch": "mozilla-beta", 09:50:59 INFO - "repo_path": "releases/mozilla-beta", 09:50:59 INFO - "revision": "f455459b2ae5e42e5fb29d90533095add226ca95", 09:50:59 INFO - "stage_platform": "macosx64", 09:50:59 INFO - "builduid": "5d9b629788f647fca5ea5eddaffd68fd", 09:50:59 INFO - "slavebuilddir": "test" 09:50:59 INFO - } 09:50:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:50:59 INFO - Running post-action listener: _resource_record_post_action 09:50:59 INFO - [mozharness: 2016-11-14 17:50:59.228388Z] Finished read-buildbot-config step (success) 09:50:59 INFO - [mozharness: 2016-11-14 17:50:59.228585Z] Running download-and-extract step. 09:50:59 INFO - Running pre-action listener: _resource_record_pre_action 09:50:59 INFO - Running main action method: download_and_extract 09:50:59 INFO - mkdir: /builds/slave/test/build/tests 09:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:59 INFO - trying https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:50:59 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:59 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:51:00 INFO - Downloaded 1165 bytes. 09:51:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:51:00 INFO - Using the following test package requirements: 09:51:00 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:51:00 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:51:00 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:51:00 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:51:00 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:51:00 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:51:00 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:51:00 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:51:00 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:51:00 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:51:00 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:51:00 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:51:00 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:51:00 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:51:00 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:51:01 INFO - Expected file size: 16231342 09:51:07 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:51:07 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:51:07 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:51:07 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:51:08 INFO - Expected file size: 16231342 09:51:14 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:14 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:14 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:15 INFO - Expected file size: 14414089 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 - trying https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:51:16 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:16 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:18 INFO - Downloaded 86010447 bytes. 09:51:18 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:18 INFO - mkdir: /builds/slave/test/properties 09:51:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:18 INFO - Contents: 09:51:18 INFO - build_url:https://queue.taskcluster.net/v1/task/QAv_ZBoqSVuriNAFK2FFbw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:51:19 INFO - Running post-action listener: _resource_record_post_action 09:51:19 INFO - Running post-action listener: set_extra_try_arguments 09:51:19 INFO - [mozharness: 2016-11-14 17:51:19.561373Z] Finished download-and-extract step (success) 09:51:19 INFO - [mozharness: 2016-11-14 17:51:19.561491Z] Running populate-webroot step. 09:51:19 INFO - Running pre-action listener: _resource_record_pre_action 09:51:19 INFO - Running main action method: populate_webroot 09:51:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:19 INFO - '--tppagecycles', 09:51:19 INFO - '7'], 09:51:19 INFO - 'tests': ['tsvgm']}}, 09:51:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['damp', 'tps']}, 09:51:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'tests': ['damp', 'tps']}, 09:51:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['dromaeo_dom']}, 09:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['basic_compositor_video']}, 09:51:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['a11yr', 09:51:19 INFO - 'ts_paint', 09:51:19 INFO - 'tpaint', 09:51:19 INFO - 'sessionrestore', 09:51:19 INFO - 'sessionrestore_no_auto_restore', 09:51:19 INFO - 'tabpaint']}, 09:51:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['tsvgx', 09:51:19 INFO - 'tsvgr_opacity', 09:51:19 INFO - 'tart', 09:51:19 INFO - 'tscrollx', 09:51:19 INFO - 'cart']}, 09:51:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:19 INFO - 'tsvgr_opacity', 09:51:19 INFO - 'tart', 09:51:19 INFO - 'tscrollx', 09:51:19 INFO - 'cart']}, 09:51:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'talos_options': ['--disable-e10s'], 09:51:19 INFO - 'tests': ['tp5o']}, 09:51:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'tests': ['tp5o']}, 09:51:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'talos_options': ['--disable-e10s', 09:51:19 INFO - '--xperf_path', 09:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:19 INFO - 'tests': ['tp5n']}, 09:51:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:19 INFO - 'talos_options': ['--xperf_path', 09:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:19 INFO - 'tests': ['tp5n']}}, 09:51:19 INFO - 'talos.zip': {'path': '', 09:51:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:19 INFO - Running post-action listener: _resource_record_post_action 09:51:19 INFO - [mozharness: 2016-11-14 17:51:19.579727Z] Finished populate-webroot step (success) 09:51:19 INFO - [mozharness: 2016-11-14 17:51:19.579834Z] Running create-virtualenv step. 09:51:19 INFO - Running pre-action listener: _resource_record_pre_action 09:51:19 INFO - Running main action method: create_virtualenv 09:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:19 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:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:19 INFO - Using real prefix '/tools/python27' 09:51:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:23 INFO - Installing pip.................done. 09:51:23 INFO - Return code: 0 09:51:23 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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', 'pip>=1.5'] 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 pip>=1.5 09:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 09:51:23 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:23 INFO - Cleaning up... 09:51:23 INFO - Return code: 0 09:51:23 INFO - Installing psutil>=3.1.1 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', '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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 09:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 09:51:23 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 psutil>=3.1.1 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:27 INFO - Installing collected packages: psutil 09:51:27 INFO - Running setup.py install for psutil 09:51:27 INFO - building 'psutil._psutil_osx' extension 09:51:27 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:27 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:27 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:28 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:28 INFO - building 'psutil._psutil_posix' extension 09:51:28 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:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:28 INFO - ^ 09:51:28 INFO - 1 warning generated. 09:51:28 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:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:28 INFO - Successfully installed psutil 09:51:28 INFO - Cleaning up... 09:51:28 INFO - Return code: 0 09:51:28 INFO - Installing mozsystemmonitor==0.3 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', '--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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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', '--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:28 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:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 09:51:28 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 - Downloading/unpacking mozsystemmonitor==0.3 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:31 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:31 INFO - Installing collected packages: mozsystemmonitor 09:51:31 INFO - Running setup.py install for mozsystemmonitor 09:51:31 INFO - Successfully installed mozsystemmonitor 09:51:31 INFO - Cleaning up... 09:51:31 INFO - Return code: 0 09:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:31 INFO - 'HOME': '/Users/cltbld', 09:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:31 INFO - 'LOGNAME': 'cltbld', 09:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:31 INFO - 'MOZ_NO_REMOTE': '1', 09:51:31 INFO - 'NO_EM_RESTART': '1', 09:51:31 INFO - 'PAGER': '/bin/cat', 09:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:31 INFO - 'PWD': '/builds/slave/test', 09:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:31 INFO - 'SHELL': '/bin/bash', 09:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:31 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:31 INFO - 'USER': 'cltbld', 09:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:31 INFO - 'XPC_FLAGS': '0x0', 09:51:31 INFO - 'XPC_SERVICE_NAME': '0', 09:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:34 INFO - warning: no files found matching '*.txt' 09:51:34 INFO - no previously-included directories found matching 'build' 09:51:34 INFO - no previously-included directories found matching 'dist' 09:51:34 INFO - no previously-included directories found matching '.git*' 09:51:34 INFO - Installing collected packages: jsonschema, functools32 09:51:34 INFO - Running setup.py install for functools32 09:51:34 INFO - warning: no files found matching '*.txt' 09:51:34 INFO - no previously-included directories found matching 'build' 09:51:34 INFO - no previously-included directories found matching 'dist' 09:51:34 INFO - no previously-included directories found matching '.git*' 09:51:34 INFO - Successfully installed jsonschema functools32 09:51:34 INFO - Cleaning up... 09:51:35 INFO - Return code: 0 09:51:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:35 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:35 INFO - 'HOME': '/Users/cltbld', 09:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:35 INFO - 'LOGNAME': 'cltbld', 09:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:35 INFO - 'MOZ_NO_REMOTE': '1', 09:51:35 INFO - 'NO_EM_RESTART': '1', 09:51:35 INFO - 'PAGER': '/bin/cat', 09:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:35 INFO - 'PWD': '/builds/slave/test', 09:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:35 INFO - 'SHELL': '/bin/bash', 09:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:35 INFO - 'USER': 'cltbld', 09:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:35 INFO - 'XPC_FLAGS': '0x0', 09:51:35 INFO - 'XPC_SERVICE_NAME': '0', 09:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:35 INFO - Cleaning up... 09:51:35 INFO - Return code: 0 09:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:35 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:35 INFO - 'HOME': '/Users/cltbld', 09:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:35 INFO - 'LOGNAME': 'cltbld', 09:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:35 INFO - 'MOZ_NO_REMOTE': '1', 09:51:35 INFO - 'NO_EM_RESTART': '1', 09:51:35 INFO - 'PAGER': '/bin/cat', 09:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:35 INFO - 'PWD': '/builds/slave/test', 09:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:35 INFO - 'SHELL': '/bin/bash', 09:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:35 INFO - 'USER': 'cltbld', 09:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:35 INFO - 'XPC_FLAGS': '0x0', 09:51:35 INFO - 'XPC_SERVICE_NAME': '0', 09:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 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:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:39 INFO - Downloading docopt-0.6.1.tar.gz 09:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:39 INFO - Running setup.py install for blobuploader 09:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:39 INFO - Running setup.py install for requests 09:51:40 INFO - Running setup.py install for docopt 09:51:40 INFO - Successfully installed blobuploader requests docopt 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:40 INFO - 'HOME': '/Users/cltbld', 09:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PAGER': '/bin/cat', 09:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:40 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - 'XPC_FLAGS': '0x0', 09:51:40 INFO - 'XPC_SERVICE_NAME': '0', 09:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:40 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0u9mQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:40 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dPlWg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:40 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-nYRKim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:40 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-BdKNLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Oy250Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-POmCFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-xJ522z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-GR3wnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-HAeVW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-xcaiXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iB43P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-2P2Kai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-QNulLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-KDpqLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-nJlPP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lV7zmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-alX9PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:42 INFO - Running setup.py install for manifestparser 09:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:42 INFO - Running setup.py install for mozcrash 09:51:42 INFO - Running setup.py install for mozdebug 09:51:42 INFO - Running setup.py install for mozdevice 09:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Running setup.py install for mozfile 09:51:43 INFO - Running setup.py install for mozhttpd 09:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Running setup.py install for mozinfo 09:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Running setup.py install for mozInstall 09:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Running setup.py install for mozleak 09:51:43 INFO - Running setup.py install for mozlog 09:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:43 INFO - Running setup.py install for moznetwork 09:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Running setup.py install for mozprocess 09:51:44 INFO - Running setup.py install for mozprofile 09:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Running setup.py install for mozrunner 09:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Running setup.py install for mozscreenshot 09:51:44 INFO - Running setup.py install for moztest 09:51:44 INFO - Running setup.py install for mozversion 09:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:44 INFO - Cleaning up... 09:51:45 INFO - Return code: 0 09:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:45 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:45 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:45 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:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:45 INFO - 'HOME': '/Users/cltbld', 09:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:45 INFO - 'LOGNAME': 'cltbld', 09:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:45 INFO - 'MOZ_NO_REMOTE': '1', 09:51:45 INFO - 'NO_EM_RESTART': '1', 09:51:45 INFO - 'PAGER': '/bin/cat', 09:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:45 INFO - 'PWD': '/builds/slave/test', 09:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:45 INFO - 'SHELL': '/bin/bash', 09:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:45 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:45 INFO - 'USER': 'cltbld', 09:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:45 INFO - 'XPC_FLAGS': '0x0', 09:51:45 INFO - 'XPC_SERVICE_NAME': '0', 09:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-kouFFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F9XjEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ne1k5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yJKqdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sCJoyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-TKq9y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:45 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-_7uqSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zQXxLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-IcBz9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fVG071-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sCjhTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yNSJOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-SRDJJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-xyTUyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-oqnv_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rqg8C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:46 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AiJLMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:49 INFO - Downloading blessings-1.6.tar.gz 09:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:49 INFO - Installing collected packages: blessings 09:51:49 INFO - Running setup.py install for blessings 09:51:49 INFO - Successfully installed blessings 09:51:49 INFO - Cleaning up... 09:51:50 INFO - Return code: 0 09:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:50 INFO - Reading from file tmpfile_stdout 09:51:50 INFO - Current package versions: 09:51:50 INFO - blessings == 1.6 09:51:50 INFO - blobuploader == 1.2.4 09:51:50 INFO - docopt == 0.6.1 09:51:50 INFO - functools32 == 3.2.3-2 09:51:50 INFO - jsonschema == 2.5.1 09:51:50 INFO - manifestparser == 1.1 09:51:50 INFO - mozInstall == 1.12 09:51:50 INFO - mozcrash == 0.17 09:51:50 INFO - mozdebug == 0.1 09:51:50 INFO - mozdevice == 0.48 09:51:50 INFO - mozfile == 1.2 09:51:50 INFO - mozhttpd == 0.7 09:51:50 INFO - mozinfo == 0.9 09:51:50 INFO - mozleak == 0.1 09:51:50 INFO - mozlog == 3.4 09:51:50 INFO - moznetwork == 0.27 09:51:50 INFO - mozprocess == 0.23 09:51:50 INFO - mozprofile == 0.28 09:51:50 INFO - mozrunner == 6.12 09:51:50 INFO - mozscreenshot == 0.1 09:51:50 INFO - mozsystemmonitor == 0.3 09:51:50 INFO - moztest == 0.7 09:51:50 INFO - mozversion == 1.4 09:51:50 INFO - psutil == 3.1.1 09:51:50 INFO - requests == 1.2.3 09:51:50 INFO - wsgiref == 0.1.2 09:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:50 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:50 INFO - 'HOME': '/Users/cltbld', 09:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:50 INFO - 'LOGNAME': 'cltbld', 09:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:50 INFO - 'MOZ_NO_REMOTE': '1', 09:51:50 INFO - 'NO_EM_RESTART': '1', 09:51:50 INFO - 'PAGER': '/bin/cat', 09:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:50 INFO - 'PWD': '/builds/slave/test', 09:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:50 INFO - 'SHELL': '/bin/bash', 09:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:50 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:50 INFO - 'USER': 'cltbld', 09:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:50 INFO - 'XPC_FLAGS': '0x0', 09:51:50 INFO - 'XPC_SERVICE_NAME': '0', 09:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Cleaning up... 09:51:50 INFO - Return code: 0 09:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:50 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 0x10893f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4a8cd53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, '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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:50 INFO - 'HOME': '/Users/cltbld', 09:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:50 INFO - 'LOGNAME': 'cltbld', 09:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:50 INFO - 'MOZ_NO_REMOTE': '1', 09:51:50 INFO - 'NO_EM_RESTART': '1', 09:51:50 INFO - 'PAGER': '/bin/cat', 09:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:50 INFO - 'PWD': '/builds/slave/test', 09:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:50 INFO - 'SHELL': '/bin/bash', 09:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:51:50 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:50 INFO - 'USER': 'cltbld', 09:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:50 INFO - 'XPC_FLAGS': '0x0', 09:51:50 INFO - 'XPC_SERVICE_NAME': '0', 09:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:50 INFO - Cleaning up... 09:51:50 INFO - Return code: 0 09:51:50 INFO - Running post-action listener: _resource_record_post_action 09:51:50 INFO - Running post-action listener: _start_resource_monitoring 09:51:50 INFO - Starting resource monitoring. 09:51:50 INFO - [mozharness: 2016-11-14 17:51:50.828965Z] Finished create-virtualenv step (success) 09:51:50 INFO - [mozharness: 2016-11-14 17:51:50.829899Z] Running install step. 09:51:50 INFO - Running pre-action listener: _resource_record_pre_action 09:51:50 INFO - Running main action method: install 09:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:51 INFO - Reading from file tmpfile_stdout 09:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:51 INFO - Reading from file tmpfile_stdout 09:51:51 INFO - Output received: 09:51:51 INFO - Usage: mozinstall [options] installer 09:51:51 INFO - Options: 09:51:51 INFO - -h, --help show this help message and exit 09:51:51 INFO - -d DEST, --destination=DEST 09:51:51 INFO - Directory to install application into. [default: 09:51:51 INFO - "/builds/slave/test"] 09:51:51 INFO - --app=APP Application being installed. [default: firefox] 09:51:51 INFO - mkdir: /builds/slave/test/build/application 09:51:51 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:51 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:12 INFO - Reading from file tmpfile_stdout 09:52:12 INFO - Output received: 09:52:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:52:12 INFO - Running post-action listener: _resource_record_post_action 09:52:12 INFO - [mozharness: 2016-11-14 17:52:12.785092Z] Finished install step (success) 09:52:12 INFO - [mozharness: 2016-11-14 17:52:12.785233Z] Running run-tests step. 09:52:12 INFO - Running pre-action listener: _resource_record_pre_action 09:52:12 INFO - Running main action method: run_tests 09:52:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:12 INFO - 2016-11-14 09:52:12.799 screenresolution[1636:7439] starting screenresolution argv=screenresolution get 09:52:12 INFO - 2016-11-14 09:52:12.802 screenresolution[1636:7439] Display 0: 1600x1200x32@60 09:52:12 INFO - 2016-11-14 09:52:12.807 screenresolution[1637:7442] starting screenresolution argv=screenresolution list 09:52:12 INFO - Available Modes on Display 0 09:52:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:13 INFO - Intel Iris: 09:52:13 INFO - Chipset Model: Intel Iris 09:52:13 INFO - Type: GPU 09:52:13 INFO - Bus: Built-In 09:52:13 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:13 INFO - Vendor: Intel (0x8086) 09:52:13 INFO - Device ID: 0x0a2e 09:52:13 INFO - Revision ID: 0x0009 09:52:13 INFO - Displays: 09:52:13 INFO - Display: 09:52:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:13 INFO - Display Serial Number: 1600x1200 60 09:52:13 INFO - Main Display: Yes 09:52:13 INFO - Mirror: Off 09:52:13 INFO - Online: Yes 09:52:13 INFO - Rotation: Supported 09:52:13 INFO - Return code: 0 09:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:13 INFO - Python 2.7.3 09:52:13 INFO - Return code: 0 09:52:13 INFO - grabbing minidump binary from tooltool 09:52:13 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:13 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 0x108753d30>, '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 0x1085b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:13 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:13 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:13 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:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:13 INFO - Return code: 0 09:52:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:13 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-0274', '--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:13 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-0274 --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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUZlVLmzqV/Render', 09:52:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:13 INFO - 'HOME': '/Users/cltbld', 09:52:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:13 INFO - 'LOGNAME': 'cltbld', 09:52:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:13 INFO - 'MOZ_NO_REMOTE': '1', 09:52:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:13 INFO - 'NO_EM_RESTART': '1', 09:52:13 INFO - 'PAGER': '/bin/cat', 09:52:13 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:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:13 INFO - 'PWD': '/builds/slave/test', 09:52:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:13 INFO - 'SHELL': '/bin/bash', 09:52:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J2JPKLDYLS/Listeners', 09:52:13 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:52:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:13 INFO - 'USER': 'cltbld', 09:52:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:13 INFO - 'XPC_FLAGS': '0x0', 09:52:13 INFO - 'XPC_SERVICE_NAME': '0', 09:52:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:13 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-0274', '--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:13 INFO - mozversion application_buildid: 20161114042748 09:52:13 INFO - mozversion application_changeset: f455459b2ae5e42e5fb29d90533095add226ca95 09:52:13 INFO - mozversion application_display_name: Firefox 09:52:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:13 INFO - mozversion application_name: Firefox 09:52:13 INFO - mozversion application_remotingname: firefox 09:52:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:13 INFO - mozversion application_vendor: Mozilla 09:52:13 INFO - mozversion application_version: 51.0 09:52:13 INFO - mozversion platform_buildid: 20161114042748 09:52:13 INFO - mozversion platform_changeset: f455459b2ae5e42e5fb29d90533095add226ca95 09:52:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:13 INFO - mozversion platform_version: 51.0 09:52:13 INFO - using testdate: 1479145933 09:52:13 INFO - actual date: 1479145933 09:52:13 INFO - starting webserver on 'localhost:49272' 09:52:13 INFO - SUITE-START | Running 2 tests 09:52:13 INFO - TEST-START | dromaeo_css 09:52:13 INFO - operating with platform_type : mac_ 09:52:13 INFO - Initialising browser for dromaeo_css test... 09:52:13 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFyKxtK/profile http://localhost:49272/getInfo.html) 09:52:15 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 09:52:15 INFO - PROCESS | 1647 | colorDepth:24 09:52:15 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 09:52:15 INFO - PROCESS | 1647 | __metrics 09:52:15 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:15 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:16 INFO - TEST-INFO | 1647: exit 0 09:52:16 INFO - Browser initialized. 09:52:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:16 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFyKxtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:28 INFO - PROCESS | 1650 | RSS: Main: 168218624 09:52:28 INFO - PROCESS | 1650 | 09:53:19 INFO - PROCESS | 1650 | 1479145999082 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:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:55:32 INFO - PROCESS | 1650 | RSS: Main: 302788608 09:55:32 INFO - PROCESS | 1650 | 09:58:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:58:35 INFO - PROCESS | 1650 | RSS: Main: 303144960 09:58:35 INFO - PROCESS | 1650 | 10:01:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:01:38 INFO - PROCESS | 1650 | RSS: Main: 301572096 10:01:38 INFO - PROCESS | 1650 | 10:04:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:04:40 INFO - PROCESS | 1650 | RSS: Main: 265879552 10:04:40 INFO - PROCESS | 1650 | 10:07:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:07:44 INFO - PROCESS | 1650 | RSS: Main: 259489792 10:07:44 INFO - PROCESS | 1650 | 10:10:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:10:47 INFO - PROCESS | 1650 | RSS: Main: 312008704 10:10:47 INFO - PROCESS | 1650 | 10:10:47 INFO - PROCESS | 1650 | __start_tp_report 10:10:47 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:10:47 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:10:47 INFO - PROCESS | 1650 | |i|pagename|runs| 10:10:47 INFO - PROCESS | 1650 | |0;dojo.html;3465.7573969822115;3471.0628130404793;3510.5085288059677;3519.436890097585;3567.714582833372;4429.180601588704;5736.426357364257;5819;5866.472017518422;5888.617239879405;5794.507466865311;5830.271216097988;5897.174395584621;5937.109433584965;5961.225040744708;5258.710770907599;5348.91976620349;5377.435369286227;5423.132298832187;5425.647332923348;5305.575553955674;5315.415304316522;5333.093374126388;5458.590605704569;5470.452954704538;5413.215083812865;5415.864603384927;5416.025115479212;5422.864428389302;5428.375736790261;5419.729013549307;5421.512063914267;5421.810236641699;5421.83734487966;5423.918641220384;5265.657732247391;5379.65032272905;5379.67721936685;5387.946120538783;5413.188021796723;5986.730597123096;5986.820395388146;5995.580309378345;6001.699915004276;6006.789762358297;6180.907286390708;6225.62646241227;6242.5942313749465;6247.468965137969;6259.311475737665;6198.3801619838105;6211.25464944205;6230.065490176465;6233.065040243954;6248.125262463259;5909.113632955091;5917.792877249276;5944.7433517323125;5994.1608174855555;6014.3684913083935;6184.443400093923;6232.220972378453;6241.157443745036;6281.528885333618;6470.2559205691;6117.096718007379;6279.277883043417;6282.874342513124;6285.842853928597;6290.4653104485715;6255.437010669061;6265.686715664198;6275.497960163176;6277.874442511215;6279.497640188774;6137.506931296464;6181.011038233951;6206.782762603378;6272;6324.494040476751;6253;6285.717142728497;6290.8427289317215;6292.087647291117;6297.905531417033;5074.264231686385;5109.718965456936;5116.56509196715;5125.56432703217;5147.433782283946;4212.304969679968;4475.5748203920575;4484.2376795944765;4531;4576.565226303496;5915.526757859361;5927.4665280125;5936.317323507766;5961.612495187799;6031.155638210654;6238.344973777688;6252.968735156386;6256.781012664626;6266.310705822356;6274.592151510137;6016.368281330398;6017.398260173947;6039.335673075958;6059.545534084961;6074.0281554951;5414.648047876875;5475.698836563947;5538.47384498472;5544.972275138599;5588.91616625751;6358.33237510064;6403.135576697086;6411.96794016027;6416.454601358937;6483.384078512534;6248.656323902229;6252.3122456530655;6277.780277690259;6278.246610406781;6285.59143655661;6428.678566071584;6464.0627109069865;6505.349465053457;6517.283098859027;6533.901991470227;6151.876962460815;6187.721552530057;6213.65824879636;6227.346128656426;6266.624002559861;6246.3753624637175;6250.874982500233;6264.436200741955;6269.310375858743;6283.151774510383;6187.443130118311;6210.254769427697;6254.312025677081;6254.718537665725;6274.937250627435;4929.334539837219;5310.097283461743;5916.290045194604;6079.726412311545;6256.405641464054;5987.910181347371;6032.969835150796;6044.788432404845;6100.694965251809;6109.35526230379;6195.349488303663;6203.069539569101;6204.751809927733;6211.254649442096;6213.875722485615;5977.790777322773;6005.429484198994;6030.668313242813;6070.6357618543025;6095.207623008981 10:10:47 INFO - PROCESS | 1650 | |1;ext.html;472.40005193404374;519.1019536202369;546.4426285189107;549.2063967566864;576.236486655182;33604.83197584012;42808.14383712328;45025;45379.546204537946;47469.28796068053;46817.53182468174;47214.055718885604;47270.81822954428;47347.52652473474;47465.28802067963;9321.533923303841;10120.240981926348;10321.277510574262;10322.948385258102;10327.483625818679;9372.8594071089;9542.52287385628;9551.044895510428;9561.760955976086;12312.507499700001;10220.897791022106;12570.560030398938;12578.433970471351;12593;12602.81095783564;10500.632477863239;12508.749825003495;12575.245485270822;12575.685607859785;12580.056495762763;12348.876511234863;12441.564545240873;12446.06654500916;12464.314462704548;12480.50077996879;43066.98531102824;43460.3480947786;43522;43537.56462435367;43539.564604353865;3497.702695270905;3552.4138517144897;3587.2646107548153;3600.567931848169;3637.4543818427182;33043.83478082618;33351.24698951057;33601;33615.99152025443;33824.661753382396;3309.9503507447407;3353.5808023997;3465.9480107798404;3497.3879571075213;3506.929861402783;523809;524087;525066;525467;525878;36528.81735591358;66611.66694166498;67025.32974670191;67280.32719672838;67346.32653673498;37878.8106059468;37971;38043.858684239516;38099.4285085724;38106.61893381031;16287;16466.259018343964;16479.258433370287;16492.917535412245;16505.917470412573;13911.026228163932;13999.230042347768;13999.95000374976;14035;14047.578572642837;7647.885281720779;7840.215978402114;7851.9214807851195;7998.960005199937;8222.588870556448;3288.7369010479106;3371.0561042908025;3383.678550537695;3385;3416.2825806580895;954.6467806911487;970.5729479029204;988.9357191782511;1005.2711783956573;1101.8677758669012;32228.19429514281;32716.182095447803;32771.50842737361;32804.34391312208;33308.167295817315;925.1035377476147;1099.69758316462;1142.2575326037975;1154.261272785418;1166.6383421139474;13589;16468.6706265874;17033.48899533016;17034.659306813795;17134.485965421056;762125;770972;771281;774310;779490.1025494837;56077;57059;64279.35720642827;65111.02333465002;65208.34791652023;1342.684469149749;1410.9223992680502;1432.3411230833724;1439.863212994764;1452.9636759081106;28478.857605711837;32255.838720806245;34265;34362;34429.79495717638;56913.146302804664;57458.71270643787;57525.84948301094;57575;57576.424235757106;647880;653239;666085;887135.2572948633;910472;27775.30561735973;28223.71776282211;28294.43411131807;28469.43061138807;28782.85608571944;49200.26199606937;49454.971247686895;49535.504644953086;50380.74809625928;50991.490085098674;40584.39123413092;41065.97335066647;42371.78814106033;43283.35074973815;43492;41580.376294355;41850.58149418467;41997.37003944882;42823;42918.78540607277;40699.59300406958;41459.585404145575;41756.3736543946;41803.37294940639;41869.069165158144;30244.24389390283;34331.31337373288;36121.63878361183;36741.63258367382;36911.26177476489;22355.32934011982;26844.328891777863;27287.863560682068;27396.7680437583;27616.585751213344 10:10:48 INFO - PROCESS | 1650 | |2;jquery.html;373.06733167082297;382.6384067056631;384.91916697493537;387.0748910104848;411.28641806465777;19945.501362465944;21710.457238569004;21719.34841954742;22041.889790551046;22608.43478913028;20592.691109633368;21230.36308910731;21358.786412135873;21486.89256553715;22208;5187.299714538527;5485.396606373296;5545.306836645419;5550.250716153308;5557.638753481031;4144.109016561439;4156.667466602679;4164.625183733463;4351;5506.889862202754;4336.21948049351;4410.757408342556;4511.954880451202;6971.163460384735;7034.6482675866255;5445.918311225335;5861.765529378819;7026.929730702705;7053.929460705404;7214.603196824199;6035.426634469718;6134.8159555213415;6140.600860944024;6140.907886381708;6149.631022138686;13499.460021599125;13518.391672374766;13648;13705;13867.098638588459;2171.86968781872;2204.9779502204933;2214.9335519934266;2225.710657614516;2240.148743477468;10146.695599132037;10323.380597164194;10330.9483452583;10668.253222274443;10755.677329680122;1905.6474552207885;1958.3145898935402;1973.4770285874256;2013.416109328293;2024.1498570600384;79503.60248198723;79838.60080699617;81644.59177704074;100685;117975.41012294883;11603.709907252218;11627.941860290644;11699.23954942926;11754.353510557;11912.285262884254;14930;15306.005109667836;15331.463398780988;15334.386624534895;15352.232388380537;9006.909930900738;9069.909300907038;9072.319576031692;9081.54592270384;9189.494577798152;7347.8163045924275;9047.592858321392;9074.637014519478;9095.36332456735;9236.491992940319;4616.815327386867;4637.466691330473;4649.139909116824;4657.930131048037;4718.4809670936165;1745.6246906915073;1825.6084529266702;1873.2506997200956;1916.9712454313196;1974.634692581877;758.332667252814;887.3566664168555;900.9009009009004;931.0549791961165;980.8283550378655;19774.61577689548;20841.957902105136;21842.50810123082;22597;22800.947914687757;755.5126943121655;975.6926568131016;980.8970058143935;990.1979396688705;1004.9497525123714;11398.886011139948;11839.88160118405;11858.347790871412;11884.940575297069;11921.105917056255;637162.6283737196;664157;664199;674578;682622;144896.37759055896;156246;156566;157920;157941;935.5415846235296;1036.2538971940191;1053.4522048534873;1069.561479793281;1069.5668254356842;19844;19862.900685497058;20707.585848282648;20775;20914.47713807167;59457;59782;61352.38647613467;61494.385056148865;61841.69079154755;74569.88145177935;80019.59990200012;85288;87218.56390718005;88525.55737221273;7901.920980790119;8061.919380806117;8087.676492940216;8426.325893928593;8481.06708262103;10984.340939543654;12042.939785301018;13326.600201993955;13728.65678358049;13762.931185344009;11403.657890263305;11454.885451145381;11557.088237499198;11812.763744724885;12010.819837702616;5248.711320877235;10618.893811061791;11532.423378831192;11603.665578458586;11870.109741769229;10147.492625368553;10310.948445257725;11209.943950280196;11743.941280293544;11747.177697561088;8014.599270036359;8275.710350137957;8300.169983001651;8334.791630209293;8397.244248017707;9292.58183381736;11362.431878406212;11527.904849039327;11836.644900652995;11902.345371004678 10:10:48 INFO - PROCESS | 1650 | |3;mootools.html;1571.379305174456;1604.037577453528;1807.6203997160596;1909.7135429685536;1947.8507680468522;8984.550772461384;9548;9552.952235238832;9555.426674399532;9560.713178604645;8343.499390036603;8582.141785821415;8985.640574377017;9228.16946474817;9335.3465257432;2179.019441251435;2392.5095355452177;2439.39015246188;2475.504899020194;2484.391324125592;2443.7922776564014;2467.444824914398;2477.3930387055198;2480.131953816159;2480.404702871307;2452.4849781545895;2465.617829236462;2473.2703852363597;2474.5298393305306;2478.764517370847;2419.0928401849305;2446.47400808827;2447.8776061197045;2452.6566280720626;2462.6059830427225;2429.441228517451;2439.3047981325235;2447.5349683560244;2448.4368595223023;2449.816263780224;9338.906610933871;9389.201917836992;9472.242220622335;9475.573599188054;9478.668246611405;5441.564674826004;5613.550915926716;5614.214010038598;5616.719164041822;5618.747156377973;3583.2475180212186;3711.9443208351895;3721.14413684854;3782.9621703782886;3792.60177681345;1106.5850306135198;1127.9097672186206;1131.847200627913;1152.7060599547146;1155.6186458468685;12508.874911250861;12553.811692824615;12573.93713031429;12584.559540416132;12596.496140154382;4764.094821983812;4791.1854984652;4809.759512024385;4936.358273424432;4967.304577359173;10593.258471907047;10601.575936962436;10602.098821600097;10607.15142788575;10610.946945265225;5619.8595035124445;5622.212890195376;5627.324721033502;5630.690312032878;5633.098704207389;4629.86110416688;4663.547037842892;4967.329410529533;5097.64316497849;5132.769025393866;4026.315526360526;4070.755754654671;4131.091159944807;4164.208800327928;4179.895502612459;1187.2401662935729;1216.1183142221819;1298.2016060122955;1311.8163457116011;1315.83552055993;932.48247222792;950.1591091883732;955.7515046087929;961.5480724059681;989.7822479054596;4927.891224474536;5945.346011938684;6031.638101713911;6050.304215015241;6124.479419249414;429.5361010109075;443.16463466366133;446.90614970855836;449.5976101389238;451.5461960729446;4004.3993400990084;4023.376376661622;4036.979815100906;4142.5857414258935;4151.8962025949595;7509.549427034395;11338.603148889913;11436.94281528587;11469.483873225725;11474.254173478697;11248.043916267045;11315.321080735182;11403.885961140448;11412.429378531206;11442.427878606037;8607.18231767981;8826.293896488265;8830.42602230853;8839.29285657146;8866.113388661082;5890.322612899571;5892.499137573354;6035;6061.36355682647;6063.363346848694;10265.024822641837;10371.27401081917;10495.265331426726;10575.735606609896;10615.681529554126;10950.835737463785;10953.780924381626;10961.671149865517;10973.23187376876;10987.39569323695;7072.434205263464;7390.96304518474;7954.482958607672;7966.760997170094;8096.271335579826;8780.946286445667;8996.730098097067;9004.324675649483;9016.053314401894;9030.232430243503;7885.605719714106;7921.564313962787;7970.4819186752675;8127.715529956423;8154.184581541798;7785.338246248905;7897.289243968071;7912.643931023233;7915.366770658218;7958.761237162895;6157.753689852356;7292.380147687294;7388.704451822082;7396.482246242711;7406.9630251765875;5065.366829146356;5093.617978651542;5298.443663415286;5307.4427185145005;5369;4523.32150177476;5164.612654051037;5391.32608423947;5420.810271640631;5430.8099216527235 10:10:48 INFO - PROCESS | 1650 | |4;prototype.html;303.3402349888991;308.11724409566597;310.76071425002743;319.22906181571506;323.75879969422783;4264.445622069126;4411.669124815639;4709.85870423887;4972.651914365996;5545.9445405545985;4432.3573081903105;4589.724616523011;5155.381354237496;5333.733313334337;5436.565074794017;3426.8800591979284;4165.666746660268;4176.853810116647;4212.136512015045;4226.9154616907645;4179.686523510733;4192.350185721203;4196.517400498936;4211.810468528924;4221.113566151112;3467.8959631211105;3848.2495913296916;4104.569020252875;4168.874933751992;4183.581641835823;4107.67138628909;4115.650169735576;4123.793810309502;4127.752334859918;4143.834246630131;3399.0285634332276;3502.1419752160627;3558.2349794794245;3558.857645694169;3559.8220088995704;4120.25835349637;4323.762193079379;4902.656814022984;5338.078291814943;5378.300820893259;3933.606639336072;4676.228422310314;4685.835995740167;4719.787609557578;4734.147853386389;5716.314042314907;5717.798033101477;5725.2843394575675;5746;5752.597318187729;3249.4151052810485;3502.8949131526097;3746.5316835395574;3777.490038844748;3894.5131858517684;5623.915641265385;5788.479036886658;5809.128630705428;5927.347991720907;6003.759849606011;3381.053305074583;3491.9873236761564;3790.166163444093;3940.2465902673034;3942.802859856996;3631.5642122945414;3725.2735716535017;3989.4614227079555;4017.9598204017584;4018;3862.8218393390284;4529.297958816389;4564.315352697122;4664.813407463664;4720.811167553328;4716.8113275468595;5384.596155288369;5738.454846789548;5746.827595172152;5754.223179870748;1290.3935150479447;1349.5411560069624;1371.615947534692;1372.27955323454;1379.379279324308;731.9487635865438;777.9922200778033;860.8335705119598;913.3423934766957;921.0099143420849;4456.866294011184;4483.887902802456;4520.706154099973;5401.432849550741;5457.99027179973;5330.096311393528;5558.387048418479;5770.16332631766;5873.530117590668;5977.163197152402;4500.639948804088;5341.919871201935;5384.434634363413;5389.9191512127345;5396.83809485716;2533.822632415713;2536.8351057181226;2670.813043086965;3046.4516387050544;3085.9845700771352;5435.537979271727;5783.074708046693;5870.559708021916;6064;6111.860848702919;5151.407588127338;5525.502704756591;5793.855153621109;6014.72933717975;6033.78881739137;5324.92012619811;5561.749721262634;5718.914216286759;6083.7870674526175;6095.573309868267;4951.806085075178;5448.972755136199;5758.596898217253;5836.970815145897;5877.94122058774;4632.3977882875015;5271.604629652715;5327.6270661054905;5747.023006089058;5837.066069429041;5385.946140538701;6082.482988945812;6094.695265236809;6140.723667434887;6172.259328880563;3906.4726261954274;3993.7803420812133;4002.4796776420044;4009.3785463253244;4010.218007488512;5406.945930540644;5575.99632066232;5880.441358070976;6022.698865056642;6101.450869421596;4955;5268.209768534751;5312.814051508179;5765.59640825155;5977.9402205977385;4711.764411779466;4925.556699897026;5801.912971305349;5907.586468947133;5910.290765108214;4570;5678;5759.531319513498;5764.279465066867;5830.4461076197695;5202.687838729688;5446.754896029767;5590.546457920888;5676.893005863817;5770.394108618702;4364.127174565163;5437.619366644455;5744;5761.913571296518;5778.393268706725 10:10:48 INFO - PROCESS | 1650 | |5;yui.html;718.4037249083258;769.9076110866695;803.8633432316506;846.9237768600826;883.284539522986;16159;16393.83606163941;17227.310907563715;17239.913800430997;17280.740788888175;15552.766708499381;15939.282732277046;15941.92029039856;15948;15958;726.1721637333444;753.8756105242628;895.0780695883251;895.8880139982502;908.5457271364318;895.8253140637578;897.6454300551278;900.8243392538458;902.499112992289;905.0994260710602;851.4252879306474;884.8141890203065;942.6747772018642;943.1935694980796;945.7021038372925;935.3452583191759;936.1013427109982;937.7046230437459;939.9765005874874;944.032366824004;699.8180473076985;702.7083760239494;703.0438603499288;704.5033251557691;709.9811770109909;16724.58188545296;16843.74734378985;16995.830041699548;16995.830041699548;17010.06444645544;12169.574064907685;15016.24918754058;15214.239288035555;15424.074555526591;15451;11503.539858405653;11625.593104241396;11845.874641909006;12341.814872776915;12357.38213089351;4606.792694328763;4615.5845973862515;4857.0801667564465;4907.8773030674165;4954.702717836942;98859.50570247103;121642;122236;123872;126986.36506817499;11387.65837024874;11546.711332216762;11619.593314233962;11776.58781942645;11904.999999999827;22886;22928.31215063551;22948.885255573616;23087;23096.538069238522;8187.672493100328;8308.626111824982;8326.45878017927;8582.78543036429;8585.055643879168;4547.954520454819;4601.033782905561;4610.354550362952;4765.499622539653;4843.685160464559;3758.4362345648374;3913.491246137984;3913.5890731473355;3916.138449541096;3922.882313530599;697.292248367907;709.1454796969639;716.5127713155;717.3328804212133;726.498715886037;642.7686033028106;694.531191445772;697.3375293471223;713.3472872321768;737.9077615298088;9518.133917353216;9642.614295428244;10157.441340726331;10160;10454.268201225994;605.8485378655337;646.7833275852548;656.1044174701593;708.6208878250111;725.2131437390385;4679.5879168849715;4918.975405122951;4970.229614409773;4993.325901003318;5002.624803139779;97948.51025744826;99487;120033;136536;161199;136520.9521857173;140368;140879.59120408664;141689;142908;110612;110882.44558777155;113833.43083284696;113895;114214;10080;10135.087842094246;10301.896981030393;10319;10441.743018544305;39294;54631;57612.1358179636;61466.69266653638;64322.67838660777;92697;94277.5286123565;96640.55039174277;99930;101756;13222.008349373644;13720.382582784;13932.58202253934;13966.156181631597;14704.338304776096;15127.470538531099;15265.313060912507;16275.51173464798;16873.937818654602;17048.31806727717;13901.235432051335;14838.629034274229;15450.304736287118;15450.613734656723;15461.768073479132;14136.929315353358;14507.854921451073;15019;15163.545093647208;15169.772453412987;13817.240051797247;13927.373268202753;14611.41554337857;14787.704245915236;15242.3903043877;11796.76406471883;11957.342346171044;12271.263724176579;12412.678942723196;12570.87429125697;10322.380657160595;11739.882601173878;12029.578964736193;12255.203411778206;12288.877111228774 10:10:48 INFO - PROCESS | 1650 | __end_tp_report 10:10:48 INFO - PROCESS | 1650 | __start_cc_report 10:10:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1193 10:10:48 INFO - PROCESS | 1650 | __end_cc_report 10:10:48 INFO - PROCESS | 1650 | __startTimestamp1479147047992__endTimestamp 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:10:48 INFO - PROCESS | 1650 | Number of tests: 6 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5843.06 Median:6059.55 stddev:625.67 (10.3%) stddev-sans-first:599.15 10:10:48 INFO - PROCESS | 1650 | Values: 3465.8 3471.1 3510.5 3519.4 3567.7 4429.2 5736.4 5819.0 5866.5 5888.6 5794.5 5830.3 5897.2 5937.1 5961.2 5258.7 5348.9 5377.4 5423.1 5425.6 5305.6 5315.4 5333.1 5458.6 5470.5 5413.2 5415.9 5416.0 5422.9 5428.4 5419.7 5421.5 5421.8 5421.8 5423.9 5265.7 5379.7 5379.7 5387.9 5413.2 5986.7 5986.8 5995.6 6001.7 6006.8 6180.9 6225.6 6242.6 6247.5 6259.3 6198.4 6211.3 6230.1 6233.1 6248.1 5909.1 5917.8 5944.7 5994.2 6014.4 6184.4 6232.2 6241.2 6281.5 6470.3 6117.1 6279.3 6282.9 6285.8 6290.5 6255.4 6265.7 6275.5 6277.9 6279.5 6137.5 6181.0 6206.8 6272.0 6324.5 6253.0 6285.7 6290.8 6292.1 6297.9 5074.3 5109.7 5116.6 5125.6 5147.4 4212.3 4475.6 4484.2 4531.0 4576.6 5915.5 5927.5 5936.3 5961.6 6031.2 6238.3 6253.0 6256.8 6266.3 6274.6 6016.4 6017.4 6039.3 6059.5 6074.0 5414.6 5475.7 5538.5 5545.0 5588.9 6358.3 6403.1 6412.0 6416.5 6483.4 6248.7 6252.3 6277.8 6278.2 6285.6 6428.7 6464.1 6505.3 6517.3 6533.9 6151.9 6187.7 6213.7 6227.3 6266.6 6246.4 6250.9 6264.4 6269.3 6283.2 6187.4 6210.3 6254.3 6254.7 6274.9 4929.3 5310.1 5916.3 6079.7 6256.4 5987.9 6033.0 6044.8 6100.7 6109.4 6195.3 6203.1 6204.8 6211.3 6213.9 5977.8 6005.4 6030.7 6070.6 6095.2 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:80308.14 Median:36635.22 stddev:187129.60 (510.8%) stddev-sans-first:187558.54 10:10:48 INFO - PROCESS | 1650 | Values: 472.4 519.1 546.4 549.2 576.2 33604.8 42808.1 45025.0 45379.5 47469.3 46817.5 47214.1 47270.8 47347.5 47465.3 9321.5 10120.2 10321.3 10322.9 10327.5 9372.9 9542.5 9551.0 9561.8 12312.5 10220.9 12570.6 12578.4 12593.0 12602.8 10500.6 12508.7 12575.2 12575.7 12580.1 12348.9 12441.6 12446.1 12464.3 12480.5 43067.0 43460.3 43522.0 43537.6 43539.6 3497.7 3552.4 3587.3 3600.6 3637.5 33043.8 33351.2 33601.0 33616.0 33824.7 3310.0 3353.6 3465.9 3497.4 3506.9 523809.0 524087.0 525066.0 525467.0 525878.0 36528.8 66611.7 67025.3 67280.3 67346.3 37878.8 37971.0 38043.9 38099.4 38106.6 16287.0 16466.3 16479.3 16492.9 16505.9 13911.0 13999.2 14000.0 14035.0 14047.6 7647.9 7840.2 7851.9 7999.0 8222.6 3288.7 3371.1 3383.7 3385.0 3416.3 954.6 970.6 988.9 1005.3 1101.9 32228.2 32716.2 32771.5 32804.3 33308.2 925.1 1099.7 1142.3 1154.3 1166.6 13589.0 16468.7 17033.5 17034.7 17134.5 762125.0 770972.0 771281.0 774310.0 779490.1 56077.0 57059.0 64279.4 65111.0 65208.3 1342.7 1410.9 1432.3 1439.9 1453.0 28478.9 32255.8 34265.0 34362.0 34429.8 56913.1 57458.7 57525.8 57575.0 57576.4 647880.0 653239.0 666085.0 887135.3 910472.0 27775.3 28223.7 28294.4 28469.4 28782.9 49200.3 49455.0 49535.5 50380.7 50991.5 40584.4 41066.0 42371.8 43283.4 43492.0 41580.4 41850.6 41997.4 42823.0 42918.8 40699.6 41459.6 41756.4 41803.4 41869.1 30244.2 34331.3 36121.6 36741.6 36911.3 22355.3 26844.3 27287.9 27396.8 27616.6 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:37111.36 Median:2232.93 stddev:110776.08 (4961.0%) stddev-sans-first:111052.49 10:10:48 INFO - PROCESS | 1650 | Values: 373.1 382.6 384.9 387.1 411.3 19945.5 21710.5 21719.3 22041.9 22608.4 20592.7 21230.4 21358.8 21486.9 22208.0 5187.3 5485.4 5545.3 5550.3 5557.6 4144.1 4156.7 4164.6 4351.0 5506.9 4336.2 4410.8 4512.0 6971.2 7034.6 5445.9 5861.8 7026.9 7053.9 7214.6 6035.4 6134.8 6140.6 6140.9 6149.6 13499.5 13518.4 13648.0 13705.0 13867.1 2171.9 2205.0 2214.9 2225.7 2240.1 10146.7 10323.4 10330.9 10668.3 10755.7 1905.6 1958.3 1973.5 2013.4 2024.1 79503.6 79838.6 81644.6 100685.0 117975.4 11603.7 11627.9 11699.2 11754.4 11912.3 14930.0 15306.0 15331.5 15334.4 15352.2 9006.9 9069.9 9072.3 9081.5 9189.5 7347.8 9047.6 9074.6 9095.4 9236.5 4616.8 4637.5 4649.1 4657.9 4718.5 1745.6 1825.6 1873.3 1917.0 1974.6 758.3 887.4 900.9 931.1 980.8 19774.6 20842.0 21842.5 22597.0 22800.9 755.5 975.7 980.9 990.2 1004.9 11398.9 11839.9 11858.3 11884.9 11921.1 637162.6 664157.0 664199.0 674578.0 682622.0 144896.4 156246.0 156566.0 157920.0 157941.0 935.5 1036.3 1053.5 1069.6 1069.6 19844.0 19862.9 20707.6 20775.0 20914.5 59457.0 59782.0 61352.4 61494.4 61841.7 74569.9 80019.6 85288.0 87218.6 88525.6 7901.9 8061.9 8087.7 8426.3 8481.1 10984.3 12042.9 13326.6 13728.7 13762.9 11403.7 11454.9 11557.1 11812.8 12010.8 5248.7 10618.9 11532.4 11603.7 11870.1 10147.5 10310.9 11209.9 11743.9 11747.2 8014.6 8275.7 8300.2 8334.8 8397.2 9292.6 11362.4 11527.9 11836.6 11902.3 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5992.70 Median:4646.70 stddev:3438.45 (74.0%) stddev-sans-first:3432.05 10:10:48 INFO - PROCESS | 1650 | Values: 1571.4 1604.0 1807.6 1909.7 1947.9 8984.6 9548.0 9553.0 9555.4 9560.7 8343.5 8582.1 8985.6 9228.2 9335.3 2179.0 2392.5 2439.4 2475.5 2484.4 2443.8 2467.4 2477.4 2480.1 2480.4 2452.5 2465.6 2473.3 2474.5 2478.8 2419.1 2446.5 2447.9 2452.7 2462.6 2429.4 2439.3 2447.5 2448.4 2449.8 9338.9 9389.2 9472.2 9475.6 9478.7 5441.6 5613.6 5614.2 5616.7 5618.7 3583.2 3711.9 3721.1 3783.0 3792.6 1106.6 1127.9 1131.8 1152.7 1155.6 12508.9 12553.8 12573.9 12584.6 12596.5 4764.1 4791.2 4809.8 4936.4 4967.3 10593.3 10601.6 10602.1 10607.2 10610.9 5619.9 5622.2 5627.3 5630.7 5633.1 4629.9 4663.5 4967.3 5097.6 5132.8 4026.3 4070.8 4131.1 4164.2 4179.9 1187.2 1216.1 1298.2 1311.8 1315.8 932.5 950.2 955.8 961.5 989.8 4927.9 5945.3 6031.6 6050.3 6124.5 429.5 443.2 446.9 449.6 451.5 4004.4 4023.4 4037.0 4142.6 4151.9 7509.5 11338.6 11436.9 11469.5 11474.3 11248.0 11315.3 11403.9 11412.4 11442.4 8607.2 8826.3 8830.4 8839.3 8866.1 5890.3 5892.5 6035.0 6061.4 6063.4 10265.0 10371.3 10495.3 10575.7 10615.7 10950.8 10953.8 10961.7 10973.2 10987.4 7072.4 7391.0 7954.5 7966.8 8096.3 8780.9 8996.7 9004.3 9016.1 9030.2 7885.6 7921.6 7970.5 8127.7 8154.2 7785.3 7897.3 7912.6 7915.4 7958.8 6157.8 7292.4 7388.7 7396.5 7407.0 5065.4 5093.6 5298.4 5307.4 5369.0 4523.3 5164.6 5391.3 5420.8 5430.8 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4559.15 Median:5062.03 stddev:1427.80 (28.2%) stddev-sans-first:1395.62 10:10:48 INFO - PROCESS | 1650 | Values: 303.3 308.1 310.8 319.2 323.8 4264.4 4411.7 4709.9 4972.7 5545.9 4432.4 4589.7 5155.4 5333.7 5436.6 3426.9 4165.7 4176.9 4212.1 4226.9 4179.7 4192.4 4196.5 4211.8 4221.1 3467.9 3848.2 4104.6 4168.9 4183.6 4107.7 4115.7 4123.8 4127.8 4143.8 3399.0 3502.1 3558.2 3558.9 3559.8 4120.3 4323.8 4902.7 5338.1 5378.3 3933.6 4676.2 4685.8 4719.8 4734.1 5716.3 5717.8 5725.3 5746.0 5752.6 3249.4 3502.9 3746.5 3777.5 3894.5 5623.9 5788.5 5809.1 5927.3 6003.8 3381.1 3492.0 3790.2 3940.2 3942.8 3631.6 3725.3 3989.5 4018.0 4018.0 3862.8 4529.3 4564.3 4664.8 4720.8 4716.8 5384.6 5738.5 5746.8 5754.2 1290.4 1349.5 1371.6 1372.3 1379.4 731.9 778.0 860.8 913.3 921.0 4456.9 4483.9 4520.7 5401.4 5458.0 5330.1 5558.4 5770.2 5873.5 5977.2 4500.6 5341.9 5384.4 5389.9 5396.8 2533.8 2536.8 2670.8 3046.5 3086.0 5435.5 5783.1 5870.6 6064.0 6111.9 5151.4 5525.5 5793.9 6014.7 6033.8 5324.9 5561.7 5718.9 6083.8 6095.6 4951.8 5449.0 5758.6 5837.0 5877.9 4632.4 5271.6 5327.6 5747.0 5837.1 5385.9 6082.5 6094.7 6140.7 6172.3 3906.5 3993.8 4002.5 4009.4 4010.2 5406.9 5576.0 5880.4 6022.7 6101.5 4955.0 5268.2 5312.8 5765.6 5977.9 4711.8 4925.6 5801.9 5907.6 5910.3 4570.0 5678.0 5759.5 5764.3 5830.4 5202.7 5446.8 5590.5 5676.9 5770.4 4364.1 5437.6 5744.0 5761.9 5778.4 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25295.66 Median:20083.37 stddev:39372.38 (196.0%) stddev-sans-first:39439.58 10:10:48 INFO - PROCESS | 1650 | Values: 718.4 769.9 803.9 846.9 883.3 16159.0 16393.8 17227.3 17239.9 17280.7 15552.8 15939.3 15941.9 15948.0 15958.0 726.2 753.9 895.1 895.9 908.5 895.8 897.6 900.8 902.5 905.1 851.4 884.8 942.7 943.2 945.7 935.3 936.1 937.7 940.0 944.0 699.8 702.7 703.0 704.5 710.0 16724.6 16843.7 16995.8 16995.8 17010.1 12169.6 15016.2 15214.2 15424.1 15451.0 11503.5 11625.6 11845.9 12341.8 12357.4 4606.8 4615.6 4857.1 4907.9 4954.7 98859.5 121642.0 122236.0 123872.0 126986.4 11387.7 11546.7 11619.6 11776.6 11905.0 22886.0 22928.3 22948.9 23087.0 23096.5 8187.7 8308.6 8326.5 8582.8 8585.1 4548.0 4601.0 4610.4 4765.5 4843.7 3758.4 3913.5 3913.6 3916.1 3922.9 697.3 709.1 716.5 717.3 726.5 642.8 694.5 697.3 713.3 737.9 9518.1 9642.6 10157.4 10160.0 10454.3 605.8 646.8 656.1 708.6 725.2 4679.6 4919.0 4970.2 4993.3 5002.6 97948.5 99487.0 120033.0 136536.0 161199.0 136521.0 140368.0 140879.6 141689.0 142908.0 110612.0 110882.4 113833.4 113895.0 114214.0 10080.0 10135.1 10301.9 10319.0 10441.7 39294.0 54631.0 57612.1 61466.7 64322.7 92697.0 94277.5 96640.6 99930.0 101756.0 13222.0 13720.4 13932.6 13966.2 14704.3 15127.5 15265.3 16275.5 16873.9 17048.3 13901.2 14838.6 15450.3 15450.6 15461.8 14136.9 14507.9 15019.0 15163.5 15169.8 13817.2 13927.4 14611.4 14787.7 15242.4 11796.8 11957.3 12271.3 12412.7 12570.9 10322.4 11739.9 12029.6 12255.2 12288.9 10:10:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:10:48 INFO - PROCESS | 1650 | 10:10:48 INFO - TEST-INFO | 1650: exit 0 10:10:48 INFO - TEST-OK | dromaeo_css | took 1115160ms 10:10:48 INFO - TEST-START | kraken 10:10:48 INFO - operating with platform_type : mac_ 10:10:48 INFO - Initialising browser for kraken test... 10:10:48 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpQXfSyi/profile http://localhost:49272/getInfo.html) 10:10:50 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 10:10:50 INFO - PROCESS | 1660 | colorDepth:24 10:10:50 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 10:10:50 INFO - PROCESS | 1660 | __metrics 10:10:50 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:50 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:51 INFO - TEST-INFO | 1660: exit 0 10:10:51 INFO - Browser initialized. 10:10:51 INFO - Running cycle 1/1 for kraken test... 10:10:51 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpQXfSyi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:03 INFO - PROCESS | 1662 | RSS: Main: 168685568 10:11:03 INFO - PROCESS | 1662 | 10:11:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:06 INFO - PROCESS | 1662 | RSS: Main: 218300416 10:11:06 INFO - PROCESS | 1662 | 10:11:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:11:10 INFO - PROCESS | 1662 | RSS: Main: 228773888 10:11:10 INFO - PROCESS | 1662 | 10:11:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:11:13 INFO - PROCESS | 1662 | RSS: Main: 326328320 10:11:13 INFO - PROCESS | 1662 | 10:11:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:11:16 INFO - PROCESS | 1662 | RSS: Main: 227971072 10:11:16 INFO - PROCESS | 1662 | 10:11:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:18 INFO - PROCESS | 1662 | RSS: Main: 230682624 10:11:18 INFO - PROCESS | 1662 | 10:11:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:22 INFO - PROCESS | 1662 | RSS: Main: 269365248 10:11:22 INFO - PROCESS | 1662 | 10:11:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:25 INFO - PROCESS | 1662 | RSS: Main: 265297920 10:11:25 INFO - PROCESS | 1662 | 10:11:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:11:29 INFO - PROCESS | 1662 | RSS: Main: 264855552 10:11:29 INFO - PROCESS | 1662 | 10:11:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:31 INFO - PROCESS | 1662 | RSS: Main: 241008640 10:11:31 INFO - PROCESS | 1662 | 10:11:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:33 INFO - PROCESS | 1662 | RSS: Main: 246411264 10:11:33 INFO - PROCESS | 1662 | 10:11:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:36 INFO - PROCESS | 1662 | RSS: Main: 252162048 10:11:36 INFO - PROCESS | 1662 | 10:11:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:40 INFO - PROCESS | 1662 | RSS: Main: 276750336 10:11:40 INFO - PROCESS | 1662 | 10:11:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:43 INFO - PROCESS | 1662 | RSS: Main: 264306688 10:11:43 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:11:45 INFO - PROCESS | 1662 | RSS: Main: 307892224 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | __start_tp_report 10:11:45 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 10:11:45 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 10:11:45 INFO - PROCESS | 1662 | |i|pagename|runs| 10:11:45 INFO - PROCESS | 1662 | |0;ai-astar;113;112;112;111;111;112;112;117;137;113 10:11:45 INFO - PROCESS | 1662 | |1;audio-beat-detection;143;138;136;147;112;136;141;113;135;112 10:11:45 INFO - PROCESS | 1662 | |2;audio-dft;189;183;181;184;180;183;182;181;184;184 10:11:45 INFO - PROCESS | 1662 | |3;audio-fft;81;58;59;87;61;58;57;58;82;58 10:11:45 INFO - PROCESS | 1662 | |4;audio-oscillator;82;69;93;69;68;68;93;68;68;88 10:11:45 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;83;87;83;86;83;87;86;132;83 10:11:45 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;92;92;93;93;92;92;92;92;93 10:11:45 INFO - PROCESS | 1662 | |7;imaging-desaturate;83;84;84;94;124;83;91;134;85;129 10:11:45 INFO - PROCESS | 1662 | |8;json-parse-financial;54;53;51;53;55;56;55;55;55;55 10:11:45 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;63;70;69;75;70;68;68;68;69;69 10:11:45 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;84;84;83;83;79;83;79;89;88;125 10:11:45 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;134;136;147;149;132;130;133;132;146;156 10:11:45 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;159;159;160;161;157;159;161;161;157;159 10:11:45 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;66;66;71;87;83;86;84;64;64 10:11:45 INFO - PROCESS | 1662 | __end_tp_report 10:11:45 INFO - PROCESS | 1662 | __start_cc_report 10:11:45 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1961 10:11:45 INFO - PROCESS | 1662 | __end_cc_report 10:11:45 INFO - PROCESS | 1662 | __startTimestamp1479147105491__endTimestamp 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | ------- Summary: start ------- 10:11:45 INFO - PROCESS | 1662 | Number of tests: 14 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:115.00 Median:112.50 stddev:7.92 (7.0%) stddev-sans-first:8.36 10:11:45 INFO - PROCESS | 1662 | Values: 113.0 112.0 112.0 111.0 111.0 112.0 112.0 117.0 137.0 113.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:137.00 stddev:13.58 (9.9%) stddev-sans-first:13.73 10:11:45 INFO - PROCESS | 1662 | Values: 143.0 138.0 136.0 147.0 112.0 136.0 141.0 113.0 135.0 112.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:2.51 (1.4%) stddev-sans-first:1.51 10:11:45 INFO - PROCESS | 1662 | Values: 189.0 183.0 181.0 184.0 180.0 183.0 182.0 181.0 184.0 184.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.00 stddev:12.17 (20.3%) stddev-sans-first:11.62 10:11:45 INFO - PROCESS | 1662 | Values: 81.0 58.0 59.0 87.0 61.0 58.0 57.0 58.0 82.0 58.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:75.50 stddev:11.10 (14.7%) stddev-sans-first:11.60 10:11:45 INFO - PROCESS | 1662 | Values: 82.0 69.0 93.0 69.0 68.0 68.0 93.0 68.0 68.0 88.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:86.00 stddev:14.97 (17.4%) stddev-sans-first:15.85 10:11:45 INFO - PROCESS | 1662 | Values: 87.0 83.0 87.0 83.0 86.0 83.0 87.0 86.0 132.0 83.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:92.50 stddev:0.97 (1.0%) stddev-sans-first:0.50 10:11:45 INFO - PROCESS | 1662 | Values: 95.0 92.0 92.0 93.0 93.0 92.0 92.0 92.0 92.0 93.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:84.00 stddev:21.07 (25.1%) stddev-sans-first:21.53 10:11:45 INFO - PROCESS | 1662 | Values: 83.0 84.0 84.0 94.0 124.0 83.0 91.0 134.0 85.0 129.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.48 (2.7%) stddev-sans-first:1.56 10:11:45 INFO - PROCESS | 1662 | Values: 54.0 53.0 51.0 53.0 55.0 56.0 55.0 55.0 55.0 55.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:2.92 (4.2%) stddev-sans-first:2.19 10:11:45 INFO - PROCESS | 1662 | Values: 63.0 70.0 69.0 75.0 70.0 68.0 68.0 68.0 69.0 69.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.50 stddev:13.49 (16.2%) stddev-sans-first:14.24 10:11:45 INFO - PROCESS | 1662 | Values: 84.0 84.0 83.0 83.0 79.0 83.0 79.0 89.0 88.0 125.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:141.00 stddev:9.12 (6.5%) stddev-sans-first:9.45 10:11:45 INFO - PROCESS | 1662 | Values: 134.0 136.0 147.0 149.0 132.0 130.0 133.0 132.0 146.0 156.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 10:11:45 INFO - PROCESS | 1662 | Values: 159.0 159.0 160.0 161.0 157.0 159.0 161.0 161.0 157.0 159.0 10:11:45 INFO - PROCESS | 1662 | 10:11:45 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:77.00 stddev:9.97 (12.9%) stddev-sans-first:10.17 10:11:45 INFO - PROCESS | 1662 | Values: 66.0 66.0 66.0 71.0 87.0 83.0 86.0 84.0 64.0 64.0 10:11:45 INFO - PROCESS | 1662 | -------- Summary: end -------- 10:11:45 INFO - PROCESS | 1662 | 10:11:46 INFO - TEST-INFO | 1662: exit 0 10:11:46 INFO - TEST-OK | kraken | took 57745ms 10:11:46 INFO - SUITE-END | took 1172s 10:11:46 INFO - Completed test suite (00:19:33) 10:11:46 INFO - javascript benchmark 10:11:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3465.7573969822115, 3471.0628130404793, 3510.5085288059677, 3519.436890097585, 3567.714582833372, 4429.180601588704, 5736.426357364257, 5819.0, 5866.472017518422, 5888.617239879405, 5794.507466865311, 5830.271216097988, 5897.174395584621, 5937.109433584965, 5961.225040744708, 5258.710770907599, 5348.91976620349, 5377.435369286227, 5423.132298832187, 5425.647332923348, 5305.575553955674, 5315.415304316522, 5333.093374126388, 5458.590605704569, 5470.452954704538, 5413.215083812865, 5415.864603384927, 5416.025115479212, 5422.864428389302, 5428.375736790261, 5419.729013549307, 5421.512063914267, 5421.810236641699, 5421.83734487966, 5423.918641220384, 5265.657732247391, 5379.65032272905, 5379.67721936685, 5387.946120538783, 5413.188021796723, 5986.730597123096, 5986.820395388146, 5995.580309378345, 6001.699915004276, 6006.789762358297, 6180.907286390708, 6225.62646241227, 6242.5942313749465, 6247.468965137969, 6259.311475737665, 6198.3801619838105, 6211.25464944205, 6230.065490176465, 6233.065040243954, 6248.125262463259, 5909.113632955091, 5917.792877249276, 5944.7433517323125, 5994.1608174855555, 6014.3684913083935, 6184.443400093923, 6232.220972378453, 6241.157443745036, 6281.528885333618, 6470.2559205691, 6117.096718007379, 6279.277883043417, 6282.874342513124, 6285.842853928597, 6290.4653104485715, 6255.437010669061, 6265.686715664198, 6275.497960163176, 6277.874442511215, 6279.497640188774, 6137.506931296464, 6181.011038233951, 6206.782762603378, 6272.0, 6324.494040476751, 6253.0, 6285.717142728497, 6290.8427289317215, 6292.087647291117, 6297.905531417033, 5074.264231686385, 5109.718965456936, 5116.56509196715, 5125.56432703217, 5147.433782283946, 4212.304969679968, 4475.5748203920575, 4484.2376795944765, 4531.0, 4576.565226303496, 5915.526757859361, 5927.4665280125, 5936.317323507766, 5961.612495187799, 6031.155638210654, 6238.344973777688, 6252.968735156386, 6256.781012664626, 6266.310705822356, 6274.592151510137, 6016.368281330398, 6017.398260173947, 6039.335673075958, 6059.545534084961, 6074.0281554951, 5414.648047876875, 5475.698836563947, 5538.47384498472, 5544.972275138599, 5588.91616625751, 6358.33237510064, 6403.135576697086, 6411.96794016027, 6416.454601358937, 6483.384078512534, 6248.656323902229, 6252.3122456530655, 6277.780277690259, 6278.246610406781, 6285.59143655661, 6428.678566071584, 6464.0627109069865, 6505.349465053457, 6517.283098859027, 6533.901991470227, 6151.876962460815, 6187.721552530057, 6213.65824879636, 6227.346128656426, 6266.624002559861, 6246.3753624637175, 6250.874982500233, 6264.436200741955, 6269.310375858743, 6283.151774510383, 6187.443130118311, 6210.254769427697, 6254.312025677081, 6254.718537665725, 6274.937250627435, 4929.334539837219, 5310.097283461743, 5916.290045194604, 6079.726412311545, 6256.405641464054, 5987.910181347371, 6032.969835150796, 6044.788432404845, 6100.694965251809, 6109.35526230379, 6195.349488303663, 6203.069539569101, 6204.751809927733, 6211.254649442096, 6213.875722485615, 5977.790777322773, 6005.429484198994, 6030.668313242813, 6070.6357618543025, 6095.207623008981], "value": 5805.220169339341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.40005193404374, 519.1019536202369, 546.4426285189107, 549.2063967566864, 576.236486655182, 33604.83197584012, 42808.14383712328, 45025.0, 45379.546204537946, 47469.28796068053, 46817.53182468174, 47214.055718885604, 47270.81822954428, 47347.52652473474, 47465.28802067963, 9321.533923303841, 10120.240981926348, 10321.277510574262, 10322.948385258102, 10327.483625818679, 9372.8594071089, 9542.52287385628, 9551.044895510428, 9561.760955976086, 12312.507499700001, 10220.897791022106, 12570.560030398938, 12578.433970471351, 12593.0, 12602.81095783564, 10500.632477863239, 12508.749825003495, 12575.245485270822, 12575.685607859785, 12580.056495762763, 12348.876511234863, 12441.564545240873, 12446.06654500916, 12464.314462704548, 12480.50077996879, 43066.98531102824, 43460.3480947786, 43522.0, 43537.56462435367, 43539.564604353865, 3497.702695270905, 3552.4138517144897, 3587.2646107548153, 3600.567931848169, 3637.4543818427182, 33043.83478082618, 33351.24698951057, 33601.0, 33615.99152025443, 33824.661753382396, 3309.9503507447407, 3353.5808023997, 3465.9480107798404, 3497.3879571075213, 3506.929861402783, 523809.0, 524087.0, 525066.0, 525467.0, 525878.0, 36528.81735591358, 66611.66694166498, 67025.32974670191, 67280.32719672838, 67346.32653673498, 37878.8106059468, 37971.0, 38043.858684239516, 38099.4285085724, 38106.61893381031, 16287.0, 16466.259018343964, 16479.258433370287, 16492.917535412245, 16505.917470412573, 13911.026228163932, 13999.230042347768, 13999.95000374976, 14035.0, 14047.578572642837, 7647.885281720779, 7840.215978402114, 7851.9214807851195, 7998.960005199937, 8222.588870556448, 3288.7369010479106, 3371.0561042908025, 3383.678550537695, 3385.0, 3416.2825806580895, 954.6467806911487, 970.5729479029204, 988.9357191782511, 1005.2711783956573, 1101.8677758669012, 32228.19429514281, 32716.182095447803, 32771.50842737361, 32804.34391312208, 33308.167295817315, 925.1035377476147, 1099.69758316462, 1142.2575326037975, 1154.261272785418, 1166.6383421139474, 13589.0, 16468.6706265874, 17033.48899533016, 17034.659306813795, 17134.485965421056, 762125.0, 770972.0, 771281.0, 774310.0, 779490.1025494837, 56077.0, 57059.0, 64279.35720642827, 65111.02333465002, 65208.34791652023, 1342.684469149749, 1410.9223992680502, 1432.3411230833724, 1439.863212994764, 1452.9636759081106, 28478.857605711837, 32255.838720806245, 34265.0, 34362.0, 34429.79495717638, 56913.146302804664, 57458.71270643787, 57525.84948301094, 57575.0, 57576.424235757106, 647880.0, 653239.0, 666085.0, 887135.2572948633, 910472.0, 27775.30561735973, 28223.71776282211, 28294.43411131807, 28469.43061138807, 28782.85608571944, 49200.26199606937, 49454.971247686895, 49535.504644953086, 50380.74809625928, 50991.490085098674, 40584.39123413092, 41065.97335066647, 42371.78814106033, 43283.35074973815, 43492.0, 41580.376294355, 41850.58149418467, 41997.37003944882, 42823.0, 42918.78540607277, 40699.59300406958, 41459.585404145575, 41756.3736543946, 41803.37294940639, 41869.069165158144, 30244.24389390283, 34331.31337373288, 36121.63878361183, 36741.63258367382, 36911.26177476489, 22355.32934011982, 26844.328891777863, 27287.863560682068, 27396.7680437583, 27616.585751213344], "value": 20412.385603163293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.06733167082297, 382.6384067056631, 384.91916697493537, 387.0748910104848, 411.28641806465777, 19945.501362465944, 21710.457238569004, 21719.34841954742, 22041.889790551046, 22608.43478913028, 20592.691109633368, 21230.36308910731, 21358.786412135873, 21486.89256553715, 22208.0, 5187.299714538527, 5485.396606373296, 5545.306836645419, 5550.250716153308, 5557.638753481031, 4144.109016561439, 4156.667466602679, 4164.625183733463, 4351.0, 5506.889862202754, 4336.21948049351, 4410.757408342556, 4511.954880451202, 6971.163460384735, 7034.6482675866255, 5445.918311225335, 5861.765529378819, 7026.929730702705, 7053.929460705404, 7214.603196824199, 6035.426634469718, 6134.8159555213415, 6140.600860944024, 6140.907886381708, 6149.631022138686, 13499.460021599125, 13518.391672374766, 13648.0, 13705.0, 13867.098638588459, 2171.86968781872, 2204.9779502204933, 2214.9335519934266, 2225.710657614516, 2240.148743477468, 10146.695599132037, 10323.380597164194, 10330.9483452583, 10668.253222274443, 10755.677329680122, 1905.6474552207885, 1958.3145898935402, 1973.4770285874256, 2013.416109328293, 2024.1498570600384, 79503.60248198723, 79838.60080699617, 81644.59177704074, 100685.0, 117975.41012294883, 11603.709907252218, 11627.941860290644, 11699.23954942926, 11754.353510557, 11912.285262884254, 14930.0, 15306.005109667836, 15331.463398780988, 15334.386624534895, 15352.232388380537, 9006.909930900738, 9069.909300907038, 9072.319576031692, 9081.54592270384, 9189.494577798152, 7347.8163045924275, 9047.592858321392, 9074.637014519478, 9095.36332456735, 9236.491992940319, 4616.815327386867, 4637.466691330473, 4649.139909116824, 4657.930131048037, 4718.4809670936165, 1745.6246906915073, 1825.6084529266702, 1873.2506997200956, 1916.9712454313196, 1974.634692581877, 758.332667252814, 887.3566664168555, 900.9009009009004, 931.0549791961165, 980.8283550378655, 19774.61577689548, 20841.957902105136, 21842.50810123082, 22597.0, 22800.947914687757, 755.5126943121655, 975.6926568131016, 980.8970058143935, 990.1979396688705, 1004.9497525123714, 11398.886011139948, 11839.88160118405, 11858.347790871412, 11884.940575297069, 11921.105917056255, 637162.6283737196, 664157.0, 664199.0, 674578.0, 682622.0, 144896.37759055896, 156246.0, 156566.0, 157920.0, 157941.0, 935.5415846235296, 1036.2538971940191, 1053.4522048534873, 1069.561479793281, 1069.5668254356842, 19844.0, 19862.900685497058, 20707.585848282648, 20775.0, 20914.47713807167, 59457.0, 59782.0, 61352.38647613467, 61494.385056148865, 61841.69079154755, 74569.88145177935, 80019.59990200012, 85288.0, 87218.56390718005, 88525.55737221273, 7901.920980790119, 8061.919380806117, 8087.676492940216, 8426.325893928593, 8481.06708262103, 10984.340939543654, 12042.939785301018, 13326.600201993955, 13728.65678358049, 13762.931185344009, 11403.657890263305, 11454.885451145381, 11557.088237499198, 11812.763744724885, 12010.819837702616, 5248.711320877235, 10618.893811061791, 11532.423378831192, 11603.665578458586, 11870.109741769229, 10147.492625368553, 10310.948445257725, 11209.943950280196, 11743.941280293544, 11747.177697561088, 8014.599270036359, 8275.710350137957, 8300.169983001651, 8334.791630209293, 8397.244248017707, 9292.58183381736, 11362.431878406212, 11527.904849039327, 11836.644900652995, 11902.345371004678], "value": 9562.918731993248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.379305174456, 1604.037577453528, 1807.6203997160596, 1909.7135429685536, 1947.8507680468522, 8984.550772461384, 9548.0, 9552.952235238832, 9555.426674399532, 9560.713178604645, 8343.499390036603, 8582.141785821415, 8985.640574377017, 9228.16946474817, 9335.3465257432, 2179.019441251435, 2392.5095355452177, 2439.39015246188, 2475.504899020194, 2484.391324125592, 2443.7922776564014, 2467.444824914398, 2477.3930387055198, 2480.131953816159, 2480.404702871307, 2452.4849781545895, 2465.617829236462, 2473.2703852363597, 2474.5298393305306, 2478.764517370847, 2419.0928401849305, 2446.47400808827, 2447.8776061197045, 2452.6566280720626, 2462.6059830427225, 2429.441228517451, 2439.3047981325235, 2447.5349683560244, 2448.4368595223023, 2449.816263780224, 9338.906610933871, 9389.201917836992, 9472.242220622335, 9475.573599188054, 9478.668246611405, 5441.564674826004, 5613.550915926716, 5614.214010038598, 5616.719164041822, 5618.747156377973, 3583.2475180212186, 3711.9443208351895, 3721.14413684854, 3782.9621703782886, 3792.60177681345, 1106.5850306135198, 1127.9097672186206, 1131.847200627913, 1152.7060599547146, 1155.6186458468685, 12508.874911250861, 12553.811692824615, 12573.93713031429, 12584.559540416132, 12596.496140154382, 4764.094821983812, 4791.1854984652, 4809.759512024385, 4936.358273424432, 4967.304577359173, 10593.258471907047, 10601.575936962436, 10602.098821600097, 10607.15142788575, 10610.946945265225, 5619.8595035124445, 5622.212890195376, 5627.324721033502, 5630.690312032878, 5633.098704207389, 4629.86110416688, 4663.547037842892, 4967.329410529533, 5097.64316497849, 5132.769025393866, 4026.315526360526, 4070.755754654671, 4131.091159944807, 4164.208800327928, 4179.895502612459, 1187.2401662935729, 1216.1183142221819, 1298.2016060122955, 1311.8163457116011, 1315.83552055993, 932.48247222792, 950.1591091883732, 955.7515046087929, 961.5480724059681, 989.7822479054596, 4927.891224474536, 5945.346011938684, 6031.638101713911, 6050.304215015241, 6124.479419249414, 429.5361010109075, 443.16463466366133, 446.90614970855836, 449.5976101389238, 451.5461960729446, 4004.3993400990084, 4023.376376661622, 4036.979815100906, 4142.5857414258935, 4151.8962025949595, 7509.549427034395, 11338.603148889913, 11436.94281528587, 11469.483873225725, 11474.254173478697, 11248.043916267045, 11315.321080735182, 11403.885961140448, 11412.429378531206, 11442.427878606037, 8607.18231767981, 8826.293896488265, 8830.42602230853, 8839.29285657146, 8866.113388661082, 5890.322612899571, 5892.499137573354, 6035.0, 6061.36355682647, 6063.363346848694, 10265.024822641837, 10371.27401081917, 10495.265331426726, 10575.735606609896, 10615.681529554126, 10950.835737463785, 10953.780924381626, 10961.671149865517, 10973.23187376876, 10987.39569323695, 7072.434205263464, 7390.96304518474, 7954.482958607672, 7966.760997170094, 8096.271335579826, 8780.946286445667, 8996.730098097067, 9004.324675649483, 9016.053314401894, 9030.232430243503, 7885.605719714106, 7921.564313962787, 7970.4819186752675, 8127.715529956423, 8154.184581541798, 7785.338246248905, 7897.289243968071, 7912.643931023233, 7915.366770658218, 7958.761237162895, 6157.753689852356, 7292.380147687294, 7388.704451822082, 7396.482246242711, 7406.9630251765875, 5065.366829146356, 5093.617978651542, 5298.443663415286, 5307.4427185145005, 5369.0, 4523.32150177476, 5164.612654051037, 5391.32608423947, 5420.810271640631, 5430.8099216527235], "value": 4707.764854596426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3402349888991, 308.11724409566597, 310.76071425002743, 319.22906181571506, 323.75879969422783, 4264.445622069126, 4411.669124815639, 4709.85870423887, 4972.651914365996, 5545.9445405545985, 4432.3573081903105, 4589.724616523011, 5155.381354237496, 5333.733313334337, 5436.565074794017, 3426.8800591979284, 4165.666746660268, 4176.853810116647, 4212.136512015045, 4226.9154616907645, 4179.686523510733, 4192.350185721203, 4196.517400498936, 4211.810468528924, 4221.113566151112, 3467.8959631211105, 3848.2495913296916, 4104.569020252875, 4168.874933751992, 4183.581641835823, 4107.67138628909, 4115.650169735576, 4123.793810309502, 4127.752334859918, 4143.834246630131, 3399.0285634332276, 3502.1419752160627, 3558.2349794794245, 3558.857645694169, 3559.8220088995704, 4120.25835349637, 4323.762193079379, 4902.656814022984, 5338.078291814943, 5378.300820893259, 3933.606639336072, 4676.228422310314, 4685.835995740167, 4719.787609557578, 4734.147853386389, 5716.314042314907, 5717.798033101477, 5725.2843394575675, 5746.0, 5752.597318187729, 3249.4151052810485, 3502.8949131526097, 3746.5316835395574, 3777.490038844748, 3894.5131858517684, 5623.915641265385, 5788.479036886658, 5809.128630705428, 5927.347991720907, 6003.759849606011, 3381.053305074583, 3491.9873236761564, 3790.166163444093, 3940.2465902673034, 3942.802859856996, 3631.5642122945414, 3725.2735716535017, 3989.4614227079555, 4017.9598204017584, 4018.0, 3862.8218393390284, 4529.297958816389, 4564.315352697122, 4664.813407463664, 4720.811167553328, 4716.8113275468595, 5384.596155288369, 5738.454846789548, 5746.827595172152, 5754.223179870748, 1290.3935150479447, 1349.5411560069624, 1371.615947534692, 1372.27955323454, 1379.379279324308, 731.9487635865438, 777.9922200778033, 860.8335705119598, 913.3423934766957, 921.0099143420849, 4456.866294011184, 4483.887902802456, 4520.706154099973, 5401.432849550741, 5457.99027179973, 5330.096311393528, 5558.387048418479, 5770.16332631766, 5873.530117590668, 5977.163197152402, 4500.639948804088, 5341.919871201935, 5384.434634363413, 5389.9191512127345, 5396.83809485716, 2533.822632415713, 2536.8351057181226, 2670.813043086965, 3046.4516387050544, 3085.9845700771352, 5435.537979271727, 5783.074708046693, 5870.559708021916, 6064.0, 6111.860848702919, 5151.407588127338, 5525.502704756591, 5793.855153621109, 6014.72933717975, 6033.78881739137, 5324.92012619811, 5561.749721262634, 5718.914216286759, 6083.7870674526175, 6095.573309868267, 4951.806085075178, 5448.972755136199, 5758.596898217253, 5836.970815145897, 5877.94122058774, 4632.3977882875015, 5271.604629652715, 5327.6270661054905, 5747.023006089058, 5837.066069429041, 5385.946140538701, 6082.482988945812, 6094.695265236809, 6140.723667434887, 6172.259328880563, 3906.4726261954274, 3993.7803420812133, 4002.4796776420044, 4009.3785463253244, 4010.218007488512, 5406.945930540644, 5575.99632066232, 5880.441358070976, 6022.698865056642, 6101.450869421596, 4955.0, 5268.209768534751, 5312.814051508179, 5765.59640825155, 5977.9402205977385, 4711.764411779466, 4925.556699897026, 5801.912971305349, 5907.586468947133, 5910.290765108214, 4570.0, 5678.0, 5759.531319513498, 5764.279465066867, 5830.4461076197695, 5202.687838729688, 5446.754896029767, 5590.546457920888, 5676.893005863817, 5770.394108618702, 4364.127174565163, 5437.619366644455, 5744.0, 5761.913571296518, 5778.393268706725], "value": 4106.14452481917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4037249083258, 769.9076110866695, 803.8633432316506, 846.9237768600826, 883.284539522986, 16159.0, 16393.83606163941, 17227.310907563715, 17239.913800430997, 17280.740788888175, 15552.766708499381, 15939.282732277046, 15941.92029039856, 15948.0, 15958.0, 726.1721637333444, 753.8756105242628, 895.0780695883251, 895.8880139982502, 908.5457271364318, 895.8253140637578, 897.6454300551278, 900.8243392538458, 902.499112992289, 905.0994260710602, 851.4252879306474, 884.8141890203065, 942.6747772018642, 943.1935694980796, 945.7021038372925, 935.3452583191759, 936.1013427109982, 937.7046230437459, 939.9765005874874, 944.032366824004, 699.8180473076985, 702.7083760239494, 703.0438603499288, 704.5033251557691, 709.9811770109909, 16724.58188545296, 16843.74734378985, 16995.830041699548, 16995.830041699548, 17010.06444645544, 12169.574064907685, 15016.24918754058, 15214.239288035555, 15424.074555526591, 15451.0, 11503.539858405653, 11625.593104241396, 11845.874641909006, 12341.814872776915, 12357.38213089351, 4606.792694328763, 4615.5845973862515, 4857.0801667564465, 4907.8773030674165, 4954.702717836942, 98859.50570247103, 121642.0, 122236.0, 123872.0, 126986.36506817499, 11387.65837024874, 11546.711332216762, 11619.593314233962, 11776.58781942645, 11904.999999999827, 22886.0, 22928.31215063551, 22948.885255573616, 23087.0, 23096.538069238522, 8187.672493100328, 8308.626111824982, 8326.45878017927, 8582.78543036429, 8585.055643879168, 4547.954520454819, 4601.033782905561, 4610.354550362952, 4765.499622539653, 4843.685160464559, 3758.4362345648374, 3913.491246137984, 3913.5890731473355, 3916.138449541096, 3922.882313530599, 697.292248367907, 709.1454796969639, 716.5127713155, 717.3328804212133, 726.498715886037, 642.7686033028106, 694.531191445772, 697.3375293471223, 713.3472872321768, 737.9077615298088, 9518.133917353216, 9642.614295428244, 10157.441340726331, 10160.0, 10454.268201225994, 605.8485378655337, 646.7833275852548, 656.1044174701593, 708.6208878250111, 725.2131437390385, 4679.5879168849715, 4918.975405122951, 4970.229614409773, 4993.325901003318, 5002.624803139779, 97948.51025744826, 99487.0, 120033.0, 136536.0, 161199.0, 136520.9521857173, 140368.0, 140879.59120408664, 141689.0, 142908.0, 110612.0, 110882.44558777155, 113833.43083284696, 113895.0, 114214.0, 10080.0, 10135.087842094246, 10301.896981030393, 10319.0, 10441.743018544305, 39294.0, 54631.0, 57612.1358179636, 61466.69266653638, 64322.67838660777, 92697.0, 94277.5286123565, 96640.55039174277, 99930.0, 101756.0, 13222.008349373644, 13720.382582784, 13932.58202253934, 13966.156181631597, 14704.338304776096, 15127.470538531099, 15265.313060912507, 16275.51173464798, 16873.937818654602, 17048.31806727717, 13901.235432051335, 14838.629034274229, 15450.304736287118, 15450.613734656723, 15461.768073479132, 14136.929315353358, 14507.854921451073, 15019.0, 15163.545093647208, 15169.772453412987, 13817.240051797247, 13927.373268202753, 14611.41554337857, 14787.704245915236, 15242.3903043877, 11796.76406471883, 11957.342346171044, 12271.263724176579, 12412.678942723196, 12570.87429125697, 10322.380657160595, 11739.882601173878, 12029.578964736193, 12255.203411778206, 12288.877111228774], "value": 8301.154269446233, "unit": "score"}], "name": "dromaeo_css", "value": 7527.013120997226, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 117.0, 137.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 136.0, 147.0, 112.0, 136.0, 141.0, 113.0, 135.0, 112.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 183.0, 181.0, 184.0, 180.0, 183.0, 182.0, 181.0, 184.0, 184.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 87.0, 61.0, 58.0, 57.0, 58.0, 82.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 93.0, 69.0, 68.0, 68.0, 93.0, 68.0, 68.0, 88.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 83.0, 86.0, 83.0, 87.0, 86.0, 132.0, 83.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 92.0, 92.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 94.0, 124.0, 83.0, 91.0, 134.0, 85.0, 129.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 53.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 69.0, 75.0, 70.0, 68.0, 68.0, 68.0, 69.0, 69.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 79.0, 83.0, 79.0, 89.0, 88.0, 125.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 147.0, 149.0, 132.0, 130.0, 133.0, 132.0, 146.0, 156.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 161.0, 157.0, 159.0, 161.0, 161.0, 157.0, 159.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 71.0, 87.0, 83.0, 86.0, 84.0, 64.0, 64.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1436.6000000000001, "alertThreshold": 2.0}]} 10:11:46 INFO - Return code: 0 10:11:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:46 INFO - # TBPL SUCCESS # 10:11:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:46 INFO - 2016-11-14 10:11:46.824 screenresolution[1666:9885] starting screenresolution argv=screenresolution get 10:11:46 INFO - 2016-11-14 10:11:46.827 screenresolution[1666:9885] Display 0: 1600x1200x32@60 10:11:46 INFO - 2016-11-14 10:11:46.832 screenresolution[1667:9888] starting screenresolution argv=screenresolution list 10:11:46 INFO - Available Modes on Display 0 10:11:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:47 INFO - Intel Iris: 10:11:47 INFO - Chipset Model: Intel Iris 10:11:47 INFO - Type: GPU 10:11:47 INFO - Bus: Built-In 10:11:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:47 INFO - Vendor: Intel (0x8086) 10:11:47 INFO - Device ID: 0x0a2e 10:11:47 INFO - Revision ID: 0x0009 10:11:47 INFO - Displays: 10:11:47 INFO - Display: 10:11:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:47 INFO - Display Serial Number: 1600x1200 60 10:11:47 INFO - Main Display: Yes 10:11:47 INFO - Mirror: Off 10:11:47 INFO - Online: Yes 10:11:47 INFO - Rotation: Supported 10:11:47 INFO - Return code: 0 10:11:47 INFO - Running post-action listener: _resource_record_post_action 10:11:47 INFO - [mozharness: 2016-11-14 18:11:47.067861Z] Finished run-tests step (success) 10:11:47 INFO - Running post-run listener: _resource_record_post_run 10:11:47 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37438464; Write bytes: 494666752; Read time: 240; Write time: 1526 10:11:47 INFO - TinderboxPrint: CPU usage
53.1% 10:11:47 INFO - TinderboxPrint: I/O read bytes / time
37,438,464 / 240 10:11:47 INFO - TinderboxPrint: I/O write bytes / time
494,666,752 / 1,526 10:11:47 INFO - TinderboxPrint: CPU idle
2,241.3 (46.9%) 10:11:47 INFO - TinderboxPrint: CPU system
949.9 (19.9%) 10:11:47 INFO - TinderboxPrint: CPU user
1,590.5 (33.3%) 10:11:47 INFO - TinderboxPrint: Swap in / out
232,976,384 / 0 10:11:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185582080; Write bytes: 178235392; Read time: 16778; Write time: 378 10:11:47 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36516864; Write bytes: 296373248; Read time: 228; Write time: 1094 10:11:47 INFO - Running post-run listener: _upload_blobber_files 10:11:47 INFO - Blob upload gear active. 10:11:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:47 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:47 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:47 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:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:49 INFO - (blobuploader) - INFO - Done attempting. 10:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:50 INFO - (blobuploader) - INFO - Done attempting. 10:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:52 INFO - (blobuploader) - INFO - Done attempting. 10:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:52 INFO - Return code: 0 10:11:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57ec487146403aa2834e3dcb1ce6344399b0280634e71b1802dd8a45307c74229f9a5c51f78b8cb3f354083af990b2519958902c68823221cfc7e3170be2ae1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d6150eb0658589585d06270acaa56f084010609c5f86b86a7062bab447ee8d3544ec3a5c3a808d5693971b3cf4d582dab4e0fdc57e607fad84e64465cec3c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af7bc82432b8d37c791b8c27c9d512da984ba7d542657105e2e85f7e14d1f30eed583665a129e5f9eb186d3837fa5b709abb08f4797275f3039eb885ed746e3"} 10:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:52 INFO - Contents: 10:11:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57ec487146403aa2834e3dcb1ce6344399b0280634e71b1802dd8a45307c74229f9a5c51f78b8cb3f354083af990b2519958902c68823221cfc7e3170be2ae1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d6150eb0658589585d06270acaa56f084010609c5f86b86a7062bab447ee8d3544ec3a5c3a808d5693971b3cf4d582dab4e0fdc57e607fad84e64465cec3c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af7bc82432b8d37c791b8c27c9d512da984ba7d542657105e2e85f7e14d1f30eed583665a129e5f9eb186d3837fa5b709abb08f4797275f3039eb885ed746e3"} 10:11:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:52 INFO - Copying logs to upload dir... 10:11:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.281931 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-14 10:11:52.931021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:52.934412) ========= 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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/57ec487146403aa2834e3dcb1ce6344399b0280634e71b1802dd8a45307c74229f9a5c51f78b8cb3f354083af990b2519958902c68823221cfc7e3170be2ae1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d6150eb0658589585d06270acaa56f084010609c5f86b86a7062bab447ee8d3544ec3a5c3a808d5693971b3cf4d582dab4e0fdc57e607fad84e64465cec3c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af7bc82432b8d37c791b8c27c9d512da984ba7d542657105e2e85f7e14d1f30eed583665a129e5f9eb186d3837fa5b709abb08f4797275f3039eb885ed746e3"} 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.010992 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/57ec487146403aa2834e3dcb1ce6344399b0280634e71b1802dd8a45307c74229f9a5c51f78b8cb3f354083af990b2519958902c68823221cfc7e3170be2ae1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d6150eb0658589585d06270acaa56f084010609c5f86b86a7062bab447ee8d3544ec3a5c3a808d5693971b3cf4d582dab4e0fdc57e607fad84e64465cec3c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af7bc82432b8d37c791b8c27c9d512da984ba7d542657105e2e85f7e14d1f30eed583665a129e5f9eb186d3837fa5b709abb08f4797275f3039eb885ed746e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:52.968025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:52.968349) ========= 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.gUZlVLmzqV/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.J2JPKLDYLS/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005043 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:11:53.016726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:53.017055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:11:53.017381) ========= ========= Total master_lag: 0.17 =========