builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1484761321.39 results: success (0) buildid: 20170118070526 builduid: 7212bf537d5f40359209ad65b3ca1b15 revision: df64cba2a9edf6b8046f9e7e63dc959bff63c419 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.387200) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.387764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.388093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.413623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.414009) ========= 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.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 09:42:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.7M=0.001s 2017-01-18 09:42:01 (20.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.579780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.580149) ========= 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.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.020335 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:01.628866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 09:42:01.629263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev df64cba2a9edf6b8046f9e7e63dc959bff63c419 --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 df64cba2a9edf6b8046f9e7e63dc959bff63c419 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 09:42:01,703 truncating revision to first 12 chars 2017-01-18 09:42:01,704 Setting DEBUG logging. 2017-01-18 09:42:01,704 attempt 1/10 2017-01-18 09:42:01,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/df64cba2a9ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 09:42:02,377 unpacking tar archive at: mozilla-beta-df64cba2a9ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921049 ========= master_lag: 0.73 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 09:42:03.276817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:03.277217) ========= script_repo_revision: df64cba2a9edf6b8046f9e7e63dc959bff63c419 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:03.277630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:03.277920) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 09:42:03.299104) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-01-18 09:42:03.299488) ========= /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.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:03 INFO - MultiFileLogger online at 20170118 09:42:03 in /builds/slave/test 09:42:03 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:42:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:03 INFO - {'append_to_log': False, 09:42:03 INFO - 'base_work_dir': '/builds/slave/test', 09:42:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:42:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:03 INFO - 'branch': 'Mozilla-Beta', 09:42:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:03 INFO - 'config_files': ('talos/mac_config.py',), 09:42:03 INFO - 'default_actions': ('clobber', 09:42:03 INFO - 'read-buildbot-config', 09:42:03 INFO - 'download-and-extract', 09:42:03 INFO - 'populate-webroot', 09:42:03 INFO - 'create-virtualenv', 09:42:03 INFO - 'install', 09:42:03 INFO - 'run-tests'), 09:42:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:03 INFO - 'download_minidump_stackwalk': True, 09:42:03 INFO - 'download_symbols': 'ondemand', 09:42:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:03 INFO - 'installer_path': 'installer.exe', 09:42:03 INFO - 'log_level': 'info', 09:42:03 INFO - 'log_name': 'talos', 09:42:03 INFO - 'log_to_console': True, 09:42:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:42:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:42:03 INFO - 'opt_config_files': (), 09:42:03 INFO - 'pip_index': False, 09:42:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:42:03 INFO - 'cmd': ('bash', 09:42:03 INFO - '-c', 09:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:42:03 INFO - 'enabled': True, 09:42:03 INFO - 'halt_on_failure': False, 09:42:03 INFO - 'name': 'check_screen_resolution'},), 09:42:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:42:03 INFO - 'cmd': ('bash', 09:42:03 INFO - '-c', 09:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:42:03 INFO - 'enabled': True, 09:42:03 INFO - 'halt_on_failure': False, 09:42:03 INFO - 'name': 'check_screen_resolution'},), 09:42:03 INFO - 'run_cmd_checks_enabled': True, 09:42:03 INFO - 'sps_profile': False, 09:42:03 INFO - 'sps_profile_interval': 0, 09:42:03 INFO - 'suite': 'dromaeojs', 09:42:03 INFO - 'system_bits': '32', 09:42:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:03 INFO - 'title': 't-yosemite-r7-0104', 09:42:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:03 INFO - 'use_talos_json': True, 09:42:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:03 INFO - 'work_dir': 'build'} 09:42:03 INFO - [mozharness: 2017-01-18 17:42:03.494431Z] Running clobber step. 09:42:03 INFO - Running pre-action listener: _resource_record_pre_action 09:42:03 INFO - Running main action method: clobber 09:42:03 INFO - rmtree: /builds/slave/test/build 09:42:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:04 INFO - Running post-action listener: _resource_record_post_action 09:42:04 INFO - [mozharness: 2017-01-18 17:42:04.461294Z] Finished clobber step (success) 09:42:04 INFO - [mozharness: 2017-01-18 17:42:04.461427Z] Running read-buildbot-config step. 09:42:04 INFO - Running pre-action listener: _resource_record_pre_action 09:42:04 INFO - Running main action method: read_buildbot_config 09:42:04 INFO - Using buildbot properties: 09:42:04 INFO - { 09:42:04 INFO - "project": "", 09:42:04 INFO - "product": "firefox", 09:42:04 INFO - "script_repo_revision": "production", 09:42:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:42:04 INFO - "repository": "", 09:42:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:42:04 INFO - "buildid": "20170118070526", 09:42:04 INFO - "pgo_build": "False", 09:42:04 INFO - "basedir": "/builds/slave/test", 09:42:04 INFO - "buildnumber": 7, 09:42:04 INFO - "slavename": "t-yosemite-r7-0104", 09:42:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:42:04 INFO - "platform": "yosemite_r7", 09:42:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:42:04 INFO - "branch": "mozilla-beta", 09:42:04 INFO - "repo_path": "releases/mozilla-beta", 09:42:04 INFO - "revision": "df64cba2a9edf6b8046f9e7e63dc959bff63c419", 09:42:04 INFO - "stage_platform": "macosx64", 09:42:04 INFO - "builduid": "7212bf537d5f40359209ad65b3ca1b15", 09:42:04 INFO - "slavebuilddir": "test" 09:42:04 INFO - } 09:42:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:42:04 INFO - Running post-action listener: _resource_record_post_action 09:42:04 INFO - [mozharness: 2017-01-18 17:42:04.464880Z] Finished read-buildbot-config step (success) 09:42:04 INFO - [mozharness: 2017-01-18 17:42:04.465021Z] Running download-and-extract step. 09:42:04 INFO - Running pre-action listener: _resource_record_pre_action 09:42:04 INFO - Running main action method: download_and_extract 09:42:04 INFO - mkdir: /builds/slave/test/build/tests 09:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:04 INFO - trying https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:42:04 INFO - Downloading https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/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:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/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:42:05 INFO - Downloaded 1165 bytes. 09:42:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:42:05 INFO - Using the following test package requirements: 09:42:05 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:42:05 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:42:05 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:42:05 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:42:05 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:42:05 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:42:05 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:42:05 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:42:05 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:42:05 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:42:05 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:42:05 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:42:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:42:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:42:05 INFO - Fetch https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:42:06 INFO - Expected file size: 16236155 09:42:13 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:42:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:42:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:42:13 INFO - Fetch https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:42:13 INFO - Expected file size: 16236155 09:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:42:20 INFO - Expected file size: 14414089 09:42:21 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:42:21 INFO - trying https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/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:42:23 INFO - Downloaded 86169701 bytes. 09:42:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:42:23 INFO - mkdir: /builds/slave/test/properties 09:42:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:23 INFO - Contents: 09:42:23 INFO - build_url:https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:42:24 INFO - Running post-action listener: _resource_record_post_action 09:42:24 INFO - Running post-action listener: set_extra_try_arguments 09:42:24 INFO - [mozharness: 2017-01-18 17:42:24.396460Z] Finished download-and-extract step (success) 09:42:24 INFO - [mozharness: 2017-01-18 17:42:24.396583Z] Running populate-webroot step. 09:42:24 INFO - Running pre-action listener: _resource_record_pre_action 09:42:24 INFO - Running main action method: populate_webroot 09:42:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:24 INFO - '--tppagecycles', 09:42:24 INFO - '7'], 09:42:24 INFO - 'tests': ['tsvgm']}}, 09:42:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['damp', 'tps']}, 09:42:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'tests': ['damp', 'tps']}, 09:42:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['dromaeo_dom']}, 09:42:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['basic_compositor_video']}, 09:42:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:42:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['a11yr', 09:42:24 INFO - 'ts_paint', 09:42:24 INFO - 'tpaint', 09:42:24 INFO - 'sessionrestore', 09:42:24 INFO - 'sessionrestore_no_auto_restore', 09:42:24 INFO - 'tabpaint']}, 09:42:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['tsvgx', 09:42:24 INFO - 'tsvgr_opacity', 09:42:24 INFO - 'tart', 09:42:24 INFO - 'tscrollx', 09:42:24 INFO - 'cart']}, 09:42:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:24 INFO - 'tsvgr_opacity', 09:42:24 INFO - 'tart', 09:42:24 INFO - 'tscrollx', 09:42:24 INFO - 'cart']}, 09:42:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'talos_options': ['--disable-e10s'], 09:42:24 INFO - 'tests': ['tp5o']}, 09:42:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'tests': ['tp5o']}, 09:42:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'talos_options': ['--disable-e10s', 09:42:24 INFO - '--xperf_path', 09:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:24 INFO - 'tests': ['tp5n']}, 09:42:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:24 INFO - 'talos_options': ['--xperf_path', 09:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:24 INFO - 'tests': ['tp5n']}}, 09:42:24 INFO - 'talos.zip': {'path': '', 09:42:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:24 INFO - Running post-action listener: _resource_record_post_action 09:42:24 INFO - [mozharness: 2017-01-18 17:42:24.415785Z] Finished populate-webroot step (success) 09:42:24 INFO - [mozharness: 2017-01-18 17:42:24.415904Z] Running create-virtualenv step. 09:42:24 INFO - Running pre-action listener: _resource_record_pre_action 09:42:24 INFO - Running main action method: create_virtualenv 09:42:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:24 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:42:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:24 INFO - Using real prefix '/tools/python27' 09:42:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:28 INFO - Installing pip.................done. 09:42:28 INFO - Return code: 0 09:42:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42: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:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42: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', 'pip>=1.5'] in /builds/slave/test/build 09:42: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 pip>=1.5 09:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:28 INFO - 'HOME': '/Users/cltbld', 09:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:28 INFO - 'LOGNAME': 'cltbld', 09:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:28 INFO - 'MOZ_NO_REMOTE': '1', 09:42:28 INFO - 'NO_EM_RESTART': '1', 09:42:28 INFO - 'PAGER': '/bin/cat', 09:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:28 INFO - 'PWD': '/builds/slave/test', 09:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:28 INFO - 'SHELL': '/bin/bash', 09:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:28 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:28 INFO - 'USER': 'cltbld', 09:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:28 INFO - 'XPC_FLAGS': '0x0', 09:42:28 INFO - 'XPC_SERVICE_NAME': '0', 09:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:28 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:42:28 INFO - Cleaning up... 09:42:28 INFO - Return code: 0 09:42:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42: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:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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', '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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:42: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 psutil>=3.1.1 09:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:28 INFO - 'HOME': '/Users/cltbld', 09:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:28 INFO - 'LOGNAME': 'cltbld', 09:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:28 INFO - 'MOZ_NO_REMOTE': '1', 09:42:28 INFO - 'NO_EM_RESTART': '1', 09:42:28 INFO - 'PAGER': '/bin/cat', 09:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:28 INFO - 'PWD': '/builds/slave/test', 09:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:28 INFO - 'SHELL': '/bin/bash', 09:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:28 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:28 INFO - 'USER': 'cltbld', 09:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:28 INFO - 'XPC_FLAGS': '0x0', 09:42:28 INFO - 'XPC_SERVICE_NAME': '0', 09:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:28 INFO - Downloading/unpacking psutil>=3.1.1 09:42: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:42: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:42: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:42: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:42: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:42: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:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:31 INFO - Installing collected packages: psutil 09:42:31 INFO - Running setup.py install for psutil 09:42:32 INFO - building 'psutil._psutil_osx' extension 09:42:32 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:42:32 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:42:32 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:42:32 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:42:32 INFO - building 'psutil._psutil_posix' extension 09:42:32 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:42:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:42:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:42:32 INFO - ^ 09:42:32 INFO - 1 warning generated. 09:42:32 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:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:32 INFO - Successfully installed psutil 09:42:32 INFO - Cleaning up... 09:42:32 INFO - Return code: 0 09:42:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42:32 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:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:32 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:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:32 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:32 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:42:32 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:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:32 INFO - 'HOME': '/Users/cltbld', 09:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:32 INFO - 'LOGNAME': 'cltbld', 09:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:32 INFO - 'MOZ_NO_REMOTE': '1', 09:42:32 INFO - 'NO_EM_RESTART': '1', 09:42:32 INFO - 'PAGER': '/bin/cat', 09:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:32 INFO - 'PWD': '/builds/slave/test', 09:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:32 INFO - 'SHELL': '/bin/bash', 09:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:32 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:32 INFO - 'USER': 'cltbld', 09:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:32 INFO - 'XPC_FLAGS': '0x0', 09:42:32 INFO - 'XPC_SERVICE_NAME': '0', 09:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:33 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:42:33 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:42:33 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:42:33 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:42:33 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:42:33 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:42:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:34 INFO - Installing collected packages: mozsystemmonitor 09:42:34 INFO - Running setup.py install for mozsystemmonitor 09:42:34 INFO - Successfully installed mozsystemmonitor 09:42:34 INFO - Cleaning up... 09:42:34 INFO - Return code: 0 09:42:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:34 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:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:34 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:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:34 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:34 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:42:34 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:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:34 INFO - 'HOME': '/Users/cltbld', 09:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:34 INFO - 'LOGNAME': 'cltbld', 09:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:34 INFO - 'MOZ_NO_REMOTE': '1', 09:42:34 INFO - 'NO_EM_RESTART': '1', 09:42:34 INFO - 'PAGER': '/bin/cat', 09:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:34 INFO - 'PWD': '/builds/slave/test', 09:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:34 INFO - 'SHELL': '/bin/bash', 09:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:34 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:34 INFO - 'USER': 'cltbld', 09:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:34 INFO - 'XPC_FLAGS': '0x0', 09:42:34 INFO - 'XPC_SERVICE_NAME': '0', 09:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:42: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:42: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:42: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:42: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:42: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:42: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:42:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:38 INFO - warning: no files found matching '*.txt' 09:42:38 INFO - no previously-included directories found matching 'build' 09:42:38 INFO - no previously-included directories found matching 'dist' 09:42:38 INFO - no previously-included directories found matching '.git*' 09:42:38 INFO - Installing collected packages: jsonschema, functools32 09:42:38 INFO - Running setup.py install for functools32 09:42:38 INFO - warning: no files found matching '*.txt' 09:42:38 INFO - no previously-included directories found matching 'build' 09:42:38 INFO - no previously-included directories found matching 'dist' 09:42:38 INFO - no previously-included directories found matching '.git*' 09:42:38 INFO - Successfully installed jsonschema functools32 09:42:38 INFO - Cleaning up... 09:42:38 INFO - Return code: 0 09:42:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:38 INFO - 'HOME': '/Users/cltbld', 09:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:38 INFO - 'LOGNAME': 'cltbld', 09:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:38 INFO - 'MOZ_NO_REMOTE': '1', 09:42:38 INFO - 'NO_EM_RESTART': '1', 09:42:38 INFO - 'PAGER': '/bin/cat', 09:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:38 INFO - 'PWD': '/builds/slave/test', 09:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:38 INFO - 'SHELL': '/bin/bash', 09:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:38 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:38 INFO - 'USER': 'cltbld', 09:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:38 INFO - 'XPC_FLAGS': '0x0', 09:42:38 INFO - 'XPC_SERVICE_NAME': '0', 09:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:38 INFO - Cleaning up... 09:42:38 INFO - Return code: 0 09:42:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:38 INFO - 'HOME': '/Users/cltbld', 09:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:38 INFO - 'LOGNAME': 'cltbld', 09:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:38 INFO - 'MOZ_NO_REMOTE': '1', 09:42:38 INFO - 'NO_EM_RESTART': '1', 09:42:38 INFO - 'PAGER': '/bin/cat', 09:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:38 INFO - 'PWD': '/builds/slave/test', 09:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:38 INFO - 'SHELL': '/bin/bash', 09:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:38 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:38 INFO - 'USER': 'cltbld', 09:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:38 INFO - 'XPC_FLAGS': '0x0', 09:42:38 INFO - 'XPC_SERVICE_NAME': '0', 09:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:42: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:42: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:42: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:42: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:42: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:42: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:42:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:42 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:42:42 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:42:42 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:42:42 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:42:42 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:42:42 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:42:42 INFO - Downloading docopt-0.6.1.tar.gz 09:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:42 INFO - Running setup.py install for blobuploader 09:42:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:42 INFO - Running setup.py install for requests 09:42:43 INFO - Running setup.py install for docopt 09:42:43 INFO - Successfully installed blobuploader requests docopt 09:42:43 INFO - Cleaning up... 09:42:43 INFO - Return code: 0 09:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:43 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:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 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:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:43 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:42:43 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:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:43 INFO - 'HOME': '/Users/cltbld', 09:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:43 INFO - 'LOGNAME': 'cltbld', 09:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:43 INFO - 'MOZ_NO_REMOTE': '1', 09:42:43 INFO - 'NO_EM_RESTART': '1', 09:42:43 INFO - 'PAGER': '/bin/cat', 09:42:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:43 INFO - 'PWD': '/builds/slave/test', 09:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:43 INFO - 'SHELL': '/bin/bash', 09:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:43 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:43 INFO - 'USER': 'cltbld', 09:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:43 INFO - 'XPC_FLAGS': '0x0', 09:42:43 INFO - 'XPC_SERVICE_NAME': '0', 09:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gsCbTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-bjmm02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-dXW6AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-V13TP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7lJZjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-yAK8B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-pXdrlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NU05_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-jvlopB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-LBrbGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-hwRogr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-RroJPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-kOljJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-HvcgIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-h6FoOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-HiW47u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:45 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-B0nQws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:45 INFO - Running setup.py install for manifestparser 09:42:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozcrash 09:42:46 INFO - Running setup.py install for mozdebug 09:42:46 INFO - Running setup.py install for mozdevice 09:42:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozfile 09:42:46 INFO - Running setup.py install for mozhttpd 09:42:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozinfo 09:42:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozInstall 09:42:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozleak 09:42:47 INFO - Running setup.py install for mozlog 09:42:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Running setup.py install for moznetwork 09:42:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Running setup.py install for mozprocess 09:42:47 INFO - Running setup.py install for mozprofile 09:42:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Running setup.py install for mozrunner 09:42:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Running setup.py install for mozscreenshot 09:42:48 INFO - Running setup.py install for moztest 09:42:48 INFO - Running setup.py install for mozversion 09:42:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:48 INFO - Cleaning up... 09:42:48 INFO - Return code: 0 09:42:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:48 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:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:48 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:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:48 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:48 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:42:48 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:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:48 INFO - 'HOME': '/Users/cltbld', 09:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:48 INFO - 'LOGNAME': 'cltbld', 09:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:48 INFO - 'MOZ_NO_REMOTE': '1', 09:42:48 INFO - 'NO_EM_RESTART': '1', 09:42:48 INFO - 'PAGER': '/bin/cat', 09:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:48 INFO - 'PWD': '/builds/slave/test', 09:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:48 INFO - 'SHELL': '/bin/bash', 09:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:48 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:48 INFO - 'USER': 'cltbld', 09:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:48 INFO - 'XPC_FLAGS': '0x0', 09:42:48 INFO - 'XPC_SERVICE_NAME': '0', 09:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-QMLwZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Hevnfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-FTp3sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ZV7LsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-_F98LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-KjE6OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-F1Tzqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-kNvrgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-oOlA8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-3wSfLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-UedbYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-65JXmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Vi9WJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:50 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-_zjobI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:50 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-WGqBfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:50 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-kojO4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:50 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7qkHrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:50 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:42:50 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:42:50 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:42:50 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:42:50 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:42:50 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:42:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - Downloading blessings-1.6.tar.gz 09:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:53 INFO - Installing collected packages: blessings 09:42:53 INFO - Running setup.py install for blessings 09:42:53 INFO - Successfully installed blessings 09:42:53 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:53 INFO - Reading from file tmpfile_stdout 09:42:53 INFO - Current package versions: 09:42:53 INFO - blessings == 1.6 09:42:53 INFO - blobuploader == 1.2.4 09:42:53 INFO - docopt == 0.6.1 09:42:53 INFO - functools32 == 3.2.3-2 09:42:53 INFO - jsonschema == 2.5.1 09:42:53 INFO - manifestparser == 1.1 09:42:53 INFO - mozInstall == 1.12 09:42:53 INFO - mozcrash == 0.17 09:42:53 INFO - mozdebug == 0.1 09:42:53 INFO - mozdevice == 0.48 09:42:53 INFO - mozfile == 1.2 09:42:53 INFO - mozhttpd == 0.7 09:42:53 INFO - mozinfo == 0.9 09:42:53 INFO - mozleak == 0.1 09:42:53 INFO - mozlog == 3.4 09:42:53 INFO - moznetwork == 0.27 09:42:53 INFO - mozprocess == 0.23 09:42:53 INFO - mozprofile == 0.28 09:42:53 INFO - mozrunner == 6.12 09:42:53 INFO - mozscreenshot == 0.1 09:42:53 INFO - mozsystemmonitor == 0.3 09:42:53 INFO - moztest == 0.7 09:42:53 INFO - mozversion == 1.4 09:42:53 INFO - psutil == 3.1.1 09:42:53 INFO - requests == 1.2.3 09:42:53 INFO - wsgiref == 0.1.2 09:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:53 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:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 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:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:53 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:42:53 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:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:53 INFO - 'HOME': '/Users/cltbld', 09:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:53 INFO - 'LOGNAME': 'cltbld', 09:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:53 INFO - 'MOZ_NO_REMOTE': '1', 09:42:53 INFO - 'NO_EM_RESTART': '1', 09:42:53 INFO - 'PAGER': '/bin/cat', 09:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:53 INFO - 'PWD': '/builds/slave/test', 09:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:53 INFO - 'SHELL': '/bin/bash', 09:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:53 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:53 INFO - 'USER': 'cltbld', 09:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:53 INFO - 'XPC_FLAGS': '0x0', 09:42:53 INFO - 'XPC_SERVICE_NAME': '0', 09:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:53 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:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 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:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 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 0x102b5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ad2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112de87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, '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.Uhg8c82plS/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.zzWlrDmmVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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:42:53 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:42:53 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:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:53 INFO - 'HOME': '/Users/cltbld', 09:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:53 INFO - 'LOGNAME': 'cltbld', 09:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:53 INFO - 'MOZ_NO_REMOTE': '1', 09:42:53 INFO - 'NO_EM_RESTART': '1', 09:42:53 INFO - 'PAGER': '/bin/cat', 09:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:53 INFO - 'PWD': '/builds/slave/test', 09:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:53 INFO - 'SHELL': '/bin/bash', 09:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:42:53 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:53 INFO - 'USER': 'cltbld', 09:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:53 INFO - 'XPC_FLAGS': '0x0', 09:42:53 INFO - 'XPC_SERVICE_NAME': '0', 09:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:42:54 INFO - Cleaning up... 09:42:54 INFO - Return code: 0 09:42:54 INFO - Running post-action listener: _resource_record_post_action 09:42:54 INFO - Running post-action listener: _start_resource_monitoring 09:42:54 INFO - Starting resource monitoring. 09:42:54 INFO - [mozharness: 2017-01-18 17:42:54.294643Z] Finished create-virtualenv step (success) 09:42:54 INFO - [mozharness: 2017-01-18 17:42:54.295661Z] Running install step. 09:42:54 INFO - Running pre-action listener: _resource_record_pre_action 09:42:54 INFO - Running main action method: install 09:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:54 INFO - Reading from file tmpfile_stdout 09:42:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:54 INFO - Reading from file tmpfile_stdout 09:42:54 INFO - Output received: 09:42:54 INFO - Usage: mozinstall [options] installer 09:42:54 INFO - Options: 09:42:54 INFO - -h, --help show this help message and exit 09:42:54 INFO - -d DEST, --destination=DEST 09:42:54 INFO - Directory to install application into. [default: 09:42:54 INFO - "/builds/slave/test"] 09:42:54 INFO - --app=APP Application being installed. [default: firefox] 09:42:54 INFO - mkdir: /builds/slave/test/build/application 09:42:54 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:42:54 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:43:16 INFO - Reading from file tmpfile_stdout 09:43:16 INFO - Output received: 09:43:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:43:16 INFO - Running post-action listener: _resource_record_post_action 09:43:16 INFO - [mozharness: 2017-01-18 17:43:16.982220Z] Finished install step (success) 09:43:16 INFO - [mozharness: 2017-01-18 17:43:16.982372Z] Running run-tests step. 09:43:16 INFO - Running pre-action listener: _resource_record_pre_action 09:43:16 INFO - Running main action method: run_tests 09:43:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:16 INFO - 2017-01-18 09:43:16.997 screenresolution[2134:16061] starting screenresolution argv=screenresolution get 09:43:17 INFO - 2017-01-18 09:43:17.000 screenresolution[2134:16061] Display 0: 1600x1200x32@60 09:43:17 INFO - 2017-01-18 09:43:17.006 screenresolution[2135:16064] starting screenresolution argv=screenresolution list 09:43:17 INFO - Available Modes on Display 0 09:43:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:17 INFO - Intel Iris: 09:43:17 INFO - Chipset Model: Intel Iris 09:43:17 INFO - Type: GPU 09:43:17 INFO - Bus: Built-In 09:43:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:17 INFO - Vendor: Intel (0x8086) 09:43:17 INFO - Device ID: 0x0a2e 09:43:17 INFO - Revision ID: 0x0009 09:43:17 INFO - Displays: 09:43:17 INFO - Display: 09:43:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:17 INFO - Display Serial Number: 1600x1200 60 09:43:17 INFO - Main Display: Yes 09:43:17 INFO - Mirror: Off 09:43:17 INFO - Online: Yes 09:43:17 INFO - Rotation: Supported 09:43:17 INFO - Return code: 0 09:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:17 INFO - Python 2.7.3 09:43:17 INFO - Return code: 0 09:43:17 INFO - grabbing minidump binary from tooltool 09:43:17 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:43:17 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 0x102970d30>, '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 0x1027d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102968b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:17 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:43:17 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:43:17 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:43:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:17 INFO - Return code: 0 09:43:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:43:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:43:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:17 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/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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:43:17 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/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Uhg8c82plS/Render', 09:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:17 INFO - 'HOME': '/Users/cltbld', 09:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:17 INFO - 'LOGNAME': 'cltbld', 09:43:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:17 INFO - 'MOZ_NO_REMOTE': '1', 09:43:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:17 INFO - 'NO_EM_RESTART': '1', 09:43:17 INFO - 'PAGER': '/bin/cat', 09:43:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:17 INFO - 'PWD': '/builds/slave/test', 09:43:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:17 INFO - 'SHELL': '/bin/bash', 09:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zzWlrDmmVG/Listeners', 09:43:17 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:17 INFO - 'USER': 'cltbld', 09:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:17 INFO - 'XPC_FLAGS': '0x0', 09:43:17 INFO - 'XPC_SERVICE_NAME': '0', 09:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:17 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/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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:43:17 INFO - mozversion application_buildid: 20170118070526 09:43:17 INFO - mozversion application_changeset: df64cba2a9edf6b8046f9e7e63dc959bff63c419 09:43:17 INFO - mozversion application_display_name: Firefox 09:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:17 INFO - mozversion application_name: Firefox 09:43:17 INFO - mozversion application_remotingname: firefox 09:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:17 INFO - mozversion application_vendor: Mozilla 09:43:17 INFO - mozversion application_version: 51.0 09:43:17 INFO - mozversion platform_buildid: 20170118070526 09:43:17 INFO - mozversion platform_changeset: df64cba2a9edf6b8046f9e7e63dc959bff63c419 09:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:17 INFO - mozversion platform_version: 51.0 09:43:17 INFO - using testdate: 1484761397 09:43:17 INFO - actual date: 1484761397 09:43:17 INFO - starting webserver on 'localhost:49487' 09:43:17 INFO - SUITE-START | Running 2 tests 09:43:17 INFO - TEST-START | dromaeo_css 09:43:17 INFO - operating with platform_type : mac_ 09:43:17 INFO - Initialising browser for dromaeo_css test... 09:43:17 INFO - TEST-INFO | started process 2145 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpjzZAxl/profile http://localhost:49487/getInfo.html) 09:43:20 INFO - PROCESS | 2145 | __metrics Screen width/height:1600/1200 09:43:20 INFO - PROCESS | 2145 | colorDepth:24 09:43:20 INFO - PROCESS | 2145 | Browser inner width/height: 1024/689 09:43:20 INFO - PROCESS | 2145 | __metrics 09:43:20 INFO - PROCESS | 2145 | 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:43:20 INFO - PROCESS | 2145 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:20 INFO - TEST-INFO | 2145: exit 0 09:43:20 INFO - Browser initialized. 09:43:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:20 INFO - TEST-INFO | started process 2148 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpjzZAxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:32 INFO - PROCESS | 2148 | RSS: Main: 169062400 09:43:32 INFO - PROCESS | 2148 | 09:44:24 INFO - PROCESS | 2148 | 1484761464395 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:46:34 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49487/tests/dromaeo/cssquery-ext.html) 09:46:36 INFO - PROCESS | 2148 | RSS: Main: 283729920 09:46:36 INFO - PROCESS | 2148 | 09:49:38 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-ext.html (next: http://localhost:49487/tests/dromaeo/cssquery-jquery.html) 09:49:39 INFO - PROCESS | 2148 | RSS: Main: 303112192 09:49:39 INFO - PROCESS | 2148 | 09:52:41 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49487/tests/dromaeo/cssquery-mootools.html) 09:52:42 INFO - PROCESS | 2148 | RSS: Main: 300298240 09:52:42 INFO - PROCESS | 2148 | 09:55:44 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49487/tests/dromaeo/cssquery-prototype.html) 09:55:45 INFO - PROCESS | 2148 | RSS: Main: 265195520 09:55:45 INFO - PROCESS | 2148 | 09:58:48 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49487/tests/dromaeo/cssquery-yui.html) 09:58:49 INFO - PROCESS | 2148 | RSS: Main: 261558272 09:58:49 INFO - PROCESS | 2148 | 10:01:51 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-yui.html (next: http://localhost:49487/tests/dromaeo/cssquery-dojo.html) 10:01:52 INFO - PROCESS | 2148 | RSS: Main: 342548480 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | __start_tp_report 10:01:52 INFO - PROCESS | 2148 | _x_x_mozilla_page_load 10:01:52 INFO - PROCESS | 2148 | _x_x_mozilla_page_load_details 10:01:52 INFO - PROCESS | 2148 | |i|pagename|runs| 10:01:52 INFO - PROCESS | 2148 | |0;dojo.html;3341.3317336532696;3349.447341188704;3377.0881861897274;3385.3567822113782;3420.1107711994873;5620.747066382012;5676.772929082842;5683.829485115442;5747.339056008565;5761.740721667525;5667.631603945751;5735.942640573603;5736;5751.626144300618;5759.963206622806;5193.948060519384;5200.895982080366;5209.505097015796;5240.423553409122;5282;5116.923246151311;5163.173892177252;5163.7159956202395;5247.737613119348;5314.335708036496;5251.658642188246;5253.57971362292;5265.605079619025;5267.789288428477;5276.393214780292;5249.8950020999555;5265.447128051538;5269.525742683177;5277.12927366984;5281.603879709037;5102.770375333119;5168.974155129238;5194.298769666085;5214.217867319894;5220.634555581111;5728.5417166626985;5759.020966435716;5777.768889244425;5828.2131912191735;5876.030454974924;6114.633122012693;6125.203723515914;6127.264728232596;6128.264608246995;6137.2635283765785;6110.297315808694;6127.31169931711;6132.877342453171;6140.785072522485;6167.537434692371;4808.591269742111;5618.297712785902;5631.267935168402;5696.971515142398;5704.914426283609;6246.593971391845;6250.718717657716;6255;6258.906116408258;6296.464800492009;5873.295204575478;5926.2295901532525;6078.0882867569335;6087.512998960073;6108.755649774048;5192.247124166975;6097.7865774697675;6133.82435864808;6184.6598437086395;6221.968890155611;6108;6112.2970858351855;6113.20528331323;6131.938680613226;6132.386102851662;5946.910796338058;6162.414570615784;6166.568340216142;6170.876582468325;6173.475254603409;4831.106245344622;4847.903041939212;4908.460069392364;4912.557869791736;4923.950760492421;4367.388565600819;4373.846915358011;4388.473383193973;4390.07808360248;4415.050764085737;5728.770849165987;5733.684647344353;5734;5749.252597162425;5752.597318187687;6013.398660134039;6090.969545152335;6100.298465676416;6114.297368146176;6173.47525460332;5784.652920824764;5797.072468405035;5812.186293918855;5824.88350232993;5826.679532625746;5339.5728341732565;5396.514313711707;5399;5407.405185429599;5415.783368665288;6197.81406557804;6252.093446450148;6262.029385445263;6285.1515045470105;6297.811065668037;6156.26124865019;6215.036669316263;6229.003359462465;6242.65665388408;6254.655993920378;6202.34875338083;6260.812175634738;6260.968695156495;6265.498760099273;6286.308506064238;5959.791407300897;6083.756649733961;6139.72371243304;6154.476869466145;6163.8150855474405;6106.2061931948565;6144.10910417978;6224.284207316216;6238.75044998195;6254.405831446005;4960.677555958851;5772.855678608068;6089.330173680803;6091.395865947327;6134.754609815557;5989.1615173874825;5998.670073146019;6010.939890601038;6027.065804800263;6040.2147720797775;5752;5792.4497172768515;5851.561132914963;5874.500667443315;5880.617759845596;6009.7295621698;6014.759409623566;6018.699065046642;6027.668478233739;6047.971844786485;5711.057675483665;5793.739281732416;5842.766289348378;5856.326522449803;5859.853503662443 10:01:52 INFO - PROCESS | 2148 | |1;ext.html;494.2832892306157;526.4524894110125;528.5744975294886;546.3416583017464;558.2742434834714;32101;41711.748647540546;43318.35022474665;43456.56543434565;45705.542944570625;44446;44836;45038.54961450385;45078.32382514265;45095.77452112743;9959.701208963743;10145.391276523394;10146.84779728301;10159.949200253988;10179.643712470064;9259.95370023149;9458.054194580556;9459.62161513542;9574.99462556432;9579.473128977937;12297.3236471994;12547.811782823264;12554.246745195273;12654.873451265508;12714.61856144317;12314.38428078597;12390.938045309806;12420.378981050912;12439.626811195678;12479.251244925334;12189.878101218963;12247.326397048158;12254.877451225462;12276.631701048982;12286.938565307206;41874.1625167498;42113;42144.94637634053;42162.57837421617;42235.57764422378;3390.8304584770663;3538.221591249921;3675.2649470105816;3983.940240896389;4079.224947260011;29764.70412774469;30397.392052159055;31225.687743122504;32450.350992980246;32838;3423.400904841668;3433.5879694436826;3434.227298857737;3487.7035451986612;3566.251087271676;532611;540644;542444;543091;543178;33899.661003390145;34605.82697086498;34745.478817817755;60632.09051864137;61167.6941615298;36280.45579316312;36334;36434.63565364313;36453.45319820205;36497.27005459876;15540.84459155394;15649.217539122998;15663.608409789618;15665.921670391803;15720.528384148494;13205.801912971314;13286.867131328756;13307.334633268492;13310;13336.866631333756;7425.888611670829;7539.0576177977755;7838.059432868093;7944.245296696805;8012.318952888953;3315.5689760331;3347.4811404232382;3347.598288205431;3380.611229708615;3387.542681737934;936.6440752514137;973.2019743810008;1009.333839665817;1039.6309310194922;1073.736934451049;30637.540436893465;30672.38655226883;30722.846385767927;31101.688983109878;31211.531827022613;1081.789051135021;1091.24158709696;1097.4786976186408;1151.6717735445359;1200.6578125234266;15208.847911520965;15655.060696358254;16043.197840107949;16198.17776716797;16504.25730842115;713037;714153;714652;715419;716960;60492;61207.08189377163;61341;61372;61592.69203654043;1379.2552021908257;1411.9435222591187;1421.9004669673232;1426.985730142706;1433.720424517209;29216.83132674669;29892.402151957274;30189;30574.84712576423;30636.78858658655;49950.00099997907;50267.74866125646;50316;50407.991840163726;50460.24309635285;596261;597382;598513;599543;601393;26807.463850723267;27182;27213;27239.86380068087;27253.727462725117;48277.793055173905;48295.275570865764;48358.5164148354;49263.01473970572;49758;39105.262631615515;39332;39880.80059599799;40097.39853902252;41385.96535086647;39402.80298598488;39487.60512394839;39562;39774.80675579737;41224;38167.427488587135;38381.80809095937;39108.60891391164;39154;39476.40785388279;33522.66477335196;35033;35471.64528354684;35702.28595428129;35761.28477430385;25696;25796.09713660013;25991;26124.34689132787;26273.86721979416 10:01:52 INFO - PROCESS | 2148 | |2;jquery.html;366.58758896241727;386.82206185154826;386.8452618952419;396.6826538768984;420.87794539583524;15841.524754257376;15936.521904342873;18837;20765.377038688825;20894.37316880496;21205.893970530127;21324.893375533138;21486.89256553719;21691.457713557167;21914.89042554789;5815.069588865782;5973.372795856438;5987.55093367997;5998.7600495980105;6116.052011938156;4323.502797178317;5981.910271345933;6089.421504957022;6095.817125486243;6096.542759293048;4357.847475338348;4373.737575745449;4466.932996005046;4512.684112112153;6605.405513503783;5782.3350314713925;6668.833279168011;6675.165604299486;6675.766348177839;6681.66591670417;5293;5590.385057643656;5638.548916086745;5676.205331253628;5685.289338832646;13428.93285533566;13680.863191368158;19323.710144347846;25598.232053038253;25934.74065259342;2214.3356992902063;2283.897224624879;2286.6570014497793;2389.2832150355;2959.883683166525;9842.60629574816;9863.802723945553;9979.650712225037;10014.298999070068;10342;1865.4776662534512;1885.161103309028;1946.6204090202416;1981.4947188466992;2001.7798042215345;118371.4081429596;124483.3775831115;131374;134684;136708;10933;11326;11594.57959901831;11609.30344179335;11812.88187118135;14735.336909839083;14747.63130921714;14753;14759.966802323948;14800.407983680532;8574.528400937883;8824.867626985471;8833.911660883308;8897.332700047522;8965.372423930263;8776.210141087333;8795.164459376349;8816.250618697482;8958.372913895964;8990.955045224731;3740.5698344690163;4396.208682437128;4513.345564893138;4523;4650.441946966385;1596;1865.3750993417086;1880.511067122558;1925.0952052535285;1931.1792488192461;748.6331697468311;753.8567672142275;860.8665656823202;984.7291994701371;1047.4396198034015;18130.365437209635;20004.299849505198;21444.927753612257;21474.134655762115;21677.132914683552;933.2254228989922;990.1336330710628;999.7650552120245;1030.4796077980573;1089.6785448292774;10906.5092070857;11221.382823944597;11238.38188899602;11246.91931992584;11260.43697815106;629205;636946;642883;643713;646700;89348;119170;121597;126100;131838;987.8370068938544;991.023841516106;1007.5566750629699;1044.535181844072;1046.1369370269558;18772.342967996054;18919.337823176123;19023.33418330352;19471.805281947;19663.901680491505;54561;55493.72253138709;55991.72004139953;56124;56491.71754141203;79130;80402;81366;84378;85013;6869.278725733726;7764.417668674985;7782.416318776001;7801.4929029612895;7863.21367863232;11091.944540277247;11696.941515292368;11729.296242225493;12051.457684404399;12152;8998.775030624287;9034.367594268339;9157.358984870994;9160.35877488596;9287.953560232156;9992.10071093605;10009.5495702695;10039.4478303694;10053.447060411747;10156;10310.07209351132;10310.742231444274;10331.05564914026;10427.113695335678;10525.263231574023;7570.318671319607;7585.506942048749;7788.376929845712;7797.727079552188;7908.920910790818;9855.45794981283;9926.503674816375;10109.848352274576;10210.387376757419;10324.948375258376 10:01:52 INFO - PROCESS | 2148 | |3;mootools.html;1386.7919812028197;1524.2378810594698;1714.90568018759;1867.7198420236955;1905.3902751119647;8557;9080.409773364727;9081.818363632732;9094.272458203337;9103.180713735763;7902.525848449082;8184;8511.489310641366;8798.252148567379;8800.119988001197;2379.0364902214633;2402.267308470916;2403.267003563912;2406.566817972764;2409.4819613783034;2371.21749822559;2376.66726658268;2411.6141417373137;2417.0090262992176;2418.3712234818986;2393.640953856927;2401.795847352977;2407.0251548123038;2418.2745176447083;2420.334408037786;2378.4410663494064;2389.581823180945;2396.5805983952737;2399.4721161344564;2401.363638635763;2374.9881250593635;2389.3429306940557;2394.772496612819;2395.1138078910913;2400.975990240093;8808.735737927873;8923.598438070303;8982.595783189772;8989.37074404792;9010.504422256774;5337.866553336159;5494.560435165177;5496.285482887199;5498.615096943216;5502.119660854244;3577.177249232665;3595.694365978895;3623.2753449310244;3682.926341473182;3688.17016171362;1085.0831047764627;1088.4884104470887;1094.9726256843562;1105.3478447715806;1114.5987444519967;11629.651110466699;11771.117166212569;11771.470283837249;11784.057275417947;11901.583444579484;4364.345348197732;4428.4243048403505;4524.072565124142;4736.3369128322065;4911.901761964741;10055.346402483816;10065;10071;10091.69724908254;10101.19190464761;5307.310049693592;5310.468953104736;5317.042932272228;5324.494173053554;5329.960657671717;4509.210888094571;4573.451185857652;4669.509701481364;4879.219324907997;4955.6531042826655;3540.2565461253425;3964.643182113566;4007.358822588372;4097.303458412018;4130.938035929464;1273.7834568123442;1275.3113318807925;1283.7432513497151;1285.8778416050461;1297.6561211279018;767.4244316762428;841.4068082002296;886.7339798060556;954.1031430455349;958.8705524754208;5532.585056120807;5671.51792097668;5915.674637894957;6015.3383127855905;6236.6258024518675;907.4782000349825;949.5299826585746;974.605284859633;979.3291595257272;1010.0303708439833;3869.980650096788;3964;4063.715539912178;4191.769452680071;4212.326027835532;10494.317869338469;10933.726656833644;10939.671809845717;10941.56233750641;10949.069329106957;10873.891261087289;10884.945575272073;10885.673429797118;10889.455527223607;10901.563937442572;7953.483023603448;8267.503949763033;8319.66721331152;8425;8433.578321083922;5968.253968253968;6057.091436284592;6076.906156891802;6212.9068063978175;6327.525435592257;9864.260180486348;10115.7471063224;10115.848262276219;10129.59481620727;10134.087932086148;9956.004399559986;10195.133413659922;10224.977502249716;10384.065434110664;10389.53247103867;6868.416184624363;7097.858042839218;7382.44631652639;7461.291177338361;7616.7334143304715;8396.832063358577;8585.184407481529;8592.011918629187;8594.441361311494;8596.527191004554;7491.625418728932;7630.369046970797;7640.312371886557;7676.270754278335;7757.185495522889;7370.226126256666;7434.368078713153;7496.737614183696;7516.436267279866;7623.923760762544;7003.5797852129035;7152.856942861218;7160.964195178991;7173.0675012248075;7176;5000.524950129732;5056.949430505648;5103.18349064148;5252.7898884045735;5306.787728490972;5123.28274041627;5128.435872054146;5130.871728206825;5199.71401572902;5205.427402985744 10:01:52 INFO - PROCESS | 2148 | |4;prototype.html;309.96745341739114;317.72358048497813;319.42503493711314;322.735357007254;327.14614855227836;5436.700981446023;5436.891262174754;5439.5104440600335;5443.156310771837;5461.481159289866;5374.838754837361;5376.596755243362;5433.864153396167;5437.429069947658;5437.918431223525;3745.8501659933568;3922.176342967973;4016.799160042001;4066.329055705805;4205.495340559137;3607.350676878161;4113.958860411388;4115.403266526352;4185.665146788265;4211.957880421202;3690.538682664667;4076.164386300801;4107.383892416132;4116.217918595457;4143.08852052548;3167.904962851118;3812.426612036864;4118.855840045584;4138.793060346986;4179.874603761892;3013.3220025494306;3515.207244305397;3522.454019626962;3539.132912436444;3543.5747710274672;5234.502722241381;5257.763400646942;5261.421243663194;5269.104252277084;5272.235525848769;3932.7836968966694;4219.725717828362;4313.029568347129;4337.761423121727;4634.443866736014;4838.830565979254;5157.71632560209;5328.573714102862;5609.49514543693;5642.548596112301;3713.665770080706;3851.4607954886337;3858.421236814472;3867.8009816956833;3874.786886721229;5007.39911210657;5532.529734972532;5878.706684529397;5927.851803704899;5940.2871655401195;3326.7005969462866;3891.377379619247;3958.040769818958;3958.4656071430563;3982.8605998789903;3451.413259745799;3903.5706072332023;4000.7599544027453;4008.2985477541315;4028.8992775180855;4688.57802797743;4688.835890743808;4695.389599352131;4696.319033740157;4712.340272361872;4906.754662266872;5473.343198816088;5765.654060756368;5778.711064446761;5814.534837213013;1162.645393155096;1340.9664758381118;1361.8696481919983;1365.7678194706923;1366.6993261482457;722.212788061016;789.2699253190775;794.7893808140848;831.2518733140222;844.8774927635459;5227.581793456515;5280.419153893069;5410.404855465896;5439.851258752849;5470.8085217017215;4613.562895642767;5884.705764711833;5920.483794387368;5972.013993003498;6031.366706495754;4515.419603138941;4939.481354457802;5124.897502049938;5458.972705136528;5551.195076713934;2908.5055540558155;3070.370574032318;3108.8290144041844;3116.2520994961046;3120.3774037500825;5435.320584926884;6146.938530614726;6156.199694039746;6156.6921653917125;6174.703312304377;4902;5674.971625141848;5971.402859713994;5991.64050156992;6014.248218972629;4672.275797251432;4935.531124543163;5176.7152806596;5883.441073098049;5907.734151963172;4976.8755781105765;5684.346300175367;5860.970695146497;5883.235179426647;5908.438698323653;5423.674579525241;5526.419725928719;5789.49473136979;5833.79581714638;5838.357780644211;5107.361579802525;5817.563682723728;6076.422739839708;6125.9693701531205;6130.386961303834;3587.4260118380935;3966.662833659171;4049.0484736087583;4052.311107111857;4074.286999774968;5749.080147176432;5773.74018169175;5791.305043394819;5812.5349972001295;5825.621334613236;5215.608829337739;5306.416294207557;5651.915221271602;5679.148127780866;5713.371529131875;4629.976850115728;5340.75966581497;5620.04459241938;5677.990664947584;5694.629849059798;5518.448155184449;5522.420145884785;5525.696086715269;5527.419620939743;5552.361478430033;4633.374494443342;5489.066858634122;5566.749496272759;5630;5714.65705559185;4825.541573550507;5600.103983362643;5676.884258912256;5686.346070201815;5694.772209111589 10:01:52 INFO - PROCESS | 2148 | |5;yui.html;715.4419552748855;750.2947229604172;814.198014955269;839.8320335932812;859.8624220124781;15356.078635281878;15794.131322777257;15843.920780396096;15888.523344299661;15901;14788.334524946376;14927.477538286135;14932.552023439313;14936.402543898232;14940.477083302087;707.3139055116528;730.7515444748784;734.0274136768776;874.0822136756412;878.275422776209;900.3787386703186;901.9052999435063;914.6250037484633;919.5494207838144;921.1479381572052;970.4807927758651;970.8301047316727;971.0532231074716;971.504532688327;971.9125278724913;959.8656188133632;960.0351646595198;961.6489981156898;962.2398305338774;964.0841200859142;720.9134903811577;725.2022774947568;725.361681720083;725.9020032295679;725.9165196002422;15981.84018159815;15993.360265589363;16170.434034808843;16171.43399980995;16231.26959286835;13413.329333533382;13661.385237664328;13934.721305573934;15079.47221847241;15268.083914965027;11505.309681419141;12218.32799196044;13471.326433678374;13731.519396821062;13774.517891873737;4744.383230180055;4803.3035209894715;4808.206645903421;4824.1316563018645;4926.11329960607;119328.40335798352;123150;124052;124954.37522812509;127111.72888271092;10669.89330106689;10950.123990080774;11319.151063670257;11429.485673144729;11491.54033838637;21524.677129843065;21837;21839.781602183775;21882.781172188075;21888.23391181301;7555.206703296185;7891.210878912063;8135.227153420416;8260.380471464545;8303.335733141334;4507.616852567503;4573.6569757268335;4668.673192876534;4691.7184968901975;4810.941592849637;3565.447355659877;3624.2932628137787;3662.432322989941;3663.157473781045;3664.0839790052487;663.320096900671;673.2795908377989;673.7473447457204;680.2958937499664;681.9624920629414;599.2539288585739;635.3741564558906;651.1730102769551;653.8365408647838;669.7120238297579;8128.227818357246;9112.635494580276;9271;9301.860472092923;9327.580258888367;547.2393373211239;586.8298193523916;593.9762409503658;622.7820262907946;681.6285124607101;4141.213169497786;4473.986705982256;4475.440569928759;4504.662150338738;4571.542845715402;147688;162362.18818906066;162386;165699;169812;86162.56918715492;90083.74790630155;90532.54733726422;92666.53666731624;94170;125230.49539009169;125733;128710;130961;131725;8063.365630387166;8107.756767296991;8538.316934645338;8660.947110695384;8814.691485797966;56501.71749141228;68268.6586567064;68440.63118737697;69390.95913561402;69581;104207;105502.41746373964;107318.39022414514;107530;108295.91704083173;11555.711107222387;11615.012723918562;11764.88235117672;11925.105617078927;12055.81916271239;12358.320292384005;12752.808707869204;13040.282784446947;13200.14199077057;13785.862141378859;12008.75982480363;12269.69325766863;12436.502539898303;12581.182223155465;12842.550510732079;12172.939135304267;12336.136470446983;12426.130170887951;12498;12569.245845249314;11775.941120294343;12250.203736757083;12794.936025319814;13062.150960187557;14502;11283.323000619988;11542.653720388402;11762.470688819194;11980.523831504575;12086.576969806367;11769.117316201147;11829.290242585128;12096.75806483883;12108.091893108229;12141.75716485683 10:01:52 INFO - PROCESS | 2148 | __end_tp_report 10:01:52 INFO - PROCESS | 2148 | __start_cc_report 10:01:52 INFO - PROCESS | 2148 | _x_x_mozilla_cycle_collect,1143 10:01:52 INFO - PROCESS | 2148 | __end_cc_report 10:01:52 INFO - PROCESS | 2148 | __startTimestamp1484762512085__endTimestamp 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | ------- Summary: start ------- 10:01:52 INFO - PROCESS | 2148 | Number of tests: 6 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#0] dojo.html Cycles:165 Average:5691.02 Median:5851.56 stddev:617.58 (10.6%) stddev-sans-first:591.33 10:01:52 INFO - PROCESS | 2148 | Values: 3341.3 3349.4 3377.1 3385.4 3420.1 5620.7 5676.8 5683.8 5747.3 5761.7 5667.6 5735.9 5736.0 5751.6 5760.0 5193.9 5200.9 5209.5 5240.4 5282.0 5116.9 5163.2 5163.7 5247.7 5314.3 5251.7 5253.6 5265.6 5267.8 5276.4 5249.9 5265.4 5269.5 5277.1 5281.6 5102.8 5169.0 5194.3 5214.2 5220.6 5728.5 5759.0 5777.8 5828.2 5876.0 6114.6 6125.2 6127.3 6128.3 6137.3 6110.3 6127.3 6132.9 6140.8 6167.5 4808.6 5618.3 5631.3 5697.0 5704.9 6246.6 6250.7 6255.0 6258.9 6296.5 5873.3 5926.2 6078.1 6087.5 6108.8 5192.2 6097.8 6133.8 6184.7 6222.0 6108.0 6112.3 6113.2 6131.9 6132.4 5946.9 6162.4 6166.6 6170.9 6173.5 4831.1 4847.9 4908.5 4912.6 4924.0 4367.4 4373.8 4388.5 4390.1 4415.1 5728.8 5733.7 5734.0 5749.3 5752.6 6013.4 6091.0 6100.3 6114.3 6173.5 5784.7 5797.1 5812.2 5824.9 5826.7 5339.6 5396.5 5399.0 5407.4 5415.8 6197.8 6252.1 6262.0 6285.2 6297.8 6156.3 6215.0 6229.0 6242.7 6254.7 6202.3 6260.8 6261.0 6265.5 6286.3 5959.8 6083.8 6139.7 6154.5 6163.8 6106.2 6144.1 6224.3 6238.8 6254.4 4960.7 5772.9 6089.3 6091.4 6134.8 5989.2 5998.7 6010.9 6027.1 6040.2 5752.0 5792.4 5851.6 5874.5 5880.6 6009.7 6014.8 6018.7 6027.7 6048.0 5711.1 5793.7 5842.8 5856.3 5859.9 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#1] ext.html Cycles:180 Average:73529.85 Median:19634.27 stddev:166801.82 (849.5%) stddev-sans-first:167179.60 10:01:52 INFO - PROCESS | 2148 | Values: 494.3 526.5 528.6 546.3 558.3 32101.0 41711.7 43318.4 43456.6 45705.5 44446.0 44836.0 45038.5 45078.3 45095.8 9959.7 10145.4 10146.8 10159.9 10179.6 9260.0 9458.1 9459.6 9575.0 9579.5 12297.3 12547.8 12554.2 12654.9 12714.6 12314.4 12390.9 12420.4 12439.6 12479.3 12189.9 12247.3 12254.9 12276.6 12286.9 41874.2 42113.0 42144.9 42162.6 42235.6 3390.8 3538.2 3675.3 3983.9 4079.2 29764.7 30397.4 31225.7 32450.4 32838.0 3423.4 3433.6 3434.2 3487.7 3566.3 532611.0 540644.0 542444.0 543091.0 543178.0 33899.7 34605.8 34745.5 60632.1 61167.7 36280.5 36334.0 36434.6 36453.5 36497.3 15540.8 15649.2 15663.6 15665.9 15720.5 13205.8 13286.9 13307.3 13310.0 13336.9 7425.9 7539.1 7838.1 7944.2 8012.3 3315.6 3347.5 3347.6 3380.6 3387.5 936.6 973.2 1009.3 1039.6 1073.7 30637.5 30672.4 30722.8 31101.7 31211.5 1081.8 1091.2 1097.5 1151.7 1200.7 15208.8 15655.1 16043.2 16198.2 16504.3 713037.0 714153.0 714652.0 715419.0 716960.0 60492.0 61207.1 61341.0 61372.0 61592.7 1379.3 1411.9 1421.9 1427.0 1433.7 29216.8 29892.4 30189.0 30574.8 30636.8 49950.0 50267.7 50316.0 50408.0 50460.2 596261.0 597382.0 598513.0 599543.0 601393.0 26807.5 27182.0 27213.0 27239.9 27253.7 48277.8 48295.3 48358.5 49263.0 49758.0 39105.3 39332.0 39880.8 40097.4 41386.0 39402.8 39487.6 39562.0 39774.8 41224.0 38167.4 38381.8 39108.6 39154.0 39476.4 33522.7 35033.0 35471.6 35702.3 35761.3 25696.0 25796.1 25991.0 26124.3 26273.9 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#2] jquery.html Cycles:180 Average:36056.03 Median:2063.70 stddev:106612.05 (5166.1%) stddev-sans-first:106877.44 10:01:52 INFO - PROCESS | 2148 | Values: 366.6 386.8 386.8 396.7 420.9 15841.5 15936.5 18837.0 20765.4 20894.4 21205.9 21324.9 21486.9 21691.5 21914.9 5815.1 5973.4 5987.6 5998.8 6116.1 4323.5 5981.9 6089.4 6095.8 6096.5 4357.8 4373.7 4466.9 4512.7 6605.4 5782.3 6668.8 6675.2 6675.8 6681.7 5293.0 5590.4 5638.5 5676.2 5685.3 13428.9 13680.9 19323.7 25598.2 25934.7 2214.3 2283.9 2286.7 2389.3 2959.9 9842.6 9863.8 9979.7 10014.3 10342.0 1865.5 1885.2 1946.6 1981.5 2001.8 118371.4 124483.4 131374.0 134684.0 136708.0 10933.0 11326.0 11594.6 11609.3 11812.9 14735.3 14747.6 14753.0 14760.0 14800.4 8574.5 8824.9 8833.9 8897.3 8965.4 8776.2 8795.2 8816.3 8958.4 8991.0 3740.6 4396.2 4513.3 4523.0 4650.4 1596.0 1865.4 1880.5 1925.1 1931.2 748.6 753.9 860.9 984.7 1047.4 18130.4 20004.3 21444.9 21474.1 21677.1 933.2 990.1 999.8 1030.5 1089.7 10906.5 11221.4 11238.4 11246.9 11260.4 629205.0 636946.0 642883.0 643713.0 646700.0 89348.0 119170.0 121597.0 126100.0 131838.0 987.8 991.0 1007.6 1044.5 1046.1 18772.3 18919.3 19023.3 19471.8 19663.9 54561.0 55493.7 55991.7 56124.0 56491.7 79130.0 80402.0 81366.0 84378.0 85013.0 6869.3 7764.4 7782.4 7801.5 7863.2 11091.9 11696.9 11729.3 12051.5 12152.0 8998.8 9034.4 9157.4 9160.4 9288.0 9992.1 10009.5 10039.4 10053.4 10156.0 10310.1 10310.7 10331.1 10427.1 10525.3 7570.3 7585.5 7788.4 7797.7 7908.9 9855.5 9926.5 10109.8 10210.4 10324.9 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#3] mootools.html Cycles:180 Average:5793.67 Median:4807.78 stddev:3235.64 (67.3%) stddev-sans-first:3227.76 10:01:52 INFO - PROCESS | 2148 | Values: 1386.8 1524.2 1714.9 1867.7 1905.4 8557.0 9080.4 9081.8 9094.3 9103.2 7902.5 8184.0 8511.5 8798.3 8800.1 2379.0 2402.3 2403.3 2406.6 2409.5 2371.2 2376.7 2411.6 2417.0 2418.4 2393.6 2401.8 2407.0 2418.3 2420.3 2378.4 2389.6 2396.6 2399.5 2401.4 2375.0 2389.3 2394.8 2395.1 2401.0 8808.7 8923.6 8982.6 8989.4 9010.5 5337.9 5494.6 5496.3 5498.6 5502.1 3577.2 3595.7 3623.3 3682.9 3688.2 1085.1 1088.5 1095.0 1105.3 1114.6 11629.7 11771.1 11771.5 11784.1 11901.6 4364.3 4428.4 4524.1 4736.3 4911.9 10055.3 10065.0 10071.0 10091.7 10101.2 5307.3 5310.5 5317.0 5324.5 5330.0 4509.2 4573.5 4669.5 4879.2 4955.7 3540.3 3964.6 4007.4 4097.3 4130.9 1273.8 1275.3 1283.7 1285.9 1297.7 767.4 841.4 886.7 954.1 958.9 5532.6 5671.5 5915.7 6015.3 6236.6 907.5 949.5 974.6 979.3 1010.0 3870.0 3964.0 4063.7 4191.8 4212.3 10494.3 10933.7 10939.7 10941.6 10949.1 10873.9 10884.9 10885.7 10889.5 10901.6 7953.5 8267.5 8319.7 8425.0 8433.6 5968.3 6057.1 6076.9 6212.9 6327.5 9864.3 10115.7 10115.8 10129.6 10134.1 9956.0 10195.1 10225.0 10384.1 10389.5 6868.4 7097.9 7382.4 7461.3 7616.7 8396.8 8585.2 8592.0 8594.4 8596.5 7491.6 7630.4 7640.3 7676.3 7757.2 7370.2 7434.4 7496.7 7516.4 7623.9 7003.6 7152.9 7161.0 7173.1 7176.0 5000.5 5056.9 5103.2 5252.8 5306.8 5123.3 5128.4 5130.9 5199.7 5205.4 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#4] prototype.html Cycles:180 Average:4597.50 Median:5259.59 stddev:1425.95 (27.1%) stddev-sans-first:1393.16 10:01:52 INFO - PROCESS | 2148 | Values: 310.0 317.7 319.4 322.7 327.1 5436.7 5436.9 5439.5 5443.2 5461.5 5374.8 5376.6 5433.9 5437.4 5437.9 3745.9 3922.2 4016.8 4066.3 4205.5 3607.4 4114.0 4115.4 4185.7 4212.0 3690.5 4076.2 4107.4 4116.2 4143.1 3167.9 3812.4 4118.9 4138.8 4179.9 3013.3 3515.2 3522.5 3539.1 3543.6 5234.5 5257.8 5261.4 5269.1 5272.2 3932.8 4219.7 4313.0 4337.8 4634.4 4838.8 5157.7 5328.6 5609.5 5642.5 3713.7 3851.5 3858.4 3867.8 3874.8 5007.4 5532.5 5878.7 5927.9 5940.3 3326.7 3891.4 3958.0 3958.5 3982.9 3451.4 3903.6 4000.8 4008.3 4028.9 4688.6 4688.8 4695.4 4696.3 4712.3 4906.8 5473.3 5765.7 5778.7 5814.5 1162.6 1341.0 1361.9 1365.8 1366.7 722.2 789.3 794.8 831.3 844.9 5227.6 5280.4 5410.4 5439.9 5470.8 4613.6 5884.7 5920.5 5972.0 6031.4 4515.4 4939.5 5124.9 5459.0 5551.2 2908.5 3070.4 3108.8 3116.3 3120.4 5435.3 6146.9 6156.2 6156.7 6174.7 4902.0 5675.0 5971.4 5991.6 6014.2 4672.3 4935.5 5176.7 5883.4 5907.7 4976.9 5684.3 5861.0 5883.2 5908.4 5423.7 5526.4 5789.5 5833.8 5838.4 5107.4 5817.6 6076.4 6126.0 6130.4 3587.4 3966.7 4049.0 4052.3 4074.3 5749.1 5773.7 5791.3 5812.5 5825.6 5215.6 5306.4 5651.9 5679.1 5713.4 4630.0 5340.8 5620.0 5678.0 5694.6 5518.4 5522.4 5525.7 5527.4 5552.4 4633.4 5489.1 5566.7 5630.0 5714.7 4825.5 5600.1 5676.9 5686.3 5694.8 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - PROCESS | 2148 | [#5] yui.html Cycles:180 Average:25577.91 Median:3594.87 stddev:41462.40 (1153.4%) stddev-sans-first:41536.69 10:01:52 INFO - PROCESS | 2148 | Values: 715.4 750.3 814.2 839.8 859.9 15356.1 15794.1 15843.9 15888.5 15901.0 14788.3 14927.5 14932.6 14936.4 14940.5 707.3 730.8 734.0 874.1 878.3 900.4 901.9 914.6 919.5 921.1 970.5 970.8 971.1 971.5 971.9 959.9 960.0 961.6 962.2 964.1 720.9 725.2 725.4 725.9 725.9 15981.8 15993.4 16170.4 16171.4 16231.3 13413.3 13661.4 13934.7 15079.5 15268.1 11505.3 12218.3 13471.3 13731.5 13774.5 4744.4 4803.3 4808.2 4824.1 4926.1 119328.4 123150.0 124052.0 124954.4 127111.7 10669.9 10950.1 11319.2 11429.5 11491.5 21524.7 21837.0 21839.8 21882.8 21888.2 7555.2 7891.2 8135.2 8260.4 8303.3 4507.6 4573.7 4668.7 4691.7 4810.9 3565.4 3624.3 3662.4 3663.2 3664.1 663.3 673.3 673.7 680.3 682.0 599.3 635.4 651.2 653.8 669.7 8128.2 9112.6 9271.0 9301.9 9327.6 547.2 586.8 594.0 622.8 681.6 4141.2 4474.0 4475.4 4504.7 4571.5 147688.0 162362.2 162386.0 165699.0 169812.0 86162.6 90083.7 90532.5 92666.5 94170.0 125230.5 125733.0 128710.0 130961.0 131725.0 8063.4 8107.8 8538.3 8660.9 8814.7 56501.7 68268.7 68440.6 69391.0 69581.0 104207.0 105502.4 107318.4 107530.0 108295.9 11555.7 11615.0 11764.9 11925.1 12055.8 12358.3 12752.8 13040.3 13200.1 13785.9 12008.8 12269.7 12436.5 12581.2 12842.6 12172.9 12336.1 12426.1 12498.0 12569.2 11775.9 12250.2 12794.9 13062.2 14502.0 11283.3 11542.7 11762.5 11980.5 12086.6 11769.1 11829.3 12096.8 12108.1 12141.8 10:01:52 INFO - PROCESS | 2148 | -------- Summary: end -------- 10:01:52 INFO - PROCESS | 2148 | 10:01:52 INFO - TEST-INFO | 2148: exit 0 10:01:52 INFO - TEST-OK | dromaeo_css | took 1115093ms 10:01:52 INFO - TEST-START | kraken 10:01:52 INFO - operating with platform_type : mac_ 10:01:52 INFO - Initialising browser for kraken test... 10:01:52 INFO - TEST-INFO | started process 2152 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpIZlTtu/profile http://localhost:49487/getInfo.html) 10:01:54 INFO - PROCESS | 2152 | __metrics Screen width/height:1600/1200 10:01:54 INFO - PROCESS | 2152 | colorDepth:24 10:01:54 INFO - PROCESS | 2152 | Browser inner width/height: 1024/689 10:01:54 INFO - PROCESS | 2152 | __metrics 10:01:55 INFO - PROCESS | 2152 | 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:01:55 INFO - PROCESS | 2152 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:55 INFO - TEST-INFO | 2152: exit 0 10:01:55 INFO - Browser initialized. 10:01:55 INFO - Running cycle 1/1 for kraken test... 10:01:55 INFO - TEST-INFO | started process 2154 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpIZlTtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:07 INFO - PROCESS | 2154 | RSS: Main: 164646912 10:02:07 INFO - PROCESS | 2154 | 10:02:10 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:11 INFO - PROCESS | 2154 | RSS: Main: 216297472 10:02:11 INFO - PROCESS | 2154 | 10:02:14 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-dft) 10:02:14 INFO - PROCESS | 2154 | RSS: Main: 227606528 10:02:14 INFO - PROCESS | 2154 | 10:02:17 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-fft) 10:02:18 INFO - PROCESS | 2154 | RSS: Main: 323452928 10:02:18 INFO - PROCESS | 2154 | 10:02:20 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-oscillator) 10:02:20 INFO - PROCESS | 2154 | RSS: Main: 227799040 10:02:20 INFO - PROCESS | 2154 | 10:02:22 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:23 INFO - PROCESS | 2154 | RSS: Main: 228331520 10:02:23 INFO - PROCESS | 2154 | 10:02:26 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:26 INFO - PROCESS | 2154 | RSS: Main: 264634368 10:02:26 INFO - PROCESS | 2154 | 10:02:29 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:30 INFO - PROCESS | 2154 | RSS: Main: 264798208 10:02:30 INFO - PROCESS | 2154 | 10:02:33 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49487/tests/kraken/driver.html?testName=json-parse-financial) 10:02:33 INFO - PROCESS | 2154 | RSS: Main: 263852032 10:02:33 INFO - PROCESS | 2154 | 10:02:35 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:35 INFO - PROCESS | 2154 | RSS: Main: 239775744 10:02:35 INFO - PROCESS | 2154 | 10:02:37 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:38 INFO - PROCESS | 2154 | RSS: Main: 245567488 10:02:38 INFO - PROCESS | 2154 | 10:02:40 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:41 INFO - PROCESS | 2154 | RSS: Main: 251916288 10:02:41 INFO - PROCESS | 2154 | 10:02:44 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:44 INFO - PROCESS | 2154 | RSS: Main: 264306688 10:02:44 INFO - PROCESS | 2154 | 10:02:47 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:48 INFO - PROCESS | 2154 | RSS: Main: 258457600 10:02:48 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49487/tests/kraken/driver.html?testName=ai-astar) 10:02:50 INFO - PROCESS | 2154 | RSS: Main: 302784512 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | __start_tp_report 10:02:50 INFO - PROCESS | 2154 | _x_x_mozilla_page_load 10:02:50 INFO - PROCESS | 2154 | _x_x_mozilla_page_load_details 10:02:50 INFO - PROCESS | 2154 | |i|pagename|runs| 10:02:50 INFO - PROCESS | 2154 | |0;ai-astar;105;113;113;113;113;114;113;113;112;114 10:02:50 INFO - PROCESS | 2154 | |1;audio-beat-detection;144;108;109;160;137;138;127;108;137;111 10:02:50 INFO - PROCESS | 2154 | |2;audio-dft;183;184;183;185;182;184;181;184;184;185 10:02:50 INFO - PROCESS | 2154 | |3;audio-fft;83;60;57;88;59;59;58;57;100;79 10:02:50 INFO - PROCESS | 2154 | |4;audio-oscillator;82;70;93;69;68;69;91;67;68;89 10:02:50 INFO - PROCESS | 2154 | |5;imaging-gaussian-blur;92;88;91;89;92;88;92;89;92;88 10:02:50 INFO - PROCESS | 2154 | |6;imaging-darkroom;95;95;95;96;95;95;96;101;138;96 10:02:50 INFO - PROCESS | 2154 | |7;imaging-desaturate;90;86;86;86;84;83;85;85;85;86 10:02:50 INFO - PROCESS | 2154 | |8;json-parse-financial;56;54;52;52;55;57;57;57;56;57 10:02:50 INFO - PROCESS | 2154 | |9;json-stringify-tinderbox;64;82;72;74;70;68;68;69;68;68 10:02:50 INFO - PROCESS | 2154 | |10;stanford-crypto-aes;83;84;82;80;83;81;78;91;95;96 10:02:50 INFO - PROCESS | 2154 | |11;stanford-crypto-ccm;135;157;148;144;139;135;147;132;192;144 10:02:50 INFO - PROCESS | 2154 | |12;stanford-crypto-pbkdf2;160;159;210;209;168;160;159;159;207;170 10:02:50 INFO - PROCESS | 2154 | |13;stanford-crypto-sha256-iterative;65;66;65;66;66;65;66;66;64;65 10:02:50 INFO - PROCESS | 2154 | __end_tp_report 10:02:50 INFO - PROCESS | 2154 | __start_cc_report 10:02:50 INFO - PROCESS | 2154 | _x_x_mozilla_cycle_collect,2036 10:02:50 INFO - PROCESS | 2154 | __end_cc_report 10:02:50 INFO - PROCESS | 2154 | __startTimestamp1484762570371__endTimestamp 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | ------- Summary: start ------- 10:02:50 INFO - PROCESS | 2154 | Number of tests: 14 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.63 (2.3%) stddev-sans-first:0.60 10:02:50 INFO - PROCESS | 2154 | Values: 105.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 112.0 114.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:137.00 stddev:18.24 (13.3%) stddev-sans-first:18.39 10:02:50 INFO - PROCESS | 2154 | Values: 144.0 108.0 109.0 160.0 137.0 138.0 127.0 108.0 137.0 111.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.27 (0.7%) stddev-sans-first:1.33 10:02:50 INFO - PROCESS | 2154 | Values: 183.0 184.0 183.0 185.0 182.0 184.0 181.0 184.0 184.0 185.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#3] audio-fft Cycles:10 Average:70.00 Median:59.50 stddev:15.98 (26.9%) stddev-sans-first:16.24 10:02:50 INFO - PROCESS | 2154 | Values: 83.0 60.0 57.0 88.0 59.0 59.0 58.0 57.0 100.0 79.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.00 stddev:10.84 (14.3%) stddev-sans-first:11.32 10:02:50 INFO - PROCESS | 2154 | Values: 82.0 70.0 93.0 69.0 68.0 69.0 91.0 67.0 68.0 89.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:91.50 stddev:1.85 (2.0%) stddev-sans-first:1.83 10:02:50 INFO - PROCESS | 2154 | Values: 92.0 88.0 91.0 89.0 92.0 88.0 92.0 89.0 92.0 88.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:95.00 stddev:13.41 (14.1%) stddev-sans-first:14.09 10:02:50 INFO - PROCESS | 2154 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 101.0 138.0 96.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.84 (2.1%) stddev-sans-first:1.05 10:02:50 INFO - PROCESS | 2154 | Values: 90.0 86.0 86.0 86.0 84.0 83.0 85.0 85.0 85.0 86.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.50 stddev:2.00 (3.5%) stddev-sans-first:2.11 10:02:50 INFO - PROCESS | 2154 | Values: 56.0 54.0 52.0 52.0 55.0 57.0 57.0 57.0 56.0 57.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:69.50 stddev:4.90 (7.1%) stddev-sans-first:4.64 10:02:50 INFO - PROCESS | 2154 | Values: 64.0 82.0 72.0 74.0 70.0 68.0 68.0 69.0 68.0 68.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:83.50 stddev:6.36 (7.6%) stddev-sans-first:6.69 10:02:50 INFO - PROCESS | 2154 | Values: 83.0 84.0 82.0 80.0 83.0 81.0 78.0 91.0 95.0 96.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:145.50 stddev:17.38 (11.9%) stddev-sans-first:17.86 10:02:50 INFO - PROCESS | 2154 | Values: 135.0 157.0 148.0 144.0 139.0 135.0 147.0 132.0 192.0 144.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:169.00 stddev:22.82 (13.5%) stddev-sans-first:23.44 10:02:50 INFO - PROCESS | 2154 | Values: 160.0 159.0 210.0 209.0 168.0 160.0 159.0 159.0 207.0 170.0 10:02:50 INFO - PROCESS | 2154 | 10:02:50 INFO - PROCESS | 2154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:02:50 INFO - PROCESS | 2154 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 64.0 65.0 10:02:50 INFO - PROCESS | 2154 | -------- Summary: end -------- 10:02:50 INFO - PROCESS | 2154 | 10:02:51 INFO - TEST-INFO | 2154: exit 0 10:02:51 INFO - TEST-OK | kraken | took 58486ms 10:02:51 INFO - SUITE-END | took 1173s 10:02:51 INFO - Completed test suite (00:19:33) 10:02:51 INFO - javascript benchmark 10:02:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.3317336532696, 3349.447341188704, 3377.0881861897274, 3385.3567822113782, 3420.1107711994873, 5620.747066382012, 5676.772929082842, 5683.829485115442, 5747.339056008565, 5761.740721667525, 5667.631603945751, 5735.942640573603, 5736.0, 5751.626144300618, 5759.963206622806, 5193.948060519384, 5200.895982080366, 5209.505097015796, 5240.423553409122, 5282.0, 5116.923246151311, 5163.173892177252, 5163.7159956202395, 5247.737613119348, 5314.335708036496, 5251.658642188246, 5253.57971362292, 5265.605079619025, 5267.789288428477, 5276.393214780292, 5249.8950020999555, 5265.447128051538, 5269.525742683177, 5277.12927366984, 5281.603879709037, 5102.770375333119, 5168.974155129238, 5194.298769666085, 5214.217867319894, 5220.634555581111, 5728.5417166626985, 5759.020966435716, 5777.768889244425, 5828.2131912191735, 5876.030454974924, 6114.633122012693, 6125.203723515914, 6127.264728232596, 6128.264608246995, 6137.2635283765785, 6110.297315808694, 6127.31169931711, 6132.877342453171, 6140.785072522485, 6167.537434692371, 4808.591269742111, 5618.297712785902, 5631.267935168402, 5696.971515142398, 5704.914426283609, 6246.593971391845, 6250.718717657716, 6255.0, 6258.906116408258, 6296.464800492009, 5873.295204575478, 5926.2295901532525, 6078.0882867569335, 6087.512998960073, 6108.755649774048, 5192.247124166975, 6097.7865774697675, 6133.82435864808, 6184.6598437086395, 6221.968890155611, 6108.0, 6112.2970858351855, 6113.20528331323, 6131.938680613226, 6132.386102851662, 5946.910796338058, 6162.414570615784, 6166.568340216142, 6170.876582468325, 6173.475254603409, 4831.106245344622, 4847.903041939212, 4908.460069392364, 4912.557869791736, 4923.950760492421, 4367.388565600819, 4373.846915358011, 4388.473383193973, 4390.07808360248, 4415.050764085737, 5728.770849165987, 5733.684647344353, 5734.0, 5749.252597162425, 5752.597318187687, 6013.398660134039, 6090.969545152335, 6100.298465676416, 6114.297368146176, 6173.47525460332, 5784.652920824764, 5797.072468405035, 5812.186293918855, 5824.88350232993, 5826.679532625746, 5339.5728341732565, 5396.514313711707, 5399.0, 5407.405185429599, 5415.783368665288, 6197.81406557804, 6252.093446450148, 6262.029385445263, 6285.1515045470105, 6297.811065668037, 6156.26124865019, 6215.036669316263, 6229.003359462465, 6242.65665388408, 6254.655993920378, 6202.34875338083, 6260.812175634738, 6260.968695156495, 6265.498760099273, 6286.308506064238, 5959.791407300897, 6083.756649733961, 6139.72371243304, 6154.476869466145, 6163.8150855474405, 6106.2061931948565, 6144.10910417978, 6224.284207316216, 6238.75044998195, 6254.405831446005, 4960.677555958851, 5772.855678608068, 6089.330173680803, 6091.395865947327, 6134.754609815557, 5989.1615173874825, 5998.670073146019, 6010.939890601038, 6027.065804800263, 6040.2147720797775, 5752.0, 5792.4497172768515, 5851.561132914963, 5874.500667443315, 5880.617759845596, 6009.7295621698, 6014.759409623566, 6018.699065046642, 6027.668478233739, 6047.971844786485, 5711.057675483665, 5793.739281732416, 5842.766289348378, 5856.326522449803, 5859.853503662443], "value": 5652.814331553844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.2832892306157, 526.4524894110125, 528.5744975294886, 546.3416583017464, 558.2742434834714, 32101.0, 41711.748647540546, 43318.35022474665, 43456.56543434565, 45705.542944570625, 44446.0, 44836.0, 45038.54961450385, 45078.32382514265, 45095.77452112743, 9959.701208963743, 10145.391276523394, 10146.84779728301, 10159.949200253988, 10179.643712470064, 9259.95370023149, 9458.054194580556, 9459.62161513542, 9574.99462556432, 9579.473128977937, 12297.3236471994, 12547.811782823264, 12554.246745195273, 12654.873451265508, 12714.61856144317, 12314.38428078597, 12390.938045309806, 12420.378981050912, 12439.626811195678, 12479.251244925334, 12189.878101218963, 12247.326397048158, 12254.877451225462, 12276.631701048982, 12286.938565307206, 41874.1625167498, 42113.0, 42144.94637634053, 42162.57837421617, 42235.57764422378, 3390.8304584770663, 3538.221591249921, 3675.2649470105816, 3983.940240896389, 4079.224947260011, 29764.70412774469, 30397.392052159055, 31225.687743122504, 32450.350992980246, 32838.0, 3423.400904841668, 3433.5879694436826, 3434.227298857737, 3487.7035451986612, 3566.251087271676, 532611.0, 540644.0, 542444.0, 543091.0, 543178.0, 33899.661003390145, 34605.82697086498, 34745.478817817755, 60632.09051864137, 61167.6941615298, 36280.45579316312, 36334.0, 36434.63565364313, 36453.45319820205, 36497.27005459876, 15540.84459155394, 15649.217539122998, 15663.608409789618, 15665.921670391803, 15720.528384148494, 13205.801912971314, 13286.867131328756, 13307.334633268492, 13310.0, 13336.866631333756, 7425.888611670829, 7539.0576177977755, 7838.059432868093, 7944.245296696805, 8012.318952888953, 3315.5689760331, 3347.4811404232382, 3347.598288205431, 3380.611229708615, 3387.542681737934, 936.6440752514137, 973.2019743810008, 1009.333839665817, 1039.6309310194922, 1073.736934451049, 30637.540436893465, 30672.38655226883, 30722.846385767927, 31101.688983109878, 31211.531827022613, 1081.789051135021, 1091.24158709696, 1097.4786976186408, 1151.6717735445359, 1200.6578125234266, 15208.847911520965, 15655.060696358254, 16043.197840107949, 16198.17776716797, 16504.25730842115, 713037.0, 714153.0, 714652.0, 715419.0, 716960.0, 60492.0, 61207.08189377163, 61341.0, 61372.0, 61592.69203654043, 1379.2552021908257, 1411.9435222591187, 1421.9004669673232, 1426.985730142706, 1433.720424517209, 29216.83132674669, 29892.402151957274, 30189.0, 30574.84712576423, 30636.78858658655, 49950.00099997907, 50267.74866125646, 50316.0, 50407.991840163726, 50460.24309635285, 596261.0, 597382.0, 598513.0, 599543.0, 601393.0, 26807.463850723267, 27182.0, 27213.0, 27239.86380068087, 27253.727462725117, 48277.793055173905, 48295.275570865764, 48358.5164148354, 49263.01473970572, 49758.0, 39105.262631615515, 39332.0, 39880.80059599799, 40097.39853902252, 41385.96535086647, 39402.80298598488, 39487.60512394839, 39562.0, 39774.80675579737, 41224.0, 38167.427488587135, 38381.80809095937, 39108.60891391164, 39154.0, 39476.40785388279, 33522.66477335196, 35033.0, 35471.64528354684, 35702.28595428129, 35761.28477430385, 25696.0, 25796.09713660013, 25991.0, 26124.34689132787, 26273.86721979416], "value": 19620.51370679255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.58758896241727, 386.82206185154826, 386.8452618952419, 396.6826538768984, 420.87794539583524, 15841.524754257376, 15936.521904342873, 18837.0, 20765.377038688825, 20894.37316880496, 21205.893970530127, 21324.893375533138, 21486.89256553719, 21691.457713557167, 21914.89042554789, 5815.069588865782, 5973.372795856438, 5987.55093367997, 5998.7600495980105, 6116.052011938156, 4323.502797178317, 5981.910271345933, 6089.421504957022, 6095.817125486243, 6096.542759293048, 4357.847475338348, 4373.737575745449, 4466.932996005046, 4512.684112112153, 6605.405513503783, 5782.3350314713925, 6668.833279168011, 6675.165604299486, 6675.766348177839, 6681.66591670417, 5293.0, 5590.385057643656, 5638.548916086745, 5676.205331253628, 5685.289338832646, 13428.93285533566, 13680.863191368158, 19323.710144347846, 25598.232053038253, 25934.74065259342, 2214.3356992902063, 2283.897224624879, 2286.6570014497793, 2389.2832150355, 2959.883683166525, 9842.60629574816, 9863.802723945553, 9979.650712225037, 10014.298999070068, 10342.0, 1865.4776662534512, 1885.161103309028, 1946.6204090202416, 1981.4947188466992, 2001.7798042215345, 118371.4081429596, 124483.3775831115, 131374.0, 134684.0, 136708.0, 10933.0, 11326.0, 11594.57959901831, 11609.30344179335, 11812.88187118135, 14735.336909839083, 14747.63130921714, 14753.0, 14759.966802323948, 14800.407983680532, 8574.528400937883, 8824.867626985471, 8833.911660883308, 8897.332700047522, 8965.372423930263, 8776.210141087333, 8795.164459376349, 8816.250618697482, 8958.372913895964, 8990.955045224731, 3740.5698344690163, 4396.208682437128, 4513.345564893138, 4523.0, 4650.441946966385, 1596.0, 1865.3750993417086, 1880.511067122558, 1925.0952052535285, 1931.1792488192461, 748.6331697468311, 753.8567672142275, 860.8665656823202, 984.7291994701371, 1047.4396198034015, 18130.365437209635, 20004.299849505198, 21444.927753612257, 21474.134655762115, 21677.132914683552, 933.2254228989922, 990.1336330710628, 999.7650552120245, 1030.4796077980573, 1089.6785448292774, 10906.5092070857, 11221.382823944597, 11238.38188899602, 11246.91931992584, 11260.43697815106, 629205.0, 636946.0, 642883.0, 643713.0, 646700.0, 89348.0, 119170.0, 121597.0, 126100.0, 131838.0, 987.8370068938544, 991.023841516106, 1007.5566750629699, 1044.535181844072, 1046.1369370269558, 18772.342967996054, 18919.337823176123, 19023.33418330352, 19471.805281947, 19663.901680491505, 54561.0, 55493.72253138709, 55991.72004139953, 56124.0, 56491.71754141203, 79130.0, 80402.0, 81366.0, 84378.0, 85013.0, 6869.278725733726, 7764.417668674985, 7782.416318776001, 7801.4929029612895, 7863.21367863232, 11091.944540277247, 11696.941515292368, 11729.296242225493, 12051.457684404399, 12152.0, 8998.775030624287, 9034.367594268339, 9157.358984870994, 9160.35877488596, 9287.953560232156, 9992.10071093605, 10009.5495702695, 10039.4478303694, 10053.447060411747, 10156.0, 10310.07209351132, 10310.742231444274, 10331.05564914026, 10427.113695335678, 10525.263231574023, 7570.318671319607, 7585.506942048749, 7788.376929845712, 7797.727079552188, 7908.920910790818, 9855.45794981283, 9926.503674816375, 10109.848352274576, 10210.387376757419, 10324.948375258376], "value": 9400.054390791445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.7919812028197, 1524.2378810594698, 1714.90568018759, 1867.7198420236955, 1905.3902751119647, 8557.0, 9080.409773364727, 9081.818363632732, 9094.272458203337, 9103.180713735763, 7902.525848449082, 8184.0, 8511.489310641366, 8798.252148567379, 8800.119988001197, 2379.0364902214633, 2402.267308470916, 2403.267003563912, 2406.566817972764, 2409.4819613783034, 2371.21749822559, 2376.66726658268, 2411.6141417373137, 2417.0090262992176, 2418.3712234818986, 2393.640953856927, 2401.795847352977, 2407.0251548123038, 2418.2745176447083, 2420.334408037786, 2378.4410663494064, 2389.581823180945, 2396.5805983952737, 2399.4721161344564, 2401.363638635763, 2374.9881250593635, 2389.3429306940557, 2394.772496612819, 2395.1138078910913, 2400.975990240093, 8808.735737927873, 8923.598438070303, 8982.595783189772, 8989.37074404792, 9010.504422256774, 5337.866553336159, 5494.560435165177, 5496.285482887199, 5498.615096943216, 5502.119660854244, 3577.177249232665, 3595.694365978895, 3623.2753449310244, 3682.926341473182, 3688.17016171362, 1085.0831047764627, 1088.4884104470887, 1094.9726256843562, 1105.3478447715806, 1114.5987444519967, 11629.651110466699, 11771.117166212569, 11771.470283837249, 11784.057275417947, 11901.583444579484, 4364.345348197732, 4428.4243048403505, 4524.072565124142, 4736.3369128322065, 4911.901761964741, 10055.346402483816, 10065.0, 10071.0, 10091.69724908254, 10101.19190464761, 5307.310049693592, 5310.468953104736, 5317.042932272228, 5324.494173053554, 5329.960657671717, 4509.210888094571, 4573.451185857652, 4669.509701481364, 4879.219324907997, 4955.6531042826655, 3540.2565461253425, 3964.643182113566, 4007.358822588372, 4097.303458412018, 4130.938035929464, 1273.7834568123442, 1275.3113318807925, 1283.7432513497151, 1285.8778416050461, 1297.6561211279018, 767.4244316762428, 841.4068082002296, 886.7339798060556, 954.1031430455349, 958.8705524754208, 5532.585056120807, 5671.51792097668, 5915.674637894957, 6015.3383127855905, 6236.6258024518675, 907.4782000349825, 949.5299826585746, 974.605284859633, 979.3291595257272, 1010.0303708439833, 3869.980650096788, 3964.0, 4063.715539912178, 4191.769452680071, 4212.326027835532, 10494.317869338469, 10933.726656833644, 10939.671809845717, 10941.56233750641, 10949.069329106957, 10873.891261087289, 10884.945575272073, 10885.673429797118, 10889.455527223607, 10901.563937442572, 7953.483023603448, 8267.503949763033, 8319.66721331152, 8425.0, 8433.578321083922, 5968.253968253968, 6057.091436284592, 6076.906156891802, 6212.9068063978175, 6327.525435592257, 9864.260180486348, 10115.7471063224, 10115.848262276219, 10129.59481620727, 10134.087932086148, 9956.004399559986, 10195.133413659922, 10224.977502249716, 10384.065434110664, 10389.53247103867, 6868.416184624363, 7097.858042839218, 7382.44631652639, 7461.291177338361, 7616.7334143304715, 8396.832063358577, 8585.184407481529, 8592.011918629187, 8594.441361311494, 8596.527191004554, 7491.625418728932, 7630.369046970797, 7640.312371886557, 7676.270754278335, 7757.185495522889, 7370.226126256666, 7434.368078713153, 7496.737614183696, 7516.436267279866, 7623.923760762544, 7003.5797852129035, 7152.856942861218, 7160.964195178991, 7173.0675012248075, 7176.0, 5000.524950129732, 5056.949430505648, 5103.18349064148, 5252.7898884045735, 5306.787728490972, 5123.28274041627, 5128.435872054146, 5130.871728206825, 5199.71401572902, 5205.427402985744], "value": 4660.297559633935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.96745341739114, 317.72358048497813, 319.42503493711314, 322.735357007254, 327.14614855227836, 5436.700981446023, 5436.891262174754, 5439.5104440600335, 5443.156310771837, 5461.481159289866, 5374.838754837361, 5376.596755243362, 5433.864153396167, 5437.429069947658, 5437.918431223525, 3745.8501659933568, 3922.176342967973, 4016.799160042001, 4066.329055705805, 4205.495340559137, 3607.350676878161, 4113.958860411388, 4115.403266526352, 4185.665146788265, 4211.957880421202, 3690.538682664667, 4076.164386300801, 4107.383892416132, 4116.217918595457, 4143.08852052548, 3167.904962851118, 3812.426612036864, 4118.855840045584, 4138.793060346986, 4179.874603761892, 3013.3220025494306, 3515.207244305397, 3522.454019626962, 3539.132912436444, 3543.5747710274672, 5234.502722241381, 5257.763400646942, 5261.421243663194, 5269.104252277084, 5272.235525848769, 3932.7836968966694, 4219.725717828362, 4313.029568347129, 4337.761423121727, 4634.443866736014, 4838.830565979254, 5157.71632560209, 5328.573714102862, 5609.49514543693, 5642.548596112301, 3713.665770080706, 3851.4607954886337, 3858.421236814472, 3867.8009816956833, 3874.786886721229, 5007.39911210657, 5532.529734972532, 5878.706684529397, 5927.851803704899, 5940.2871655401195, 3326.7005969462866, 3891.377379619247, 3958.040769818958, 3958.4656071430563, 3982.8605998789903, 3451.413259745799, 3903.5706072332023, 4000.7599544027453, 4008.2985477541315, 4028.8992775180855, 4688.57802797743, 4688.835890743808, 4695.389599352131, 4696.319033740157, 4712.340272361872, 4906.754662266872, 5473.343198816088, 5765.654060756368, 5778.711064446761, 5814.534837213013, 1162.645393155096, 1340.9664758381118, 1361.8696481919983, 1365.7678194706923, 1366.6993261482457, 722.212788061016, 789.2699253190775, 794.7893808140848, 831.2518733140222, 844.8774927635459, 5227.581793456515, 5280.419153893069, 5410.404855465896, 5439.851258752849, 5470.8085217017215, 4613.562895642767, 5884.705764711833, 5920.483794387368, 5972.013993003498, 6031.366706495754, 4515.419603138941, 4939.481354457802, 5124.897502049938, 5458.972705136528, 5551.195076713934, 2908.5055540558155, 3070.370574032318, 3108.8290144041844, 3116.2520994961046, 3120.3774037500825, 5435.320584926884, 6146.938530614726, 6156.199694039746, 6156.6921653917125, 6174.703312304377, 4902.0, 5674.971625141848, 5971.402859713994, 5991.64050156992, 6014.248218972629, 4672.275797251432, 4935.531124543163, 5176.7152806596, 5883.441073098049, 5907.734151963172, 4976.8755781105765, 5684.346300175367, 5860.970695146497, 5883.235179426647, 5908.438698323653, 5423.674579525241, 5526.419725928719, 5789.49473136979, 5833.79581714638, 5838.357780644211, 5107.361579802525, 5817.563682723728, 6076.422739839708, 6125.9693701531205, 6130.386961303834, 3587.4260118380935, 3966.662833659171, 4049.0484736087583, 4052.311107111857, 4074.286999774968, 5749.080147176432, 5773.74018169175, 5791.305043394819, 5812.5349972001295, 5825.621334613236, 5215.608829337739, 5306.416294207557, 5651.915221271602, 5679.148127780866, 5713.371529131875, 4629.976850115728, 5340.75966581497, 5620.04459241938, 5677.990664947584, 5694.629849059798, 5518.448155184449, 5522.420145884785, 5525.696086715269, 5527.419620939743, 5552.361478430033, 4633.374494443342, 5489.066858634122, 5566.749496272759, 5630.0, 5714.65705559185, 4825.541573550507, 5600.103983362643, 5676.884258912256, 5686.346070201815, 5694.772209111589], "value": 4136.717355280943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.4419552748855, 750.2947229604172, 814.198014955269, 839.8320335932812, 859.8624220124781, 15356.078635281878, 15794.131322777257, 15843.920780396096, 15888.523344299661, 15901.0, 14788.334524946376, 14927.477538286135, 14932.552023439313, 14936.402543898232, 14940.477083302087, 707.3139055116528, 730.7515444748784, 734.0274136768776, 874.0822136756412, 878.275422776209, 900.3787386703186, 901.9052999435063, 914.6250037484633, 919.5494207838144, 921.1479381572052, 970.4807927758651, 970.8301047316727, 971.0532231074716, 971.504532688327, 971.9125278724913, 959.8656188133632, 960.0351646595198, 961.6489981156898, 962.2398305338774, 964.0841200859142, 720.9134903811577, 725.2022774947568, 725.361681720083, 725.9020032295679, 725.9165196002422, 15981.84018159815, 15993.360265589363, 16170.434034808843, 16171.43399980995, 16231.26959286835, 13413.329333533382, 13661.385237664328, 13934.721305573934, 15079.47221847241, 15268.083914965027, 11505.309681419141, 12218.32799196044, 13471.326433678374, 13731.519396821062, 13774.517891873737, 4744.383230180055, 4803.3035209894715, 4808.206645903421, 4824.1316563018645, 4926.11329960607, 119328.40335798352, 123150.0, 124052.0, 124954.37522812509, 127111.72888271092, 10669.89330106689, 10950.123990080774, 11319.151063670257, 11429.485673144729, 11491.54033838637, 21524.677129843065, 21837.0, 21839.781602183775, 21882.781172188075, 21888.23391181301, 7555.206703296185, 7891.210878912063, 8135.227153420416, 8260.380471464545, 8303.335733141334, 4507.616852567503, 4573.6569757268335, 4668.673192876534, 4691.7184968901975, 4810.941592849637, 3565.447355659877, 3624.2932628137787, 3662.432322989941, 3663.157473781045, 3664.0839790052487, 663.320096900671, 673.2795908377989, 673.7473447457204, 680.2958937499664, 681.9624920629414, 599.2539288585739, 635.3741564558906, 651.1730102769551, 653.8365408647838, 669.7120238297579, 8128.227818357246, 9112.635494580276, 9271.0, 9301.860472092923, 9327.580258888367, 547.2393373211239, 586.8298193523916, 593.9762409503658, 622.7820262907946, 681.6285124607101, 4141.213169497786, 4473.986705982256, 4475.440569928759, 4504.662150338738, 4571.542845715402, 147688.0, 162362.18818906066, 162386.0, 165699.0, 169812.0, 86162.56918715492, 90083.74790630155, 90532.54733726422, 92666.53666731624, 94170.0, 125230.49539009169, 125733.0, 128710.0, 130961.0, 131725.0, 8063.365630387166, 8107.756767296991, 8538.316934645338, 8660.947110695384, 8814.691485797966, 56501.71749141228, 68268.6586567064, 68440.63118737697, 69390.95913561402, 69581.0, 104207.0, 105502.41746373964, 107318.39022414514, 107530.0, 108295.91704083173, 11555.711107222387, 11615.012723918562, 11764.88235117672, 11925.105617078927, 12055.81916271239, 12358.320292384005, 12752.808707869204, 13040.282784446947, 13200.14199077057, 13785.862141378859, 12008.75982480363, 12269.69325766863, 12436.502539898303, 12581.182223155465, 12842.550510732079, 12172.939135304267, 12336.136470446983, 12426.130170887951, 12498.0, 12569.245845249314, 11775.941120294343, 12250.203736757083, 12794.936025319814, 13062.150960187557, 14502.0, 11283.323000619988, 11542.653720388402, 11762.470688819194, 11980.523831504575, 12086.576969806367, 11769.117316201147, 11829.290242585128, 12096.75806483883, 12108.091893108229, 12141.75716485683], "value": 7960.498781704135, "unit": "score"}], "name": "dromaeo_css", "value": 7368.174651615112, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 112.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 109.0, 160.0, 137.0, 138.0, 127.0, 108.0, 137.0, 111.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 185.0, 182.0, 184.0, 181.0, 184.0, 184.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 57.0, 88.0, 59.0, 59.0, 58.0, 57.0, 100.0, 79.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 93.0, 69.0, 68.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 89.0, 92.0, 88.0, 92.0, 89.0, 92.0, 88.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 101.0, 138.0, 96.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 86.0, 86.0, 84.0, 83.0, 85.0, 85.0, 85.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 52.0, 52.0, 55.0, 57.0, 57.0, 57.0, 56.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 82.0, 72.0, 74.0, 70.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 80.0, 83.0, 81.0, 78.0, 91.0, 95.0, 96.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 157.0, 148.0, 144.0, 139.0, 135.0, 147.0, 132.0, 192.0, 144.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 210.0, 209.0, 168.0, 160.0, 159.0, 159.0, 207.0, 170.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 64.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1445.8999999999999, "alertThreshold": 2.0}]} 10:02:51 INFO - Return code: 0 10:02:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:51 INFO - # TBPL SUCCESS # 10:02:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:51 INFO - 2017-01-18 10:02:51.697 screenresolution[2158:18277] starting screenresolution argv=screenresolution get 10:02:51 INFO - 2017-01-18 10:02:51.700 screenresolution[2158:18277] Display 0: 1600x1200x32@60 10:02:51 INFO - 2017-01-18 10:02:51.706 screenresolution[2159:18280] starting screenresolution argv=screenresolution list 10:02:51 INFO - Available Modes on Display 0 10:02:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:51 INFO - Intel Iris: 10:02:51 INFO - Chipset Model: Intel Iris 10:02:51 INFO - Type: GPU 10:02:51 INFO - Bus: Built-In 10:02:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:51 INFO - Vendor: Intel (0x8086) 10:02:51 INFO - Device ID: 0x0a2e 10:02:51 INFO - Revision ID: 0x0009 10:02:51 INFO - Displays: 10:02:51 INFO - Display: 10:02:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:51 INFO - Display Serial Number: 1600x1200 60 10:02:51 INFO - Main Display: Yes 10:02:51 INFO - Mirror: Off 10:02:51 INFO - Online: Yes 10:02:51 INFO - Rotation: Supported 10:02:51 INFO - Return code: 0 10:02:51 INFO - Running post-action listener: _resource_record_post_action 10:02:51 INFO - [mozharness: 2017-01-18 18:02:51.941875Z] Finished run-tests step (success) 10:02:51 INFO - Running post-run listener: _resource_record_post_run 10:02:51 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1982976; Write bytes: 494684160; Read time: 23; Write time: 1796 10:02:51 INFO - TinderboxPrint: CPU usage
53.6% 10:02:51 INFO - TinderboxPrint: I/O read bytes / time
1,982,976 / 23 10:02:51 INFO - TinderboxPrint: I/O write bytes / time
494,684,160 / 1,796 10:02:51 INFO - TinderboxPrint: CPU idle
2,222.4 (46.4%) 10:02:51 INFO - TinderboxPrint: CPU system
964.0 (20.1%) 10:02:51 INFO - TinderboxPrint: CPU user
1,603.4 (33.5%) 10:02:51 INFO - TinderboxPrint: Swap in / out
198,283,264 / 0 10:02:52 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188338688; Write bytes: 187893760; Read time: 17552; Write time: 387 10:02:52 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 1982464; Write bytes: 296620032; Read time: 19; Write time: 1377 10:02:52 INFO - Running post-run listener: _upload_blobber_files 10:02:52 INFO - Blob upload gear active. 10:02:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:52 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:02:52 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:02:52 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:02:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:53 INFO - (blobuploader) - INFO - Done attempting. 10:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:54 INFO - (blobuploader) - INFO - Done attempting. 10:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:57 INFO - (blobuploader) - INFO - Done attempting. 10:02:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:57 INFO - Return code: 0 10:02:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa3e111d447450557af2c23c71f317f7341f8b5221c1e3c862d45a5f93a133bdee891eb540994e6c5c8aa3f38aa8cb2706a9b7b3c605ee9464a01ddcd2ba6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f205f09266363945d9fabe3f9bd0aed59293a73264c47acfaea00aa640dacfa7f4ba43384219a4ff3bbcaa2cf44a43d82fb319e5ca320f62d8e3409c52dcc318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4757805126a88c177470a8d52133865087300d0d4348029ab3bb4f27a0ca6e60cb7cb57c1b25fe8534a6904268262eb1c36f5faee4af24542837684c4d5509fd"} 10:02:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:57 INFO - Contents: 10:02:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa3e111d447450557af2c23c71f317f7341f8b5221c1e3c862d45a5f93a133bdee891eb540994e6c5c8aa3f38aa8cb2706a9b7b3c605ee9464a01ddcd2ba6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f205f09266363945d9fabe3f9bd0aed59293a73264c47acfaea00aa640dacfa7f4ba43384219a4ff3bbcaa2cf44a43d82fb319e5ca320f62d8e3409c52dcc318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4757805126a88c177470a8d52133865087300d0d4348029ab3bb4f27a0ca6e60cb7cb57c1b25fe8534a6904268262eb1c36f5faee4af24542837684c4d5509fd"} 10:02:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:57 INFO - Copying logs to upload dir... 10:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.744468 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-01-18 10:02:57.090157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 10:02:57.094192) ========= 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.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/fa3e111d447450557af2c23c71f317f7341f8b5221c1e3c862d45a5f93a133bdee891eb540994e6c5c8aa3f38aa8cb2706a9b7b3c605ee9464a01ddcd2ba6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f205f09266363945d9fabe3f9bd0aed59293a73264c47acfaea00aa640dacfa7f4ba43384219a4ff3bbcaa2cf44a43d82fb319e5ca320f62d8e3409c52dcc318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4757805126a88c177470a8d52133865087300d0d4348029ab3bb4f27a0ca6e60cb7cb57c1b25fe8534a6904268262eb1c36f5faee4af24542837684c4d5509fd"} build_url:https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/aPxVkARFTn-YPAnVFZA8DQ/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/fa3e111d447450557af2c23c71f317f7341f8b5221c1e3c862d45a5f93a133bdee891eb540994e6c5c8aa3f38aa8cb2706a9b7b3c605ee9464a01ddcd2ba6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f205f09266363945d9fabe3f9bd0aed59293a73264c47acfaea00aa640dacfa7f4ba43384219a4ff3bbcaa2cf44a43d82fb319e5ca320f62d8e3409c52dcc318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4757805126a88c177470a8d52133865087300d0d4348029ab3bb4f27a0ca6e60cb7cb57c1b25fe8534a6904268262eb1c36f5faee4af24542837684c4d5509fd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 10:02:57.133029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 10:02:57.133835) ========= 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.Uhg8c82plS/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.zzWlrDmmVG/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005235 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 10:02:57.184851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 10:02:57.185206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 10:02:57.185611) ========= ========= Total master_lag: 0.90 =========