builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0287 starttime: 1491833802.35 results: success (0) buildid: 20170410055650 builduid: cf08c9c376044f7a94491b45a6cb10f8 revision: 0d25d01521602c090c320eb85d04c61cf005a041 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.349608) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.350220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.350631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.380162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.385105) ========= 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.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-04-10 07:16:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-04-10 07:16:42 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128025 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.538245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.538555) ========= 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.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.027004 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.588214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:42.588742) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0d25d01521602c090c320eb85d04c61cf005a041 --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 0d25d01521602c090c320eb85d04c61cf005a041 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-04-10 07:16:42,694 truncating revision to first 12 chars 2017-04-10 07:16:42,694 Setting DEBUG logging. 2017-04-10 07:16:42,694 attempt 1/10 2017-04-10 07:16:42,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0d25d0152160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 07:16:43,362 unpacking tar archive at: mozilla-beta-0d25d0152160/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:43.549122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:43.549479) ========= script_repo_revision: 0d25d01521602c090c320eb85d04c61cf005a041 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:43.549947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:43.550214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 07:16:43.570181) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 07:16:43.570526) ========= /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.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:16:43 INFO - MultiFileLogger online at 20170410 07:16:43 in /builds/slave/test 07:16:43 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 07:16:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:43 INFO - {'append_to_log': False, 07:16:43 INFO - 'base_work_dir': '/builds/slave/test', 07:16:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:16:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:43 INFO - 'branch': 'Mozilla-Beta', 07:16:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:43 INFO - 'config_files': ('talos/mac_config.py',), 07:16:43 INFO - 'default_actions': ('clobber', 07:16:43 INFO - 'read-buildbot-config', 07:16:43 INFO - 'download-and-extract', 07:16:43 INFO - 'populate-webroot', 07:16:43 INFO - 'create-virtualenv', 07:16:43 INFO - 'install', 07:16:43 INFO - 'run-tests'), 07:16:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:43 INFO - 'download_minidump_stackwalk': True, 07:16:43 INFO - 'download_symbols': 'ondemand', 07:16:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:43 INFO - 'installer_path': 'installer.exe', 07:16:43 INFO - 'log_level': 'info', 07:16:43 INFO - 'log_name': 'talos', 07:16:43 INFO - 'log_to_console': True, 07:16:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:16:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:16:43 INFO - 'opt_config_files': (), 07:16:43 INFO - 'pip_index': False, 07:16:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:16:43 INFO - 'cmd': ('bash', 07:16:43 INFO - '-c', 07:16:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:16:43 INFO - 'enabled': True, 07:16:43 INFO - 'halt_on_failure': False, 07:16:43 INFO - 'name': 'check_screen_resolution'},), 07:16:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:16:43 INFO - 'cmd': ('bash', 07:16:43 INFO - '-c', 07:16:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:16:43 INFO - 'enabled': True, 07:16:43 INFO - 'halt_on_failure': False, 07:16:43 INFO - 'name': 'check_screen_resolution'},), 07:16:43 INFO - 'run_cmd_checks_enabled': True, 07:16:43 INFO - 'sps_profile': False, 07:16:43 INFO - 'sps_profile_interval': 0, 07:16:43 INFO - 'suite': 'dromaeojs', 07:16:43 INFO - 'system_bits': '32', 07:16:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:43 INFO - 'title': 't-yosemite-r7-0287', 07:16:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:43 INFO - 'use_talos_json': True, 07:16:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:43 INFO - 'work_dir': 'build'} 07:16:43 INFO - [mozharness: 2017-04-10 14:16:43.780863Z] Running clobber step. 07:16:43 INFO - Running pre-action listener: _resource_record_pre_action 07:16:43 INFO - Running main action method: clobber 07:16:43 INFO - rmtree: /builds/slave/test/build 07:16:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:46 INFO - Running post-action listener: _resource_record_post_action 07:16:46 INFO - [mozharness: 2017-04-10 14:16:46.296076Z] Finished clobber step (success) 07:16:46 INFO - [mozharness: 2017-04-10 14:16:46.296223Z] Running read-buildbot-config step. 07:16:46 INFO - Running pre-action listener: _resource_record_pre_action 07:16:46 INFO - Running main action method: read_buildbot_config 07:16:46 INFO - Using buildbot properties: 07:16:46 INFO - { 07:16:46 INFO - "project": "", 07:16:46 INFO - "product": "firefox", 07:16:46 INFO - "script_repo_revision": "production", 07:16:46 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:16:46 INFO - "repository": "", 07:16:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:16:46 INFO - "buildid": "20170410055650", 07:16:46 INFO - "pgo_build": "False", 07:16:46 INFO - "basedir": "/builds/slave/test", 07:16:46 INFO - "buildnumber": 19, 07:16:46 INFO - "slavename": "t-yosemite-r7-0287", 07:16:46 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:16:46 INFO - "platform": "yosemite_r7", 07:16:46 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:16:46 INFO - "branch": "mozilla-beta", 07:16:46 INFO - "repo_path": "releases/mozilla-beta", 07:16:46 INFO - "revision": "0d25d01521602c090c320eb85d04c61cf005a041", 07:16:46 INFO - "stage_platform": "macosx64", 07:16:46 INFO - "builduid": "cf08c9c376044f7a94491b45a6cb10f8", 07:16:46 INFO - "slavebuilddir": "test" 07:16:46 INFO - } 07:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 07:16:46 INFO - Running post-action listener: _resource_record_post_action 07:16:46 INFO - [mozharness: 2017-04-10 14:16:46.299647Z] Finished read-buildbot-config step (success) 07:16:46 INFO - [mozharness: 2017-04-10 14:16:46.299740Z] Running download-and-extract step. 07:16:46 INFO - Running pre-action listener: _resource_record_pre_action 07:16:46 INFO - Running main action method: download_and_extract 07:16:46 INFO - mkdir: /builds/slave/test/build/tests 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:46 INFO - trying https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 07:16:46 INFO - Downloading https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 07:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 07:16:47 INFO - Downloaded 1165 bytes. 07:16:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 07:16:47 INFO - Using the following test package requirements: 07:16:47 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:16:47 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 07:16:47 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 07:16:47 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:16:47 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 07:16:47 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:16:47 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 07:16:47 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 07:16:47 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 07:16:47 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:16:47 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 07:16:47 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 07:16:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:16:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:16:47 INFO - Fetch https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:16:48 INFO - Expected file size: 16116590 07:16:48 INFO - Obtained file size: 16116590 07:16:55 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:16:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:16:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:16:55 INFO - Fetch https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:16:56 INFO - Expected file size: 16116590 07:16:56 INFO - Obtained file size: 16116590 07:17:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 07:17:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 07:17:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 07:17:03 INFO - Expected file size: 14403650 07:17:03 INFO - Obtained file size: 14403650 07:17: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')]} 07:17:04 INFO - trying https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 07:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 07:17:06 INFO - Downloaded 58734685 bytes. 07:17:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:17:06 INFO - mkdir: /builds/slave/test/properties 07:17:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:06 INFO - Contents: 07:17:06 INFO - build_url:https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:17:06 INFO - Running post-action listener: _resource_record_post_action 07:17:06 INFO - Running post-action listener: set_extra_try_arguments 07:17:06 INFO - [mozharness: 2017-04-10 14:17:06.703448Z] Finished download-and-extract step (success) 07:17:06 INFO - [mozharness: 2017-04-10 14:17:06.703621Z] Running populate-webroot step. 07:17:06 INFO - Running pre-action listener: _resource_record_pre_action 07:17:06 INFO - Running main action method: populate_webroot 07:17:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:06 INFO - '--tppagecycles', 07:17:06 INFO - '7'], 07:17:06 INFO - 'tests': ['tsvgm']}}, 07:17:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['damp', 'tps']}, 07:17:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'tests': ['damp', 'tps']}, 07:17:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['dromaeo_dom']}, 07:17:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['basic_compositor_video']}, 07:17:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:17:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['a11yr', 07:17:06 INFO - 'ts_paint', 07:17:06 INFO - 'tpaint', 07:17:06 INFO - 'sessionrestore', 07:17:06 INFO - 'sessionrestore_no_auto_restore', 07:17:06 INFO - 'tabpaint']}, 07:17:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['tsvgx', 07:17:06 INFO - 'tsvgr_opacity', 07:17:06 INFO - 'tart', 07:17:06 INFO - 'tscrollx', 07:17:06 INFO - 'cart', 07:17:06 INFO - 'tsvg_static']}, 07:17:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:06 INFO - 'tsvgr_opacity', 07:17:06 INFO - 'tart', 07:17:06 INFO - 'tscrollx', 07:17:06 INFO - 'cart', 07:17:06 INFO - 'tsvg_static']}, 07:17:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'talos_options': ['--disable-e10s'], 07:17:06 INFO - 'tests': ['tp5o']}, 07:17:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:17:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'talos_options': ['--disable-e10s', 07:17:06 INFO - '--xperf_path', 07:17:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:06 INFO - 'tests': ['tp5n']}, 07:17:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:17:06 INFO - 'talos_options': ['--xperf_path', 07:17:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:06 INFO - 'tests': ['tp5n']}}, 07:17:06 INFO - 'talos.zip': {'path': '', 07:17:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:06 INFO - Running post-action listener: _resource_record_post_action 07:17:06 INFO - [mozharness: 2017-04-10 14:17:06.723155Z] Finished populate-webroot step (success) 07:17:06 INFO - [mozharness: 2017-04-10 14:17:06.723298Z] Running create-virtualenv step. 07:17:06 INFO - Running pre-action listener: _resource_record_pre_action 07:17:06 INFO - Running main action method: create_virtualenv 07:17:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:17:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:06 INFO - Using real prefix '/tools/python27' 07:17:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:10 INFO - Installing pip.................done. 07:17:10 INFO - Return code: 0 07:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:17:10 INFO - Reading from file tmpfile_stdout 07:17:10 INFO - Output received: 07:17:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:17:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:10 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:10 INFO - 'HOME': '/Users/cltbld', 07:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:10 INFO - 'LOGNAME': 'cltbld', 07:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:10 INFO - 'MOZ_NO_REMOTE': '1', 07:17:10 INFO - 'NO_EM_RESTART': '1', 07:17:10 INFO - 'PAGER': '/bin/cat', 07:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:10 INFO - 'PWD': '/builds/slave/test', 07:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:10 INFO - 'SHELL': '/bin/bash', 07:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:10 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:10 INFO - 'USER': 'cltbld', 07:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:10 INFO - 'XPC_FLAGS': '0x0', 07:17:10 INFO - 'XPC_SERVICE_NAME': '0', 07:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:10 INFO - Cleaning up... 07:17:10 INFO - Return code: 0 07:17:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:10 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:10 INFO - 'HOME': '/Users/cltbld', 07:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:10 INFO - 'LOGNAME': 'cltbld', 07:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:10 INFO - 'MOZ_NO_REMOTE': '1', 07:17:10 INFO - 'NO_EM_RESTART': '1', 07:17:10 INFO - 'PAGER': '/bin/cat', 07:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:10 INFO - 'PWD': '/builds/slave/test', 07:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:10 INFO - 'SHELL': '/bin/bash', 07:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:10 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:10 INFO - 'USER': 'cltbld', 07:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:10 INFO - 'XPC_FLAGS': '0x0', 07:17:10 INFO - 'XPC_SERVICE_NAME': '0', 07:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:11 INFO - Downloading/unpacking psutil>=3.1.1 07:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:14 INFO - Installing collected packages: psutil 07:17:14 INFO - Running setup.py install for psutil 07:17:14 INFO - building 'psutil._psutil_osx' extension 07:17:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:17:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:17:15 INFO - building 'psutil._psutil_posix' extension 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:17:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:17:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:17:15 INFO - ^ 07:17:15 INFO - 1 warning generated. 07:17:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:15 INFO - Successfully installed psutil 07:17:15 INFO - Cleaning up... 07:17:15 INFO - Return code: 0 07:17:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:15 INFO - 'HOME': '/Users/cltbld', 07:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:15 INFO - 'LOGNAME': 'cltbld', 07:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:15 INFO - 'MOZ_NO_REMOTE': '1', 07:17:15 INFO - 'NO_EM_RESTART': '1', 07:17:15 INFO - 'PAGER': '/bin/cat', 07:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:15 INFO - 'PWD': '/builds/slave/test', 07:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:15 INFO - 'SHELL': '/bin/bash', 07:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:15 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:15 INFO - 'USER': 'cltbld', 07:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:15 INFO - 'XPC_FLAGS': '0x0', 07:17:15 INFO - 'XPC_SERVICE_NAME': '0', 07:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:18 INFO - Installing collected packages: mozsystemmonitor 07:17:18 INFO - Running setup.py install for mozsystemmonitor 07:17:18 INFO - Successfully installed mozsystemmonitor 07:17:18 INFO - Cleaning up... 07:17:19 INFO - Return code: 0 07:17:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:17:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:19 INFO - 'HOME': '/Users/cltbld', 07:17:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:19 INFO - 'LOGNAME': 'cltbld', 07:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:19 INFO - 'MOZ_NO_REMOTE': '1', 07:17:19 INFO - 'NO_EM_RESTART': '1', 07:17:19 INFO - 'PAGER': '/bin/cat', 07:17:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:19 INFO - 'PWD': '/builds/slave/test', 07:17:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:19 INFO - 'SHELL': '/bin/bash', 07:17:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:19 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:19 INFO - 'USER': 'cltbld', 07:17:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:19 INFO - 'XPC_FLAGS': '0x0', 07:17:19 INFO - 'XPC_SERVICE_NAME': '0', 07:17:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:22 INFO - warning: no files found matching '*.txt' 07:17:22 INFO - no previously-included directories found matching 'build' 07:17:22 INFO - no previously-included directories found matching 'dist' 07:17:22 INFO - no previously-included directories found matching '.git*' 07:17:22 INFO - Installing collected packages: jsonschema, functools32 07:17:22 INFO - Running setup.py install for functools32 07:17:22 INFO - warning: no files found matching '*.txt' 07:17:22 INFO - no previously-included directories found matching 'build' 07:17:22 INFO - no previously-included directories found matching 'dist' 07:17:22 INFO - no previously-included directories found matching '.git*' 07:17:22 INFO - Successfully installed jsonschema functools32 07:17:22 INFO - Cleaning up... 07:17:22 INFO - Return code: 0 07:17:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:22 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:22 INFO - 'HOME': '/Users/cltbld', 07:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:22 INFO - 'LOGNAME': 'cltbld', 07:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:22 INFO - 'MOZ_NO_REMOTE': '1', 07:17:22 INFO - 'NO_EM_RESTART': '1', 07:17:22 INFO - 'PAGER': '/bin/cat', 07:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:22 INFO - 'PWD': '/builds/slave/test', 07:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:22 INFO - 'SHELL': '/bin/bash', 07:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:22 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:22 INFO - 'USER': 'cltbld', 07:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:22 INFO - 'XPC_FLAGS': '0x0', 07:17:22 INFO - 'XPC_SERVICE_NAME': '0', 07:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:17:22 INFO - Cleaning up... 07:17:22 INFO - Return code: 0 07:17:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:22 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:22 INFO - 'HOME': '/Users/cltbld', 07:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:22 INFO - 'LOGNAME': 'cltbld', 07:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:22 INFO - 'MOZ_NO_REMOTE': '1', 07:17:22 INFO - 'NO_EM_RESTART': '1', 07:17:22 INFO - 'PAGER': '/bin/cat', 07:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:22 INFO - 'PWD': '/builds/slave/test', 07:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:22 INFO - 'SHELL': '/bin/bash', 07:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:22 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:22 INFO - 'USER': 'cltbld', 07:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:22 INFO - 'XPC_FLAGS': '0x0', 07:17:22 INFO - 'XPC_SERVICE_NAME': '0', 07:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:26 INFO - Downloading docopt-0.6.1.tar.gz 07:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:27 INFO - Running setup.py install for blobuploader 07:17:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:27 INFO - Running setup.py install for requests 07:17:27 INFO - Running setup.py install for docopt 07:17:27 INFO - Successfully installed blobuploader requests docopt 07:17:27 INFO - Cleaning up... 07:17:27 INFO - Return code: 0 07:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:27 INFO - 'HOME': '/Users/cltbld', 07:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:27 INFO - 'LOGNAME': 'cltbld', 07:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:27 INFO - 'MOZ_NO_REMOTE': '1', 07:17:27 INFO - 'NO_EM_RESTART': '1', 07:17:27 INFO - 'PAGER': '/bin/cat', 07:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:27 INFO - 'PWD': '/builds/slave/test', 07:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:27 INFO - 'SHELL': '/bin/bash', 07:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:27 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:27 INFO - 'USER': 'cltbld', 07:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:27 INFO - 'XPC_FLAGS': '0x0', 07:17:27 INFO - 'XPC_SERVICE_NAME': '0', 07:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2Dgx_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-eZmzLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2a1lKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-KpUpQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-dVLaNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-5FIkzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2_Mcsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-iT2JUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-6AloXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-9S_PjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-moaczq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2JKjLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-UsPYNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-onCDCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-RoHF5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-BPAQ8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-h8dTWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:30 INFO - Running setup.py install for manifestparser 07:17:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:30 INFO - Running setup.py install for mozcrash 07:17:30 INFO - Running setup.py install for mozdebug 07:17:30 INFO - Running setup.py install for mozdevice 07:17:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:30 INFO - Running setup.py install for mozfile 07:17:30 INFO - Running setup.py install for mozhttpd 07:17:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:30 INFO - Running setup.py install for mozinfo 07:17:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Running setup.py install for mozInstall 07:17:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Running setup.py install for mozleak 07:17:31 INFO - Running setup.py install for mozlog 07:17:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Running setup.py install for moznetwork 07:17:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Running setup.py install for mozprocess 07:17:31 INFO - Running setup.py install for mozprofile 07:17:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:31 INFO - Running setup.py install for mozrunner 07:17:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:32 INFO - Running setup.py install for mozscreenshot 07:17:32 INFO - Running setup.py install for moztest 07:17:32 INFO - Running setup.py install for mozversion 07:17:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:32 INFO - Cleaning up... 07:17:32 INFO - Return code: 0 07:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:33 INFO - 'HOME': '/Users/cltbld', 07:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:33 INFO - 'LOGNAME': 'cltbld', 07:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:33 INFO - 'MOZ_NO_REMOTE': '1', 07:17:33 INFO - 'NO_EM_RESTART': '1', 07:17:33 INFO - 'PAGER': '/bin/cat', 07:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:33 INFO - 'PWD': '/builds/slave/test', 07:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:33 INFO - 'SHELL': '/bin/bash', 07:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:33 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:33 INFO - 'USER': 'cltbld', 07:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:33 INFO - 'XPC_FLAGS': '0x0', 07:17:33 INFO - 'XPC_SERVICE_NAME': '0', 07:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:33 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-KjnKJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:33 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-FGcaMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:33 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-29ZR_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-l0UF6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-OwA36E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Bh1Dxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-V0AAu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-tvPqmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Yt_UGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-WF4xPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Qwe1ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:34 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-XJaYka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:35 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-if7Mju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:35 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-OnGpOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:35 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-HWmO1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:35 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Ls6tsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:35 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-igKhNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:38 INFO - Downloading blessings-1.6.tar.gz 07:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:38 INFO - Installing collected packages: blessings 07:17:38 INFO - Running setup.py install for blessings 07:17:38 INFO - Successfully installed blessings 07:17:38 INFO - Cleaning up... 07:17:38 INFO - Return code: 0 07:17:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:39 INFO - Reading from file tmpfile_stdout 07:17:39 INFO - Current package versions: 07:17:39 INFO - blessings == 1.6 07:17:39 INFO - blobuploader == 1.2.4 07:17:39 INFO - docopt == 0.6.1 07:17:39 INFO - functools32 == 3.2.3-2 07:17:39 INFO - jsonschema == 2.5.1 07:17:39 INFO - manifestparser == 1.1 07:17:39 INFO - mozInstall == 1.12 07:17:39 INFO - mozcrash == 1.0 07:17:39 INFO - mozdebug == 0.1 07:17:39 INFO - mozdevice == 0.49 07:17:39 INFO - mozfile == 1.2 07:17:39 INFO - mozhttpd == 0.7 07:17:39 INFO - mozinfo == 0.9 07:17:39 INFO - mozleak == 0.1 07:17:39 INFO - mozlog == 3.4 07:17:39 INFO - moznetwork == 0.27 07:17:39 INFO - mozprocess == 0.24 07:17:39 INFO - mozprofile == 0.28 07:17:39 INFO - mozrunner == 6.13 07:17:39 INFO - mozscreenshot == 0.1 07:17:39 INFO - mozsystemmonitor == 0.3 07:17:39 INFO - moztest == 0.8 07:17:39 INFO - mozversion == 1.4 07:17:39 INFO - psutil == 3.1.1 07:17:39 INFO - requests == 1.2.3 07:17:39 INFO - wsgiref == 0.1.2 07:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:39 INFO - 'HOME': '/Users/cltbld', 07:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:39 INFO - 'LOGNAME': 'cltbld', 07:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:39 INFO - 'MOZ_NO_REMOTE': '1', 07:17:39 INFO - 'NO_EM_RESTART': '1', 07:17:39 INFO - 'PAGER': '/bin/cat', 07:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:39 INFO - 'PWD': '/builds/slave/test', 07:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:39 INFO - 'SHELL': '/bin/bash', 07:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:39 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:39 INFO - 'USER': 'cltbld', 07:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:39 INFO - 'XPC_FLAGS': '0x0', 07:17:39 INFO - 'XPC_SERVICE_NAME': '0', 07:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:39 INFO - Cleaning up... 07:17:39 INFO - Return code: 0 07:17:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:39 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 0x106f51b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f54768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb02468b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, '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.oRAFgoNVrF/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.CletfVHKva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:39 INFO - 'HOME': '/Users/cltbld', 07:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:39 INFO - 'LOGNAME': 'cltbld', 07:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:39 INFO - 'MOZ_NO_REMOTE': '1', 07:17:39 INFO - 'NO_EM_RESTART': '1', 07:17:39 INFO - 'PAGER': '/bin/cat', 07:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:39 INFO - 'PWD': '/builds/slave/test', 07:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:39 INFO - 'SHELL': '/bin/bash', 07:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:39 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:39 INFO - 'USER': 'cltbld', 07:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:39 INFO - 'XPC_FLAGS': '0x0', 07:17:39 INFO - 'XPC_SERVICE_NAME': '0', 07:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:17:39 INFO - Cleaning up... 07:17:39 INFO - Return code: 0 07:17:39 INFO - Running post-action listener: _resource_record_post_action 07:17:39 INFO - Running post-action listener: _start_resource_monitoring 07:17:39 INFO - Starting resource monitoring. 07:17:39 INFO - [mozharness: 2017-04-10 14:17:39.866174Z] Finished create-virtualenv step (success) 07:17:39 INFO - [mozharness: 2017-04-10 14:17:39.867026Z] Running install step. 07:17:39 INFO - Running pre-action listener: _resource_record_pre_action 07:17:39 INFO - Running main action method: install 07:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:40 INFO - Reading from file tmpfile_stdout 07:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:40 INFO - Reading from file tmpfile_stdout 07:17:40 INFO - Output received: 07:17:40 INFO - Usage: mozinstall [options] installer 07:17:40 INFO - Options: 07:17:40 INFO - -h, --help show this help message and exit 07:17:40 INFO - -d DEST, --destination=DEST 07:17:40 INFO - Directory to install application into. [default: 07:17:40 INFO - "/builds/slave/test"] 07:17:40 INFO - --app=APP Application being installed. [default: firefox] 07:17:40 INFO - mkdir: /builds/slave/test/build/application 07:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:17:54 INFO - Reading from file tmpfile_stdout 07:17:54 INFO - Output received: 07:17:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:17:54 INFO - Running post-action listener: _resource_record_post_action 07:17:54 INFO - [mozharness: 2017-04-10 14:17:54.935813Z] Finished install step (success) 07:17:54 INFO - [mozharness: 2017-04-10 14:17:54.935965Z] Running run-tests step. 07:17:54 INFO - Running pre-action listener: _resource_record_pre_action 07:17:54 INFO - Running main action method: run_tests 07:17:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:17:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:17:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:17:54 INFO - 2017-04-10 07:17:54.950 screenresolution[1628:7379] starting screenresolution argv=screenresolution get 07:17:54 INFO - 2017-04-10 07:17:54.953 screenresolution[1628:7379] Display 0: 1600x1200x32@60 07:17:54 INFO - 2017-04-10 07:17:54.958 screenresolution[1629:7381] starting screenresolution argv=screenresolution list 07:17:54 INFO - Available Modes on Display 0 07:17:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:17:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:17:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:17:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:17:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:17:55 INFO - Intel Iris: 07:17:55 INFO - Chipset Model: Intel Iris 07:17:55 INFO - Type: GPU 07:17:55 INFO - Bus: Built-In 07:17:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:17:55 INFO - Vendor: Intel (0x8086) 07:17:55 INFO - Device ID: 0x0a2e 07:17:55 INFO - Revision ID: 0x0009 07:17:55 INFO - Displays: 07:17:55 INFO - Display: 07:17:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:17:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:17:55 INFO - Display Serial Number: 1600x1200 60 07:17:55 INFO - Main Display: Yes 07:17:55 INFO - Mirror: Off 07:17:55 INFO - Online: Yes 07:17:55 INFO - Rotation: Supported 07:17:55 INFO - Return code: 0 07:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:55 INFO - Python 2.7.3 07:17:55 INFO - Return code: 0 07:17:55 INFO - grabbing minidump binary from tooltool 07:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:55 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 0x106d2fd30>, '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 0x106c56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d24be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:17:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:17:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:17:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:55 INFO - Return code: 0 07:17:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:17:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:17:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:55 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/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:17:55 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/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0287 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oRAFgoNVrF/Render', 07:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:55 INFO - 'HOME': '/Users/cltbld', 07:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:55 INFO - 'LOGNAME': 'cltbld', 07:17:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:55 INFO - 'MOZ_NO_REMOTE': '1', 07:17:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:55 INFO - 'NO_EM_RESTART': '1', 07:17:55 INFO - 'PAGER': '/bin/cat', 07:17:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:55 INFO - 'PWD': '/builds/slave/test', 07:17:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:55 INFO - 'SHELL': '/bin/bash', 07:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CletfVHKva/Listeners', 07:17:55 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 07:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:55 INFO - 'USER': 'cltbld', 07:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:55 INFO - 'XPC_FLAGS': '0x0', 07:17:55 INFO - 'XPC_SERVICE_NAME': '0', 07:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:55 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/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:17:55 INFO - mozversion application_buildid: 20170410055650 07:17:55 INFO - mozversion application_changeset: 0d25d01521602c090c320eb85d04c61cf005a041 07:17:55 INFO - mozversion application_display_name: Firefox 07:17:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:55 INFO - mozversion application_name: Firefox 07:17:55 INFO - mozversion application_remotingname: firefox 07:17:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:17:55 INFO - mozversion application_vendor: Mozilla 07:17:55 INFO - mozversion application_version: 53.0 07:17:55 INFO - mozversion platform_buildid: 20170410055650 07:17:55 INFO - mozversion platform_changeset: 0d25d01521602c090c320eb85d04c61cf005a041 07:17:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:17:55 INFO - mozversion platform_version: 53.0 07:17:55 INFO - using testdate: 1491833875 07:17:55 INFO - actual date: 1491833875 07:17:55 INFO - starting webserver on 'localhost:49248' 07:17:55 INFO - SUITE-START | Running 2 tests 07:17:55 INFO - TEST-START | dromaeo_css 07:17:55 INFO - operating with platform_type : mac_ 07:17:55 INFO - Initialising browser for dromaeo_css test... 07:17:55 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpx88apm/profile http://localhost:49248/getInfo.html) 07:17:57 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 07:17:57 INFO - PROCESS | 1639 | colorDepth:24 07:17:57 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 07:17:57 INFO - PROCESS | 1639 | __metrics 07:17:58 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:58 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:58 INFO - TEST-INFO | 1639: exit 0 07:17:58 INFO - Browser initialized. 07:17:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:58 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpx88apm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:10 INFO - PROCESS | 1642 | RSS: Main: 163688448 07:18:10 INFO - PROCESS | 1642 | 07:21:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 07:21:15 INFO - PROCESS | 1642 | RSS: Main: 311304192 07:21:15 INFO - PROCESS | 1642 | 07:24:17 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 07:24:18 INFO - PROCESS | 1642 | RSS: Main: 308457472 07:24:18 INFO - PROCESS | 1642 | 07:27:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 07:27:21 INFO - PROCESS | 1642 | RSS: Main: 277221376 07:27:21 INFO - PROCESS | 1642 | 07:30:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 07:30:24 INFO - PROCESS | 1642 | RSS: Main: 286171136 07:30:24 INFO - PROCESS | 1642 | 07:33:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 07:33:28 INFO - PROCESS | 1642 | RSS: Main: 264650752 07:33:28 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 07:36:31 INFO - PROCESS | 1642 | RSS: Main: 406298624 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | __start_tp_report 07:36:31 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 07:36:31 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 07:36:31 INFO - PROCESS | 1642 | |i|pagename|runs| 07:36:31 INFO - PROCESS | 1642 | |0;dojo.html;3264.836758162092;3512.2273099918025;3515.5254040704513;3534.24013837025;3579.3020361029594;5961.523078153748;5987.042073268278;6003.039513677802;6005.3394126646035;6008.3991600839945;4928.753562321878;5934.495567876736;5999.640021598696;6015.578909476339;6021.2473440819895;4719.716816990975;5346.492083252104;5368.758405871726;5377.623566350357;5385.272988146589;5292.914952434741;5295.894082118355;5318.547923426513;5430.59270554708;5431.701256430894;5393.622446428752;5407.053765591026;5408.567314614821;5412.702301373423;5413.485718856722;5362.544183744387;5394.676319420847;5397.325334333208;5400.891982160374;5417.133258678632;5232.947670523284;5357.758900849432;5365.248865158881;5373.516383525502;5379.112446446332;6087.452129308339;6138.0179171332375;6144.109104179869;6158.9692051539905;6164.506839452833;6245.094461303131;6304.495640348761;6318.115463835067;6319.020551814476;6327.5254355923025;6225.968870155665;6229.781957631461;6248.687565621746;6318.210223722035;6339.714712837934;6049.758009679652;6051.606645568068;6055.455009049163;6064.904062247181;6096.207493025967;6268;6425.967870160713;6463.192100987377;6468.126802881645;6483.448906842971;6232.0963460298;6250.249970003629;6283.59156654816;6307.306196318401;6321.96839015802;6331.778387756499;6334.1765570475545;6340.619562826153;6349.2698339690605;6355.205599300088;6297.4017468340435;6318.62088274705;6321.3994670507145;6334.271558770801;6341.809745707544;6221.004639257697;6282.2147231596055;6294.307626161119;6316.494680425555;6323.715432805535;5178.093833579109;5187.714675692798;5192.792288308426;5199.402068762065;5212.40057393397;4585.082983403266;4590.334401511762;4594.839180628729;4612.985143268475;4630.976845115752;5723.7424315905055;5940.079287710412;5976.312724036705;6058.909116363258;6071.848203794852;5678.801241956512;6259.4679452246155;6264.59280146789;6270.122182894398;6357.682115894187;6031.51341139415;6084.5132389408745;6086.695665216722;6090.421409966135;6139.508839292846;5575.665460072409;5623.437656234344;5629.4652008059165;5633.352164501053;5635.3237611486065;6367.458766004849;6437.195350581177;6502.317256687979;6545.083688283549;6563.409293163638;6385.425311721968;6412.9679351602945;6413.326600706859;6416.00551914454;6416.45460135875;5833.708314584339;6562.80311590653;6574.408303252731;6633.336666333521;6639.634820084942;6240.719167637558;6277.246730392382;6295.874082518416;6326.9876819708625;6328.6202827830475;6359.20509936258;6369.14016607752;6383.202099737533;6388.073729309317;6391.296957334783;6092.421219984094;6309.337519560564;6311.337309582611;6318.8736225274315;6352.396522330371;6226.657533835682;6253.718582663882;6259.029850373199;6262;6273.341299163522;6219.751209951552;6245.250569931637;6260.718267678057;6268.122462855113;6269.592476489013;6282.057691346335;6309.305976342507;6331.9366806331345;6343.714532845941;6350.142730731477;6116.42707509198;6135.538906165067;6191.1641928339095;6197.783077592263;6199.225096862892 07:36:31 INFO - PROCESS | 1642 | |1;ext.html;484.396925827345;524.6065450911816;534.078714217974;537.0279793573632;538.0906268406392;31804;41853.79073104634;43520.564794352045;43646.781766091204;45472;38100.23799524008;41709.58290417095;43695;44087.77956110215;44479.55520444795;8929.374943753939;9490.193333566654;9724.611015559369;9749.171320437772;9778;9004.234640055603;11594.362310072942;11843.822342664824;11870.940645296761;12172.57395991136;11903;11983.94008029963;11999.820002699922;12000.219985700902;12049.036077113853;11805.23265987708;11897.881021189763;11917.821232681517;11923.701907452296;11934.462949167308;11850;11880.40597970098;11884.584039558575;11888.04895608358;11891.881081189164;33995.830020849986;41508.1698366034;41872.162556749;41909.161816763495;41990.37014444786;4035.757854528738;4090.713650044498;4093.9181216375805;4102.712810103264;4128.91742165158;30470.69529304723;30649.69350306513;31462.528062079087;32552.837235813906;32593.185170370693;3305.7024867761775;3312.834358282076;3327.351166522529;3346.4478361070396;3465.7227421806447;496381.5180924108;500512;501163;501537;502772;64271.67864160649;64631;64698.676506617165;64771;64790.67604662041;66498;66747;66807.66596167085;66821.3317866815;66888.66555667287;17131.400400985905;17311.740323895152;17314.567135821453;17324.566885827957;17355.3057877686;10191.54138063789;12383.318917459446;13148.013898957617;13218.537351192663;13222.140560863512;14721.411143554353;16332.775041871908;16511.83488165103;16594.253258603392;16778.58053548671;6148.877022459616;6923.6192009439965;7146.785596432115;7155.463340249502;7169.283071692893;815.4943934760367;863.6588547523693;864.6195673903462;920.5673333533229;924.6393906376519;29788.851055745017;30680;30828.69171308303;31052.68947310543;31502.52746208809;1008.8436292374694;1104.3318792130644;1109.8668159820872;1151.5163631274884;1232.5131573028602;14455.409904910452;16270;16462.670746585;16485.752713709306;16720.41478548245;561308;565287.1735641295;566242;568534.1573292107;568554;62270.75458490805;62448.375516244254;62487.06269405963;62494;62509;1376.8210132682686;1401.1172961034483;1407.71141915907;1494.1856688104792;1512.9621759456102;26654.333641659112;29332;31885.36229275448;32549.67450325561;33192.336153276316;51806.74096629493;52305.7384713074;52380;52425;52448.47551524436;527172;528813;529491;531234.3438282938;532044;40793.59206407898;41137.79431102825;41828.3725744108;41921;41942.161156776085;48785.02429951452;49630.86662844923;49842.501574983784;49866.75066624644;50375.74812125916;32410.83794581012;33825.661743382254;33964.32071358609;34531.964041078805;34835.303293934485;32681.836590817846;32813.343733124726;33987.4901876477;33993.490097649046;34236.657633424344;38167;38405.6159438402;39424.40863386994;39465.40801887916;39561.60438395695;31725.5241171378;32250.35499290048;33554.32891342208;33732.13276871493;34139.80510682114;21626.6755998657;24193.39516512101;25056.99772009172;25549.616755748306;25616.487670246865 07:36:31 INFO - PROCESS | 1642 | |2;jquery.html;405.6653261059625;411.2966826726298;413.64013308421676;421.18080333750845;434.4656073030173;20253.696194557095;20761.273355432564;21811.127554897826;21971.450713732163;22017.559648807033;15620;17295.481135565955;19529.92585407802;22050.88974555129;22332.106715731392;5200.219967004941;5509.090999984997;5515.862103447426;5520.972395138018;5527;5413.53984911283;5478.780848766045;5491.862703432426;5536.584756143306;5975.163477113208;5259.6055295852775;6068.211132552762;6105.297890742577;6114.877702445949;6126.172966649512;5543.362513310981;5597.776088956437;5664.065429204176;6107.786227482039;6127.632342059468;5474.945250547484;5484.533814625762;5486.835394938158;5487.42382049887;5495.368032676253;13880;14010.85989140116;22576.54846903069;25760.969561217527;26798.928042878262;2555.3867071902796;2677.3574342157935;2699.5275826730244;2707.5803250496206;2714.2671478700836;10671.893281067167;10947.890521094767;10992.945035274852;13944.093633913762;15428.3828646854;1831.130213148757;1881.74596429483;1887.4715079777684;1897.791242963273;1911.0540282560082;103965;110620;112628;123384.38307808404;139006.3049684755;11153.38656373891;11695;12334.074944379208;12384.071194660437;12418.441170147365;16513.83486165123;16522.339106435607;16532.256048477608;16574.419895303847;16583.253753581117;8618.698345558001;9236.815263694689;9268.35121541499;9418.19945304643;9452.716418507456;9024.864627030469;9030.413023153606;9082;9131.086891310815;9210.677626283048;4932.013597280558;4975.328330675385;4978.083437876444;5011.223260394645;5021.322121513622;1807;2025.756909170909;2039.1333683184587;2069.379186244121;2084.270505323125;850.5534594337898;855.6662901468433;874.0865795243985;875.2166810704384;885.8936927568604;17193.828061719472;22092.668609970864;23406.297811065695;23603.763962360157;23802.404939876295;925.5372313843078;945.8817647794026;947.9715608531756;950.7195377363694;967.1827305926481;11720.120990925545;12023.939880300542;12203.08476864221;12299.385030748426;12376.257424554555;765399;772778;787418;788008;801396;130707;153981.69027464598;155195;161067.38932610757;166448;1038.2732087538752;1054.5201933120566;1068.3483075324045;1085.1102096281131;1089.6894385100209;18749.156287967347;19144.425667230007;21100.47248818792;21339.893300533397;21440.89279553592;48000.7599961998;58157.83684326374;61382.079268810114;62201;62302;87399.12600874164;90471.54764226137;91990.54004729934;93335.53332233567;94225;7804.9609751950875;8494.957525212334;8560.828783424173;8831.072737362741;8831.381803273709;9393;12903.483860645845;13060.542880999119;13344.866551334362;13458.461661533429;11179.049780768726;11220.326780393203;11341.659750207507;11552.133589980953;11651.650450486499;9984.850227246452;10118.696439106838;10319.742006449898;10395.688129356131;10902.400367979837;11564.94217528907;11597.82603260935;11679.708007299885;11862.644120676394;11951.940240298743;7329.9267007329245;7651.5409075455655;7745.264199901;7870.449068565145;8697.826043479221;10523.368597884151;11108.111351091731;11336.036436902627;11602.70993225176;11682.007029402595 07:36:31 INFO - PROCESS | 1642 | |3;mootools.html;1448.4713079725902;1469.5738235911579;1488.992555037225;1496.2443965797277;1498.4755335632526;8163.10205877353;8515.935508061491;8533.530655813927;8543.40196186268;8548.230659240668;7502.512336698111;7750.108737495189;8164;8346.91653083469;8359.74920752377;2373.359193017884;2405.675233843435;2410.09621391978;2412.601920683085;2412.7587241275905;2374.6794182785275;2405.230326295586;2405.4467472481338;2406.4344878953434;2409.289259668402;2368.95262094758;2372.2764556810166;2388.3312672451743;2388.653645221442;2398.0647547456506;2349.2482405630035;2362.2795047510504;2374.3114496795906;2378.452955820171;2379.381360846175;2333.673285739998;2360;2365.3377054424786;2376.061455724979;2387.0929046962215;8316.708915187999;8420.410571260014;8516.82966340676;8524.70163544273;8532.57337133141;5109.080365534202;5260.500252476047;5268.262443257947;5272;5273.947260527384;3152.67587613203;3422.161570415239;3452;3503.929921401583;3506.1409954561295;1250.8061250506096;1262.4066688656408;1291.0962326371578;1307.1634154141357;1309.332240557313;10832.079273261783;10931;10935.070519005814;10936.453177341102;10950.34297942126;4243.363495475642;4523;4565.748883811422;4599.5400459953735;4608.815647374135;8791.428557143892;8805.207531322212;8805.42764720291;8807.515586642796;8824;5196.76614552346;5200.427952925175;5203.985222881577;5206.219067139959;5210.895782084337;4408.074304396113;4548.727076375428;4567.634589232854;4844.75776211188;4871.3667223261455;3508.8421021054114;3671.6144804795645;3729.4778730977687;3833.3674943634546;3842.116313247913;996.1333639733479;1069.7699994501063;1182.1901997131993;1188.2810899405736;1199.964001079969;917.6696389299847;927.5686805635412;941.087145468894;955.4935883981501;1000.6547741029333;5560.388357280696;5663.150527420919;5736.627119237236;5881.794137205263;5916.053431450947;540.8512659018722;555.6194007105146;965.990539885821;998.3760149906309;1071.8606581144402;3740.6072362401555;3779.4897688812207;3796.677282430969;3839.865604703822;3936.9606303937167;8085.3531717462465;8653.913460865311;10148.188144948386;10151.086402223687;10152.086312231935;9449;9727.854082188773;10128.139108175741;10175.643852465128;10186;7788.766337009899;7848.568328741974;8012.879806802903;8042.879356809653;8043.195680432027;5413.377461591967;5413.485718856702;5497.202905578589;5584.553235741049;5619.550435965195;9296.767580810534;9318.394304370195;9320.021397753138;9329.766755831159;9343.859842102238;9061.68284110053;9247.352685311964;9351.579178936829;9489.051094890456;9494.572744226389;5921.792737254175;6125.908111378422;6729.259781423942;6764.4588432924265;6833;7619.54282743015;7690.961545192238;7825.0218722659665;8067.677292908218;8097.676092956452;6918.965405172942;7006.2643422439905;7016.298370162943;7049.577025378494;7114.822129446805;6880.036794848826;6917.827054323682;6926.549774264657;6962.1297337832775;6964.930350696631;6373.521985851173;6417.294097649348;6500.122483464861;6503.707333169924;6520.543561950808;4983.601311894967;4986.825461108844;5011.373578302712;5049.192129259301;5073.315102461121;4612.400387949545;4964.975175124101;4970.975145124251;5119.6416250862085;5137.51193636604 07:36:31 INFO - PROCESS | 1642 | |4;prototype.html;311.96412412572545;364.34599893191717;374.06483790523697;383.7678204686163;384.21236465246255;5368.543673787733;5388.110961691326;5553.361363443205;5631.746571404292;5644.604877658566;4433.667474939376;4926.482719314474;5363.061464243751;5415.918761218585;5497.39528651848;3376.0378292186733;4192.49690037196;4298.441202643668;4309.849155279566;4321.373400856874;3421.6407277235903;3626.854925802978;3726.5900750917376;4240.985531872367;4304.375865499501;3458.77517961333;4074.8777536673797;4124.97937510312;4131.7934103294865;4161.459010328653;4117.485314335708;4123.608257215575;4125.711200215971;4132.586741325874;4142.150859073882;3574.749767516249;3596.532450781408;3616.168281295317;3630.4735813306925;3633.400488919325;5174.948250517522;5180.611454140954;5343.786248550054;5352.57179425645;5426.321709786277;3892.2020985698146;4746;4757.122944799977;4778.880527986828;4787.784549695272;5761.625494342897;5779.508741756956;5802.462347477922;5808;5863.188927197313;3836.2135762168687;3941.7437866538585;3980.2835489611857;3983.601639836022;3985.043589538519;5315;6079.756809727605;6102.72537735803;6127.969360153171;6130.509559235251;3633.182533929845;4007.4189242559664;4024.63778259958;4035.7915457211;4039.4546736190237;3765.6799172070682;3807.485989391452;4010.8195131219163;4045.37296719009;4092.4626731426706;3797.6392242736897;4463.8214471421425;4690;4722.480527142012;4748.905021899612;5071.554606937005;5806.780576078986;5819.6508209507565;5835.883282334329;5855.707214639251;1233.8704436034266;1263.0148484182353;1304.934753262333;1311.3574348569132;1318.8351456067992;748.3190296829968;822.9629666665014;856.0497847389393;899.7615631857562;901.8827552418144;4137.751734895915;4798;4994.875128121754;5159.561437277798;5187.797883714204;5341.65279256847;5410.404855465896;5442.537384322298;5655.953648575027;5702.45826646468;4644.35418196714;4806.611339005993;5092.949070509321;5255.369355677343;5269.578433725293;2483.416397146669;2872.3250036241466;2921.547160190174;2961.48174069537;3001.6848230935875;4955.355803745562;5238.842834714965;5741.942580574141;5956.349424506053;5964;4986.351774269322;5398.9472052949295;5605.187247849039;5818.050952930816;5831.475167234969;5016.936281611906;5870.823875283749;6001.579889407787;6255.655938923312;6287.937120628735;4997.400311962442;5705.62913410627;6049.699314647372;6073.240844894388;6099.573029887865;5336.919946200733;5461;5737.881113182889;5898.9115163273445;5911.7635294587735;5423.430539793265;5752.8206717623625;6242.406971337716;6258.812235632939;6269.31037585856;3659.835307411226;3798.5631652360335;4007.0948562292106;4025.5370632377653;4025.698072644622;5423.806762512241;5444.428335024923;5522.950639378505;5779.479846813639;5983.192269043798;4702.764861756967;4979.676321039121;5445.237666726741;5660.320761508646;5870.706464676835;5551.500364967173;5825.242718446744;5848.56135789826;5858.677772722371;5873.970630146822;5354.4110147884485;5643.689597072036;5696.917585658712;5714.856928651756;5723.8855222896145;5071.949280507295;5080.669756465818;5379.811706590251;5816.738246778989;5835.533157347317;4879.365682461257;4999.200127979506;5011.523905228997;5600.103983362643;5656.60403771732 07:36:31 INFO - PROCESS | 1642 | |5;yui.html;750.8610906982206;761.0334874709116;791.1534657916029;867.4274978514181;875.8467268228061;15314.463993760206;16001.27994240259;16005.759913601305;16009.599760006005;16012.279447424864;13390.263535505543;13413.932930335335;13419.19484830911;13420;13430.12704174228;718.4144921888644;744.5011842065802;748.4648476339416;884.8097659003313;891.1756625121769;900.3877363392891;901.7700486375965;907.9137481939205;913.137085454246;913.5386629751999;966.9903300966971;969.2827307792219;970.815545046439;971.5627967414656;971.9854202186973;973.1728031173517;973.2651847854895;973.7030205787232;974.7514383832148;978.9657361992296;719.7732714195064;719.9712011519533;720.7333286683908;723.9493235473519;724.4313214126938;15579;15629.921850390789;15768.053916765031;16098.436554720529;16322.673546529002;14970;15052.623684407978;15266.847331526653;15453.922730386388;15528.145951972638;11851.644450666494;11969.162158648898;11991.880081199164;12014.3633733978;12134.514619415213;3840.788756618385;3872.8644497442738;3885.825137868803;4073.6944729145134;4075.8777236682945;116240.41879790547;117316;117606;119590.20614690786;120829;11807.527698891949;11839.822402663967;11859.288442693465;11974.063472061662;12081.516739330504;25413.74586254151;25476.363090922503;25491.745082548936;25499.87250063738;25522.10672626486;8103.970975597611;8116.147804480563;8134.837303253902;8179.918200817916;8454.577271136419;4445.17764213615;4449.710768800018;4516.954830451719;4575.22221222393;4610.2623580227;3620.1311685195365;3747.34421476246;3757.492738480325;3788.924221515554;3790.7156963227867;686.9141357330334;689.0628744906923;693.1405057728481;695.1310861423221;708.3624737736079;712.1454254894147;714.6426786606696;714.7010730456309;732.6410059071017;767.3822572828926;9754.804903901882;9958.203343732484;10036.447995360179;10190.64332748365;10825;699.8005568412977;702.1924786495571;705.1502938958542;705.3581241070601;721.6247551273309;4833.371661683958;5164.509371609766;5174.24973378858;5174.818881339211;5191.506806853343;97344.0265597335;100112.49831252391;100437;102083;102951.42621434524;74885;86645.13354866496;92800.53599731959;94218.52890735502;94280.0571994285;76187.61906190433;77069;78982;79083.81374279506;80606;9533.618655253713;9983.550740216562;10028.64899728506;10042.748931276776;10078.949605251926;52056.73971630118;53281;53955.46044539662;54527.72736136294;55024.72487637536;71294.93057604243;72721;73407;73766.63116684383;74388.62805685936;10987.340759554452;11302;11484.94257528707;11821.290722556674;12576.811347829607;12614;12708.127706218149;12979.28613926243;13201.273929933946;13472.124311919693;11642.359670218219;12011.75976480483;12115.454804533641;12165.452554634885;12441.44013519412;13945.790813137608;14283.357248923616;14461.349239284047;14693.412263509339;14724;13422.932885335511;14027.789583156466;14360.35378407995;14563.199024053778;14848;9219.308551858772;9775.657851975147;9854.260930430102;9912;10302;10555.366677999345;10619.94690026545;10735.141188704729;10964.06805421548;12028.518859245532 07:36:31 INFO - PROCESS | 1642 | __end_tp_report 07:36:31 INFO - PROCESS | 1642 | __start_cc_report 07:36:31 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1542 07:36:31 INFO - PROCESS | 1642 | __end_cc_report 07:36:31 INFO - PROCESS | 1642 | __startTimestamp1491834991803__endTimestamp 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | ------- Summary: start ------- 07:36:31 INFO - PROCESS | 1642 | Number of tests: 6 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5919.21 Median:6199.23 stddev:641.58 (10.3%) stddev-sans-first:608.82 07:36:31 INFO - PROCESS | 1642 | Values: 3264.8 3512.2 3515.5 3534.2 3579.3 5961.5 5987.0 6003.0 6005.3 6008.4 4928.8 5934.5 5999.6 6015.6 6021.2 4719.7 5346.5 5368.8 5377.6 5385.3 5292.9 5295.9 5318.5 5430.6 5431.7 5393.6 5407.1 5408.6 5412.7 5413.5 5362.5 5394.7 5397.3 5400.9 5417.1 5232.9 5357.8 5365.2 5373.5 5379.1 6087.5 6138.0 6144.1 6159.0 6164.5 6245.1 6304.5 6318.1 6319.0 6327.5 6226.0 6229.8 6248.7 6318.2 6339.7 6049.8 6051.6 6055.5 6064.9 6096.2 6268.0 6426.0 6463.2 6468.1 6483.4 6232.1 6250.2 6283.6 6307.3 6322.0 6331.8 6334.2 6340.6 6349.3 6355.2 6297.4 6318.6 6321.4 6334.3 6341.8 6221.0 6282.2 6294.3 6316.5 6323.7 5178.1 5187.7 5192.8 5199.4 5212.4 4585.1 4590.3 4594.8 4613.0 4631.0 5723.7 5940.1 5976.3 6058.9 6071.8 5678.8 6259.5 6264.6 6270.1 6357.7 6031.5 6084.5 6086.7 6090.4 6139.5 5575.7 5623.4 5629.5 5633.4 5635.3 6367.5 6437.2 6502.3 6545.1 6563.4 6385.4 6413.0 6413.3 6416.0 6416.5 5833.7 6562.8 6574.4 6633.3 6639.6 6240.7 6277.2 6295.9 6327.0 6328.6 6359.2 6369.1 6383.2 6388.1 6391.3 6092.4 6309.3 6311.3 6318.9 6352.4 6226.7 6253.7 6259.0 6262.0 6273.3 6219.8 6245.3 6260.7 6268.1 6269.6 6282.1 6309.3 6331.9 6343.7 6350.1 6116.4 6135.5 6191.2 6197.8 6199.2 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:68092.91 Median:36467.77 stddev:141742.14 (388.7%) stddev-sans-first:142048.87 07:36:31 INFO - PROCESS | 1642 | Values: 484.4 524.6 534.1 537.0 538.1 31804.0 41853.8 43520.6 43646.8 45472.0 38100.2 41709.6 43695.0 44087.8 44479.6 8929.4 9490.2 9724.6 9749.2 9778.0 9004.2 11594.4 11843.8 11870.9 12172.6 11903.0 11983.9 11999.8 12000.2 12049.0 11805.2 11897.9 11917.8 11923.7 11934.5 11850.0 11880.4 11884.6 11888.0 11891.9 33995.8 41508.2 41872.2 41909.2 41990.4 4035.8 4090.7 4093.9 4102.7 4128.9 30470.7 30649.7 31462.5 32552.8 32593.2 3305.7 3312.8 3327.4 3346.4 3465.7 496381.5 500512.0 501163.0 501537.0 502772.0 64271.7 64631.0 64698.7 64771.0 64790.7 66498.0 66747.0 66807.7 66821.3 66888.7 17131.4 17311.7 17314.6 17324.6 17355.3 10191.5 12383.3 13148.0 13218.5 13222.1 14721.4 16332.8 16511.8 16594.3 16778.6 6148.9 6923.6 7146.8 7155.5 7169.3 815.5 863.7 864.6 920.6 924.6 29788.9 30680.0 30828.7 31052.7 31502.5 1008.8 1104.3 1109.9 1151.5 1232.5 14455.4 16270.0 16462.7 16485.8 16720.4 561308.0 565287.2 566242.0 568534.2 568554.0 62270.8 62448.4 62487.1 62494.0 62509.0 1376.8 1401.1 1407.7 1494.2 1513.0 26654.3 29332.0 31885.4 32549.7 33192.3 51806.7 52305.7 52380.0 52425.0 52448.5 527172.0 528813.0 529491.0 531234.3 532044.0 40793.6 41137.8 41828.4 41921.0 41942.2 48785.0 49630.9 49842.5 49866.8 50375.7 32410.8 33825.7 33964.3 34532.0 34835.3 32681.8 32813.3 33987.5 33993.5 34236.7 38167.0 38405.6 39424.4 39465.4 39561.6 31725.5 32250.4 33554.3 33732.1 34139.8 21626.7 24193.4 25057.0 25549.6 25616.5 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:41554.89 Median:13178.90 stddev:129970.65 (986.2%) stddev-sans-first:130298.52 07:36:31 INFO - PROCESS | 1642 | Values: 405.7 411.3 413.6 421.2 434.5 20253.7 20761.3 21811.1 21971.5 22017.6 15620.0 17295.5 19529.9 22050.9 22332.1 5200.2 5509.1 5515.9 5521.0 5527.0 5413.5 5478.8 5491.9 5536.6 5975.2 5259.6 6068.2 6105.3 6114.9 6126.2 5543.4 5597.8 5664.1 6107.8 6127.6 5474.9 5484.5 5486.8 5487.4 5495.4 13880.0 14010.9 22576.5 25761.0 26798.9 2555.4 2677.4 2699.5 2707.6 2714.3 10671.9 10947.9 10992.9 13944.1 15428.4 1831.1 1881.7 1887.5 1897.8 1911.1 103965.0 110620.0 112628.0 123384.4 139006.3 11153.4 11695.0 12334.1 12384.1 12418.4 16513.8 16522.3 16532.3 16574.4 16583.3 8618.7 9236.8 9268.4 9418.2 9452.7 9024.9 9030.4 9082.0 9131.1 9210.7 4932.0 4975.3 4978.1 5011.2 5021.3 1807.0 2025.8 2039.1 2069.4 2084.3 850.6 855.7 874.1 875.2 885.9 17193.8 22092.7 23406.3 23603.8 23802.4 925.5 945.9 948.0 950.7 967.2 11720.1 12023.9 12203.1 12299.4 12376.3 765399.0 772778.0 787418.0 788008.0 801396.0 130707.0 153981.7 155195.0 161067.4 166448.0 1038.3 1054.5 1068.3 1085.1 1089.7 18749.2 19144.4 21100.5 21339.9 21440.9 48000.8 58157.8 61382.1 62201.0 62302.0 87399.1 90471.5 91990.5 93335.5 94225.0 7805.0 8495.0 8560.8 8831.1 8831.4 9393.0 12903.5 13060.5 13344.9 13458.5 11179.0 11220.3 11341.7 11552.1 11651.7 9984.9 10118.7 10319.7 10395.7 10902.4 11564.9 11597.8 11679.7 11862.6 11951.9 7329.9 7651.5 7745.3 7870.4 8697.8 10523.4 11108.1 11336.0 11602.7 11682.0 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5409.88 Median:5205.10 stddev:2916.87 (56.0%) stddev-sans-first:2909.86 07:36:31 INFO - PROCESS | 1642 | Values: 1448.5 1469.6 1489.0 1496.2 1498.5 8163.1 8515.9 8533.5 8543.4 8548.2 7502.5 7750.1 8164.0 8346.9 8359.7 2373.4 2405.7 2410.1 2412.6 2412.8 2374.7 2405.2 2405.4 2406.4 2409.3 2369.0 2372.3 2388.3 2388.7 2398.1 2349.2 2362.3 2374.3 2378.5 2379.4 2333.7 2360.0 2365.3 2376.1 2387.1 8316.7 8420.4 8516.8 8524.7 8532.6 5109.1 5260.5 5268.3 5272.0 5273.9 3152.7 3422.2 3452.0 3503.9 3506.1 1250.8 1262.4 1291.1 1307.2 1309.3 10832.1 10931.0 10935.1 10936.5 10950.3 4243.4 4523.0 4565.7 4599.5 4608.8 8791.4 8805.2 8805.4 8807.5 8824.0 5196.8 5200.4 5204.0 5206.2 5210.9 4408.1 4548.7 4567.6 4844.8 4871.4 3508.8 3671.6 3729.5 3833.4 3842.1 996.1 1069.8 1182.2 1188.3 1200.0 917.7 927.6 941.1 955.5 1000.7 5560.4 5663.2 5736.6 5881.8 5916.1 540.9 555.6 966.0 998.4 1071.9 3740.6 3779.5 3796.7 3839.9 3937.0 8085.4 8653.9 10148.2 10151.1 10152.1 9449.0 9727.9 10128.1 10175.6 10186.0 7788.8 7848.6 8012.9 8042.9 8043.2 5413.4 5413.5 5497.2 5584.6 5619.6 9296.8 9318.4 9320.0 9329.8 9343.9 9061.7 9247.4 9351.6 9489.1 9494.6 5921.8 6125.9 6729.3 6764.5 6833.0 7619.5 7691.0 7825.0 8067.7 8097.7 6919.0 7006.3 7016.3 7049.6 7114.8 6880.0 6917.8 6926.5 6962.1 6964.9 6373.5 6417.3 6500.1 6503.7 6520.5 4983.6 4986.8 5011.4 5049.2 5073.3 4612.4 4965.0 4971.0 5119.6 5137.5 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4613.44 Median:5167.25 stddev:1428.45 (27.6%) stddev-sans-first:1395.49 07:36:31 INFO - PROCESS | 1642 | Values: 312.0 364.3 374.1 383.8 384.2 5368.5 5388.1 5553.4 5631.7 5644.6 4433.7 4926.5 5363.1 5415.9 5497.4 3376.0 4192.5 4298.4 4309.8 4321.4 3421.6 3626.9 3726.6 4241.0 4304.4 3458.8 4074.9 4125.0 4131.8 4161.5 4117.5 4123.6 4125.7 4132.6 4142.2 3574.7 3596.5 3616.2 3630.5 3633.4 5174.9 5180.6 5343.8 5352.6 5426.3 3892.2 4746.0 4757.1 4778.9 4787.8 5761.6 5779.5 5802.5 5808.0 5863.2 3836.2 3941.7 3980.3 3983.6 3985.0 5315.0 6079.8 6102.7 6128.0 6130.5 3633.2 4007.4 4024.6 4035.8 4039.5 3765.7 3807.5 4010.8 4045.4 4092.5 3797.6 4463.8 4690.0 4722.5 4748.9 5071.6 5806.8 5819.7 5835.9 5855.7 1233.9 1263.0 1304.9 1311.4 1318.8 748.3 823.0 856.0 899.8 901.9 4137.8 4798.0 4994.9 5159.6 5187.8 5341.7 5410.4 5442.5 5656.0 5702.5 4644.4 4806.6 5092.9 5255.4 5269.6 2483.4 2872.3 2921.5 2961.5 3001.7 4955.4 5238.8 5741.9 5956.3 5964.0 4986.4 5398.9 5605.2 5818.1 5831.5 5016.9 5870.8 6001.6 6255.7 6287.9 4997.4 5705.6 6049.7 6073.2 6099.6 5336.9 5461.0 5737.9 5898.9 5911.8 5423.4 5752.8 6242.4 6258.8 6269.3 3659.8 3798.6 4007.1 4025.5 4025.7 5423.8 5444.4 5523.0 5779.5 5983.2 4702.8 4979.7 5445.2 5660.3 5870.7 5551.5 5825.2 5848.6 5858.7 5874.0 5354.4 5643.7 5696.9 5714.9 5723.9 5071.9 5080.7 5379.8 5816.7 5835.5 4879.4 4999.2 5011.5 5600.1 5656.6 07:36:31 INFO - PROCESS | 1642 | 07:36:31 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21156.05 Median:4260.53 stddev:30625.06 (718.8%) stddev-sans-first:30672.65 07:36:31 INFO - PROCESS | 1642 | Values: 750.9 761.0 791.2 867.4 875.8 15314.5 16001.3 16005.8 16009.6 16012.3 13390.3 13413.9 13419.2 13420.0 13430.1 718.4 744.5 748.5 884.8 891.2 900.4 901.8 907.9 913.1 913.5 967.0 969.3 970.8 971.6 972.0 973.2 973.3 973.7 974.8 979.0 719.8 720.0 720.7 723.9 724.4 15579.0 15629.9 15768.1 16098.4 16322.7 14970.0 15052.6 15266.8 15453.9 15528.1 11851.6 11969.2 11991.9 12014.4 12134.5 3840.8 3872.9 3885.8 4073.7 4075.9 116240.4 117316.0 117606.0 119590.2 120829.0 11807.5 11839.8 11859.3 11974.1 12081.5 25413.7 25476.4 25491.7 25499.9 25522.1 8104.0 8116.1 8134.8 8179.9 8454.6 4445.2 4449.7 4517.0 4575.2 4610.3 3620.1 3747.3 3757.5 3788.9 3790.7 686.9 689.1 693.1 695.1 708.4 712.1 714.6 714.7 732.6 767.4 9754.8 9958.2 10036.4 10190.6 10825.0 699.8 702.2 705.2 705.4 721.6 4833.4 5164.5 5174.2 5174.8 5191.5 97344.0 100112.5 100437.0 102083.0 102951.4 74885.0 86645.1 92800.5 94218.5 94280.1 76187.6 77069.0 78982.0 79083.8 80606.0 9533.6 9983.6 10028.6 10042.7 10078.9 52056.7 53281.0 53955.5 54527.7 55024.7 71294.9 72721.0 73407.0 73766.6 74388.6 10987.3 11302.0 11484.9 11821.3 12576.8 12614.0 12708.1 12979.3 13201.3 13472.1 11642.4 12011.8 12115.5 12165.5 12441.4 13945.8 14283.4 14461.3 14693.4 14724.0 13422.9 14027.8 14360.4 14563.2 14848.0 9219.3 9775.7 9854.3 9912.0 10302.0 10555.4 10619.9 10735.1 10964.1 12028.5 07:36:31 INFO - PROCESS | 1642 | -------- Summary: end -------- 07:36:31 INFO - PROCESS | 1642 | 07:36:32 INFO - TEST-INFO | 1642: exit 0 07:36:32 INFO - TEST-OK | dromaeo_css | took 1116870ms 07:36:32 INFO - TEST-START | kraken 07:36:32 INFO - operating with platform_type : mac_ 07:36:32 INFO - Initialising browser for kraken test... 07:36:32 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpGT7pZC/profile http://localhost:49248/getInfo.html) 07:36:34 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 07:36:34 INFO - PROCESS | 1653 | colorDepth:24 07:36:34 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 07:36:34 INFO - PROCESS | 1653 | __metrics 07:36:34 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:34 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:35 INFO - TEST-INFO | 1653: exit 0 07:36:35 INFO - Browser initialized. 07:36:35 INFO - Running cycle 1/1 for kraken test... 07:36:35 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpGT7pZC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:47 INFO - PROCESS | 1655 | RSS: Main: 163708928 07:36:47 INFO - PROCESS | 1655 | 07:36:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:50 INFO - PROCESS | 1655 | RSS: Main: 214675456 07:36:50 INFO - PROCESS | 1655 | 07:36:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 07:36:53 INFO - PROCESS | 1655 | RSS: Main: 227287040 07:36:53 INFO - PROCESS | 1655 | 07:36:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 07:36:57 INFO - PROCESS | 1655 | RSS: Main: 324255744 07:36:57 INFO - PROCESS | 1655 | 07:36:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 07:37:00 INFO - PROCESS | 1655 | RSS: Main: 227340288 07:37:00 INFO - PROCESS | 1655 | 07:37:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:03 INFO - PROCESS | 1655 | RSS: Main: 230289408 07:37:03 INFO - PROCESS | 1655 | 07:37:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:06 INFO - PROCESS | 1655 | RSS: Main: 269467648 07:37:06 INFO - PROCESS | 1655 | 07:37:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:09 INFO - PROCESS | 1655 | RSS: Main: 270135296 07:37:09 INFO - PROCESS | 1655 | 07:37:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 07:37:13 INFO - PROCESS | 1655 | RSS: Main: 269033472 07:37:13 INFO - PROCESS | 1655 | 07:37:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:15 INFO - PROCESS | 1655 | RSS: Main: 244772864 07:37:15 INFO - PROCESS | 1655 | 07:37:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:17 INFO - PROCESS | 1655 | RSS: Main: 246546432 07:37:17 INFO - PROCESS | 1655 | 07:37:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:20 INFO - PROCESS | 1655 | RSS: Main: 252719104 07:37:20 INFO - PROCESS | 1655 | 07:37:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:24 INFO - PROCESS | 1655 | RSS: Main: 267350016 07:37:24 INFO - PROCESS | 1655 | 07:37:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:27 INFO - PROCESS | 1655 | RSS: Main: 260665344 07:37:27 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 07:37:29 INFO - PROCESS | 1655 | RSS: Main: 304635904 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | __start_tp_report 07:37:29 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 07:37:29 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 07:37:29 INFO - PROCESS | 1655 | |i|pagename|runs| 07:37:29 INFO - PROCESS | 1655 | |0;ai-astar;101;113;114;112;113;113;112;113;115;114 07:37:29 INFO - PROCESS | 1655 | |1;audio-beat-detection;141;108;108;143;107;108;107;105;127;106 07:37:29 INFO - PROCESS | 1655 | |2;audio-dft;182;180;200;256;183;182;182;185;181;184 07:37:29 INFO - PROCESS | 1655 | |3;audio-fft;81;59;60;106;86;84;63;57;73;58 07:37:29 INFO - PROCESS | 1655 | |4;audio-oscillator;87;70;85;69;66;69;81;67;68;82 07:37:29 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;85;88;85;87;85;88;85;88;84 07:37:29 INFO - PROCESS | 1655 | |6;imaging-darkroom;93;93;95;94;93;94;94;94;93;93 07:37:29 INFO - PROCESS | 1655 | |7;imaging-desaturate;88;84;88;88;85;87;88;87;87;84 07:37:29 INFO - PROCESS | 1655 | |8;json-parse-financial;56;54;55;49;52;82;56;56;55;55 07:37:29 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;64;73;68;80;72;68;68;70;69;70 07:37:29 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;81;79;83;83;80;80;82;80;85;80 07:37:29 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;133;133;136;118;144;142;146;143;170;134 07:37:29 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;164;161;162;161;219;221;161;161;161;160 07:37:29 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;64;74;71;87;83;83;71;61;63;62 07:37:29 INFO - PROCESS | 1655 | __end_tp_report 07:37:29 INFO - PROCESS | 1655 | __start_cc_report 07:37:29 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1987 07:37:29 INFO - PROCESS | 1655 | __end_cc_report 07:37:29 INFO - PROCESS | 1655 | __startTimestamp1491835049818__endTimestamp 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | ------- Summary: start ------- 07:37:29 INFO - PROCESS | 1655 | Number of tests: 14 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.97 (3.5%) stddev-sans-first:0.97 07:37:29 INFO - PROCESS | 1655 | Values: 101.0 113.0 114.0 112.0 113.0 113.0 112.0 113.0 115.0 114.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:108.00 stddev:15.09 (14.0%) stddev-sans-first:13.02 07:37:29 INFO - PROCESS | 1655 | Values: 141.0 108.0 108.0 143.0 107.0 108.0 107.0 105.0 127.0 106.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:191.50 Median:183.50 stddev:23.37 (12.7%) stddev-sans-first:24.54 07:37:29 INFO - PROCESS | 1655 | Values: 182.0 180.0 200.0 256.0 183.0 182.0 182.0 185.0 181.0 184.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:72.70 Median:68.00 stddev:16.29 (24.0%) stddev-sans-first:17.00 07:37:29 INFO - PROCESS | 1655 | Values: 81.0 59.0 60.0 106.0 86.0 84.0 63.0 57.0 73.0 58.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:74.40 Median:75.50 stddev:8.28 (11.0%) stddev-sans-first:7.42 07:37:29 INFO - PROCESS | 1655 | Values: 87.0 70.0 85.0 69.0 66.0 69.0 81.0 67.0 68.0 82.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 07:37:29 INFO - PROCESS | 1655 | Values: 88.0 85.0 88.0 85.0 87.0 85.0 88.0 85.0 88.0 84.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:37:29 INFO - PROCESS | 1655 | Values: 93.0 93.0 95.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 07:37:29 INFO - PROCESS | 1655 | Values: 88.0 84.0 88.0 88.0 85.0 87.0 88.0 87.0 87.0 84.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.50 stddev:9.06 (16.3%) stddev-sans-first:9.60 07:37:29 INFO - PROCESS | 1655 | Values: 56.0 54.0 55.0 49.0 52.0 82.0 56.0 56.0 55.0 55.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:4.24 (6.1%) stddev-sans-first:3.86 07:37:29 INFO - PROCESS | 1655 | Values: 64.0 73.0 68.0 80.0 72.0 68.0 68.0 70.0 69.0 70.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:1.89 (2.3%) stddev-sans-first:2.00 07:37:29 INFO - PROCESS | 1655 | Values: 81.0 79.0 83.0 83.0 80.0 80.0 82.0 80.0 85.0 80.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:142.50 stddev:13.33 (9.4%) stddev-sans-first:13.90 07:37:29 INFO - PROCESS | 1655 | Values: 133.0 133.0 136.0 118.0 144.0 142.0 146.0 143.0 170.0 134.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:161.50 stddev:24.75 (15.3%) stddev-sans-first:26.03 07:37:29 INFO - PROCESS | 1655 | Values: 164.0 161.0 162.0 161.0 219.0 221.0 161.0 161.0 161.0 160.0 07:37:29 INFO - PROCESS | 1655 | 07:37:29 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.50 stddev:9.65 (13.3%) stddev-sans-first:9.81 07:37:29 INFO - PROCESS | 1655 | Values: 64.0 74.0 71.0 87.0 83.0 83.0 71.0 61.0 63.0 62.0 07:37:29 INFO - PROCESS | 1655 | -------- Summary: end -------- 07:37:29 INFO - PROCESS | 1655 | 07:37:30 INFO - TEST-INFO | 1655: exit 0 07:37:30 INFO - TEST-OK | kraken | took 58279ms 07:37:30 INFO - SUITE-END | took 1175s 07:37:30 INFO - Completed test suite (00:19:35) 07:37:30 INFO - javascript benchmark 07:37:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.836758162092, 3512.2273099918025, 3515.5254040704513, 3534.24013837025, 3579.3020361029594, 5961.523078153748, 5987.042073268278, 6003.039513677802, 6005.3394126646035, 6008.3991600839945, 4928.753562321878, 5934.495567876736, 5999.640021598696, 6015.578909476339, 6021.2473440819895, 4719.716816990975, 5346.492083252104, 5368.758405871726, 5377.623566350357, 5385.272988146589, 5292.914952434741, 5295.894082118355, 5318.547923426513, 5430.59270554708, 5431.701256430894, 5393.622446428752, 5407.053765591026, 5408.567314614821, 5412.702301373423, 5413.485718856722, 5362.544183744387, 5394.676319420847, 5397.325334333208, 5400.891982160374, 5417.133258678632, 5232.947670523284, 5357.758900849432, 5365.248865158881, 5373.516383525502, 5379.112446446332, 6087.452129308339, 6138.0179171332375, 6144.109104179869, 6158.9692051539905, 6164.506839452833, 6245.094461303131, 6304.495640348761, 6318.115463835067, 6319.020551814476, 6327.5254355923025, 6225.968870155665, 6229.781957631461, 6248.687565621746, 6318.210223722035, 6339.714712837934, 6049.758009679652, 6051.606645568068, 6055.455009049163, 6064.904062247181, 6096.207493025967, 6268.0, 6425.967870160713, 6463.192100987377, 6468.126802881645, 6483.448906842971, 6232.0963460298, 6250.249970003629, 6283.59156654816, 6307.306196318401, 6321.96839015802, 6331.778387756499, 6334.1765570475545, 6340.619562826153, 6349.2698339690605, 6355.205599300088, 6297.4017468340435, 6318.62088274705, 6321.3994670507145, 6334.271558770801, 6341.809745707544, 6221.004639257697, 6282.2147231596055, 6294.307626161119, 6316.494680425555, 6323.715432805535, 5178.093833579109, 5187.714675692798, 5192.792288308426, 5199.402068762065, 5212.40057393397, 4585.082983403266, 4590.334401511762, 4594.839180628729, 4612.985143268475, 4630.976845115752, 5723.7424315905055, 5940.079287710412, 5976.312724036705, 6058.909116363258, 6071.848203794852, 5678.801241956512, 6259.4679452246155, 6264.59280146789, 6270.122182894398, 6357.682115894187, 6031.51341139415, 6084.5132389408745, 6086.695665216722, 6090.421409966135, 6139.508839292846, 5575.665460072409, 5623.437656234344, 5629.4652008059165, 5633.352164501053, 5635.3237611486065, 6367.458766004849, 6437.195350581177, 6502.317256687979, 6545.083688283549, 6563.409293163638, 6385.425311721968, 6412.9679351602945, 6413.326600706859, 6416.00551914454, 6416.45460135875, 5833.708314584339, 6562.80311590653, 6574.408303252731, 6633.336666333521, 6639.634820084942, 6240.719167637558, 6277.246730392382, 6295.874082518416, 6326.9876819708625, 6328.6202827830475, 6359.20509936258, 6369.14016607752, 6383.202099737533, 6388.073729309317, 6391.296957334783, 6092.421219984094, 6309.337519560564, 6311.337309582611, 6318.8736225274315, 6352.396522330371, 6226.657533835682, 6253.718582663882, 6259.029850373199, 6262.0, 6273.341299163522, 6219.751209951552, 6245.250569931637, 6260.718267678057, 6268.122462855113, 6269.592476489013, 6282.057691346335, 6309.305976342507, 6331.9366806331345, 6343.714532845941, 6350.142730731477, 6116.42707509198, 6135.538906165067, 6191.1641928339095, 6197.783077592263, 6199.225096862892], "value": 5879.018175126583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.396925827345, 524.6065450911816, 534.078714217974, 537.0279793573632, 538.0906268406392, 31804.0, 41853.79073104634, 43520.564794352045, 43646.781766091204, 45472.0, 38100.23799524008, 41709.58290417095, 43695.0, 44087.77956110215, 44479.55520444795, 8929.374943753939, 9490.193333566654, 9724.611015559369, 9749.171320437772, 9778.0, 9004.234640055603, 11594.362310072942, 11843.822342664824, 11870.940645296761, 12172.57395991136, 11903.0, 11983.94008029963, 11999.820002699922, 12000.219985700902, 12049.036077113853, 11805.23265987708, 11897.881021189763, 11917.821232681517, 11923.701907452296, 11934.462949167308, 11850.0, 11880.40597970098, 11884.584039558575, 11888.04895608358, 11891.881081189164, 33995.830020849986, 41508.1698366034, 41872.162556749, 41909.161816763495, 41990.37014444786, 4035.757854528738, 4090.713650044498, 4093.9181216375805, 4102.712810103264, 4128.91742165158, 30470.69529304723, 30649.69350306513, 31462.528062079087, 32552.837235813906, 32593.185170370693, 3305.7024867761775, 3312.834358282076, 3327.351166522529, 3346.4478361070396, 3465.7227421806447, 496381.5180924108, 500512.0, 501163.0, 501537.0, 502772.0, 64271.67864160649, 64631.0, 64698.676506617165, 64771.0, 64790.67604662041, 66498.0, 66747.0, 66807.66596167085, 66821.3317866815, 66888.66555667287, 17131.400400985905, 17311.740323895152, 17314.567135821453, 17324.566885827957, 17355.3057877686, 10191.54138063789, 12383.318917459446, 13148.013898957617, 13218.537351192663, 13222.140560863512, 14721.411143554353, 16332.775041871908, 16511.83488165103, 16594.253258603392, 16778.58053548671, 6148.877022459616, 6923.6192009439965, 7146.785596432115, 7155.463340249502, 7169.283071692893, 815.4943934760367, 863.6588547523693, 864.6195673903462, 920.5673333533229, 924.6393906376519, 29788.851055745017, 30680.0, 30828.69171308303, 31052.68947310543, 31502.52746208809, 1008.8436292374694, 1104.3318792130644, 1109.8668159820872, 1151.5163631274884, 1232.5131573028602, 14455.409904910452, 16270.0, 16462.670746585, 16485.752713709306, 16720.41478548245, 561308.0, 565287.1735641295, 566242.0, 568534.1573292107, 568554.0, 62270.75458490805, 62448.375516244254, 62487.06269405963, 62494.0, 62509.0, 1376.8210132682686, 1401.1172961034483, 1407.71141915907, 1494.1856688104792, 1512.9621759456102, 26654.333641659112, 29332.0, 31885.36229275448, 32549.67450325561, 33192.336153276316, 51806.74096629493, 52305.7384713074, 52380.0, 52425.0, 52448.47551524436, 527172.0, 528813.0, 529491.0, 531234.3438282938, 532044.0, 40793.59206407898, 41137.79431102825, 41828.3725744108, 41921.0, 41942.161156776085, 48785.02429951452, 49630.86662844923, 49842.501574983784, 49866.75066624644, 50375.74812125916, 32410.83794581012, 33825.661743382254, 33964.32071358609, 34531.964041078805, 34835.303293934485, 32681.836590817846, 32813.343733124726, 33987.4901876477, 33993.490097649046, 34236.657633424344, 38167.0, 38405.6159438402, 39424.40863386994, 39465.40801887916, 39561.60438395695, 31725.5241171378, 32250.35499290048, 33554.32891342208, 33732.13276871493, 34139.80510682114, 21626.6755998657, 24193.39516512101, 25056.99772009172, 25549.616755748306, 25616.487670246865], "value": 20698.34136284032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6653261059625, 411.2966826726298, 413.64013308421676, 421.18080333750845, 434.4656073030173, 20253.696194557095, 20761.273355432564, 21811.127554897826, 21971.450713732163, 22017.559648807033, 15620.0, 17295.481135565955, 19529.92585407802, 22050.88974555129, 22332.106715731392, 5200.219967004941, 5509.090999984997, 5515.862103447426, 5520.972395138018, 5527.0, 5413.53984911283, 5478.780848766045, 5491.862703432426, 5536.584756143306, 5975.163477113208, 5259.6055295852775, 6068.211132552762, 6105.297890742577, 6114.877702445949, 6126.172966649512, 5543.362513310981, 5597.776088956437, 5664.065429204176, 6107.786227482039, 6127.632342059468, 5474.945250547484, 5484.533814625762, 5486.835394938158, 5487.42382049887, 5495.368032676253, 13880.0, 14010.85989140116, 22576.54846903069, 25760.969561217527, 26798.928042878262, 2555.3867071902796, 2677.3574342157935, 2699.5275826730244, 2707.5803250496206, 2714.2671478700836, 10671.893281067167, 10947.890521094767, 10992.945035274852, 13944.093633913762, 15428.3828646854, 1831.130213148757, 1881.74596429483, 1887.4715079777684, 1897.791242963273, 1911.0540282560082, 103965.0, 110620.0, 112628.0, 123384.38307808404, 139006.3049684755, 11153.38656373891, 11695.0, 12334.074944379208, 12384.071194660437, 12418.441170147365, 16513.83486165123, 16522.339106435607, 16532.256048477608, 16574.419895303847, 16583.253753581117, 8618.698345558001, 9236.815263694689, 9268.35121541499, 9418.19945304643, 9452.716418507456, 9024.864627030469, 9030.413023153606, 9082.0, 9131.086891310815, 9210.677626283048, 4932.013597280558, 4975.328330675385, 4978.083437876444, 5011.223260394645, 5021.322121513622, 1807.0, 2025.756909170909, 2039.1333683184587, 2069.379186244121, 2084.270505323125, 850.5534594337898, 855.6662901468433, 874.0865795243985, 875.2166810704384, 885.8936927568604, 17193.828061719472, 22092.668609970864, 23406.297811065695, 23603.763962360157, 23802.404939876295, 925.5372313843078, 945.8817647794026, 947.9715608531756, 950.7195377363694, 967.1827305926481, 11720.120990925545, 12023.939880300542, 12203.08476864221, 12299.385030748426, 12376.257424554555, 765399.0, 772778.0, 787418.0, 788008.0, 801396.0, 130707.0, 153981.69027464598, 155195.0, 161067.38932610757, 166448.0, 1038.2732087538752, 1054.5201933120566, 1068.3483075324045, 1085.1102096281131, 1089.6894385100209, 18749.156287967347, 19144.425667230007, 21100.47248818792, 21339.893300533397, 21440.89279553592, 48000.7599961998, 58157.83684326374, 61382.079268810114, 62201.0, 62302.0, 87399.12600874164, 90471.54764226137, 91990.54004729934, 93335.53332233567, 94225.0, 7804.9609751950875, 8494.957525212334, 8560.828783424173, 8831.072737362741, 8831.381803273709, 9393.0, 12903.483860645845, 13060.542880999119, 13344.866551334362, 13458.461661533429, 11179.049780768726, 11220.326780393203, 11341.659750207507, 11552.133589980953, 11651.650450486499, 9984.850227246452, 10118.696439106838, 10319.742006449898, 10395.688129356131, 10902.400367979837, 11564.94217528907, 11597.82603260935, 11679.708007299885, 11862.644120676394, 11951.940240298743, 7329.9267007329245, 7651.5409075455655, 7745.264199901, 7870.449068565145, 8697.826043479221, 10523.368597884151, 11108.111351091731, 11336.036436902627, 11602.70993225176, 11682.007029402595], "value": 9998.292246166944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.4713079725902, 1469.5738235911579, 1488.992555037225, 1496.2443965797277, 1498.4755335632526, 8163.10205877353, 8515.935508061491, 8533.530655813927, 8543.40196186268, 8548.230659240668, 7502.512336698111, 7750.108737495189, 8164.0, 8346.91653083469, 8359.74920752377, 2373.359193017884, 2405.675233843435, 2410.09621391978, 2412.601920683085, 2412.7587241275905, 2374.6794182785275, 2405.230326295586, 2405.4467472481338, 2406.4344878953434, 2409.289259668402, 2368.95262094758, 2372.2764556810166, 2388.3312672451743, 2388.653645221442, 2398.0647547456506, 2349.2482405630035, 2362.2795047510504, 2374.3114496795906, 2378.452955820171, 2379.381360846175, 2333.673285739998, 2360.0, 2365.3377054424786, 2376.061455724979, 2387.0929046962215, 8316.708915187999, 8420.410571260014, 8516.82966340676, 8524.70163544273, 8532.57337133141, 5109.080365534202, 5260.500252476047, 5268.262443257947, 5272.0, 5273.947260527384, 3152.67587613203, 3422.161570415239, 3452.0, 3503.929921401583, 3506.1409954561295, 1250.8061250506096, 1262.4066688656408, 1291.0962326371578, 1307.1634154141357, 1309.332240557313, 10832.079273261783, 10931.0, 10935.070519005814, 10936.453177341102, 10950.34297942126, 4243.363495475642, 4523.0, 4565.748883811422, 4599.5400459953735, 4608.815647374135, 8791.428557143892, 8805.207531322212, 8805.42764720291, 8807.515586642796, 8824.0, 5196.76614552346, 5200.427952925175, 5203.985222881577, 5206.219067139959, 5210.895782084337, 4408.074304396113, 4548.727076375428, 4567.634589232854, 4844.75776211188, 4871.3667223261455, 3508.8421021054114, 3671.6144804795645, 3729.4778730977687, 3833.3674943634546, 3842.116313247913, 996.1333639733479, 1069.7699994501063, 1182.1901997131993, 1188.2810899405736, 1199.964001079969, 917.6696389299847, 927.5686805635412, 941.087145468894, 955.4935883981501, 1000.6547741029333, 5560.388357280696, 5663.150527420919, 5736.627119237236, 5881.794137205263, 5916.053431450947, 540.8512659018722, 555.6194007105146, 965.990539885821, 998.3760149906309, 1071.8606581144402, 3740.6072362401555, 3779.4897688812207, 3796.677282430969, 3839.865604703822, 3936.9606303937167, 8085.3531717462465, 8653.913460865311, 10148.188144948386, 10151.086402223687, 10152.086312231935, 9449.0, 9727.854082188773, 10128.139108175741, 10175.643852465128, 10186.0, 7788.766337009899, 7848.568328741974, 8012.879806802903, 8042.879356809653, 8043.195680432027, 5413.377461591967, 5413.485718856702, 5497.202905578589, 5584.553235741049, 5619.550435965195, 9296.767580810534, 9318.394304370195, 9320.021397753138, 9329.766755831159, 9343.859842102238, 9061.68284110053, 9247.352685311964, 9351.579178936829, 9489.051094890456, 9494.572744226389, 5921.792737254175, 6125.908111378422, 6729.259781423942, 6764.4588432924265, 6833.0, 7619.54282743015, 7690.961545192238, 7825.0218722659665, 8067.677292908218, 8097.676092956452, 6918.965405172942, 7006.2643422439905, 7016.298370162943, 7049.577025378494, 7114.822129446805, 6880.036794848826, 6917.827054323682, 6926.549774264657, 6962.1297337832775, 6964.930350696631, 6373.521985851173, 6417.294097649348, 6500.122483464861, 6503.707333169924, 6520.543561950808, 4983.601311894967, 4986.825461108844, 5011.373578302712, 5049.192129259301, 5073.315102461121, 4612.400387949545, 4964.975175124101, 4970.975145124251, 5119.6416250862085, 5137.51193636604], "value": 4412.62154002534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.96412412572545, 364.34599893191717, 374.06483790523697, 383.7678204686163, 384.21236465246255, 5368.543673787733, 5388.110961691326, 5553.361363443205, 5631.746571404292, 5644.604877658566, 4433.667474939376, 4926.482719314474, 5363.061464243751, 5415.918761218585, 5497.39528651848, 3376.0378292186733, 4192.49690037196, 4298.441202643668, 4309.849155279566, 4321.373400856874, 3421.6407277235903, 3626.854925802978, 3726.5900750917376, 4240.985531872367, 4304.375865499501, 3458.77517961333, 4074.8777536673797, 4124.97937510312, 4131.7934103294865, 4161.459010328653, 4117.485314335708, 4123.608257215575, 4125.711200215971, 4132.586741325874, 4142.150859073882, 3574.749767516249, 3596.532450781408, 3616.168281295317, 3630.4735813306925, 3633.400488919325, 5174.948250517522, 5180.611454140954, 5343.786248550054, 5352.57179425645, 5426.321709786277, 3892.2020985698146, 4746.0, 4757.122944799977, 4778.880527986828, 4787.784549695272, 5761.625494342897, 5779.508741756956, 5802.462347477922, 5808.0, 5863.188927197313, 3836.2135762168687, 3941.7437866538585, 3980.2835489611857, 3983.601639836022, 3985.043589538519, 5315.0, 6079.756809727605, 6102.72537735803, 6127.969360153171, 6130.509559235251, 3633.182533929845, 4007.4189242559664, 4024.63778259958, 4035.7915457211, 4039.4546736190237, 3765.6799172070682, 3807.485989391452, 4010.8195131219163, 4045.37296719009, 4092.4626731426706, 3797.6392242736897, 4463.8214471421425, 4690.0, 4722.480527142012, 4748.905021899612, 5071.554606937005, 5806.780576078986, 5819.6508209507565, 5835.883282334329, 5855.707214639251, 1233.8704436034266, 1263.0148484182353, 1304.934753262333, 1311.3574348569132, 1318.8351456067992, 748.3190296829968, 822.9629666665014, 856.0497847389393, 899.7615631857562, 901.8827552418144, 4137.751734895915, 4798.0, 4994.875128121754, 5159.561437277798, 5187.797883714204, 5341.65279256847, 5410.404855465896, 5442.537384322298, 5655.953648575027, 5702.45826646468, 4644.35418196714, 4806.611339005993, 5092.949070509321, 5255.369355677343, 5269.578433725293, 2483.416397146669, 2872.3250036241466, 2921.547160190174, 2961.48174069537, 3001.6848230935875, 4955.355803745562, 5238.842834714965, 5741.942580574141, 5956.349424506053, 5964.0, 4986.351774269322, 5398.9472052949295, 5605.187247849039, 5818.050952930816, 5831.475167234969, 5016.936281611906, 5870.823875283749, 6001.579889407787, 6255.655938923312, 6287.937120628735, 4997.400311962442, 5705.62913410627, 6049.699314647372, 6073.240844894388, 6099.573029887865, 5336.919946200733, 5461.0, 5737.881113182889, 5898.9115163273445, 5911.7635294587735, 5423.430539793265, 5752.8206717623625, 6242.406971337716, 6258.812235632939, 6269.31037585856, 3659.835307411226, 3798.5631652360335, 4007.0948562292106, 4025.5370632377653, 4025.698072644622, 5423.806762512241, 5444.428335024923, 5522.950639378505, 5779.479846813639, 5983.192269043798, 4702.764861756967, 4979.676321039121, 5445.237666726741, 5660.320761508646, 5870.706464676835, 5551.500364967173, 5825.242718446744, 5848.56135789826, 5858.677772722371, 5873.970630146822, 5354.4110147884485, 5643.689597072036, 5696.917585658712, 5714.856928651756, 5723.8855222896145, 5071.949280507295, 5080.669756465818, 5379.811706590251, 5816.738246778989, 5835.533157347317, 4879.365682461257, 4999.200127979506, 5011.523905228997, 5600.103983362643, 5656.60403771732], "value": 4166.678842017295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.8610906982206, 761.0334874709116, 791.1534657916029, 867.4274978514181, 875.8467268228061, 15314.463993760206, 16001.27994240259, 16005.759913601305, 16009.599760006005, 16012.279447424864, 13390.263535505543, 13413.932930335335, 13419.19484830911, 13420.0, 13430.12704174228, 718.4144921888644, 744.5011842065802, 748.4648476339416, 884.8097659003313, 891.1756625121769, 900.3877363392891, 901.7700486375965, 907.9137481939205, 913.137085454246, 913.5386629751999, 966.9903300966971, 969.2827307792219, 970.815545046439, 971.5627967414656, 971.9854202186973, 973.1728031173517, 973.2651847854895, 973.7030205787232, 974.7514383832148, 978.9657361992296, 719.7732714195064, 719.9712011519533, 720.7333286683908, 723.9493235473519, 724.4313214126938, 15579.0, 15629.921850390789, 15768.053916765031, 16098.436554720529, 16322.673546529002, 14970.0, 15052.623684407978, 15266.847331526653, 15453.922730386388, 15528.145951972638, 11851.644450666494, 11969.162158648898, 11991.880081199164, 12014.3633733978, 12134.514619415213, 3840.788756618385, 3872.8644497442738, 3885.825137868803, 4073.6944729145134, 4075.8777236682945, 116240.41879790547, 117316.0, 117606.0, 119590.20614690786, 120829.0, 11807.527698891949, 11839.822402663967, 11859.288442693465, 11974.063472061662, 12081.516739330504, 25413.74586254151, 25476.363090922503, 25491.745082548936, 25499.87250063738, 25522.10672626486, 8103.970975597611, 8116.147804480563, 8134.837303253902, 8179.918200817916, 8454.577271136419, 4445.17764213615, 4449.710768800018, 4516.954830451719, 4575.22221222393, 4610.2623580227, 3620.1311685195365, 3747.34421476246, 3757.492738480325, 3788.924221515554, 3790.7156963227867, 686.9141357330334, 689.0628744906923, 693.1405057728481, 695.1310861423221, 708.3624737736079, 712.1454254894147, 714.6426786606696, 714.7010730456309, 732.6410059071017, 767.3822572828926, 9754.804903901882, 9958.203343732484, 10036.447995360179, 10190.64332748365, 10825.0, 699.8005568412977, 702.1924786495571, 705.1502938958542, 705.3581241070601, 721.6247551273309, 4833.371661683958, 5164.509371609766, 5174.24973378858, 5174.818881339211, 5191.506806853343, 97344.0265597335, 100112.49831252391, 100437.0, 102083.0, 102951.42621434524, 74885.0, 86645.13354866496, 92800.53599731959, 94218.52890735502, 94280.0571994285, 76187.61906190433, 77069.0, 78982.0, 79083.81374279506, 80606.0, 9533.618655253713, 9983.550740216562, 10028.64899728506, 10042.748931276776, 10078.949605251926, 52056.73971630118, 53281.0, 53955.46044539662, 54527.72736136294, 55024.72487637536, 71294.93057604243, 72721.0, 73407.0, 73766.63116684383, 74388.62805685936, 10987.340759554452, 11302.0, 11484.94257528707, 11821.290722556674, 12576.811347829607, 12614.0, 12708.127706218149, 12979.28613926243, 13201.273929933946, 13472.124311919693, 11642.359670218219, 12011.75976480483, 12115.454804533641, 12165.452554634885, 12441.44013519412, 13945.790813137608, 14283.357248923616, 14461.349239284047, 14693.412263509339, 14724.0, 13422.932885335511, 14027.789583156466, 14360.35378407995, 14563.199024053778, 14848.0, 9219.308551858772, 9775.657851975147, 9854.260930430102, 9912.0, 10302.0, 10555.366677999345, 10619.94690026545, 10735.141188704729, 10964.06805421548, 12028.518859245532], "value": 7743.023761694352, "unit": "score"}], "name": "dromaeo_css", "value": 7466.239454570584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 114.0, 112.0, 113.0, 113.0, 112.0, 113.0, 115.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 108.0, 143.0, 107.0, 108.0, 107.0, 105.0, 127.0, 106.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 200.0, 256.0, 183.0, 182.0, 182.0, 185.0, 181.0, 184.0], "value": 191.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 106.0, 86.0, 84.0, 63.0, 57.0, 73.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 69.0, 66.0, 69.0, 81.0, 67.0, 68.0, 82.0], "value": 74.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 88.0, 85.0, 87.0, 88.0, 87.0, 87.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 49.0, 52.0, 82.0, 56.0, 56.0, 55.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 68.0, 80.0, 72.0, 68.0, 68.0, 70.0, 69.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 83.0, 83.0, 80.0, 80.0, 82.0, 80.0, 85.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 136.0, 118.0, 144.0, 142.0, 146.0, 143.0, 170.0, 134.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 161.0, 219.0, 221.0, 161.0, 161.0, 161.0, 160.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 71.0, 87.0, 83.0, 83.0, 71.0, 61.0, 63.0, 62.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1426.5000000000002, "alertThreshold": 2.0}]} 07:37:31 INFO - Return code: 0 07:37:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:31 INFO - # TBPL SUCCESS # 07:37:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:31 INFO - 2017-04-10 07:37:31.166 screenresolution[1659:9810] starting screenresolution argv=screenresolution get 07:37:31 INFO - 2017-04-10 07:37:31.168 screenresolution[1659:9810] Display 0: 1600x1200x32@60 07:37:31 INFO - 2017-04-10 07:37:31.174 screenresolution[1660:9813] starting screenresolution argv=screenresolution list 07:37:31 INFO - Available Modes on Display 0 07:37:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:31 INFO - Intel Iris: 07:37:31 INFO - Chipset Model: Intel Iris 07:37:31 INFO - Type: GPU 07:37:31 INFO - Bus: Built-In 07:37:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:31 INFO - Vendor: Intel (0x8086) 07:37:31 INFO - Device ID: 0x0a2e 07:37:31 INFO - Revision ID: 0x0009 07:37:31 INFO - Displays: 07:37:31 INFO - Display: 07:37:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:31 INFO - Display Serial Number: 1600x1200 60 07:37:31 INFO - Main Display: Yes 07:37:31 INFO - Mirror: Off 07:37:31 INFO - Online: Yes 07:37:31 INFO - Rotation: Supported 07:37:31 INFO - Return code: 0 07:37:31 INFO - Running post-action listener: _resource_record_post_action 07:37:31 INFO - [mozharness: 2017-04-10 14:37:31.409390Z] Finished run-tests step (success) 07:37:31 INFO - Running post-run listener: _resource_record_post_run 07:37:31 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 38413312; Write bytes: 422872576; Read time: 247; Write time: 1372 07:37:31 INFO - TinderboxPrint: CPU usage
53.5% 07:37:31 INFO - TinderboxPrint: I/O read bytes / time
38,413,312 / 247 07:37:31 INFO - TinderboxPrint: I/O write bytes / time
422,872,576 / 1,372 07:37:31 INFO - TinderboxPrint: CPU idle
2,216.9 (46.5%) 07:37:31 INFO - TinderboxPrint: CPU system
952.2 (20.0%) 07:37:31 INFO - TinderboxPrint: CPU user
1,596.5 (33.5%) 07:37:31 INFO - TinderboxPrint: Swap in / out
160,276,480 / 0 07:37:31 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122915328; Write bytes: 122638336; Read time: 11129; Write time: 279 07:37:31 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34583552; Write bytes: 298866176; Read time: 222; Write time: 1089 07:37:31 INFO - Running post-run listener: _upload_blobber_files 07:37:31 INFO - Blob upload gear active. 07:37:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:31 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 07:37:31 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'] 07:37:31 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 07:37:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:33 INFO - (blobuploader) - INFO - Done attempting. 07:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:34 INFO - (blobuploader) - INFO - Done attempting. 07:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:35 INFO - (blobuploader) - INFO - Done attempting. 07:37:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:37:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:37 INFO - (blobuploader) - INFO - Done attempting. 07:37:37 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:37 INFO - Return code: 0 07:37:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/891cdc193a014af4a71268b38505f8a7a3d753ffda4b7a03581eeb482407f3484965fa70df7192995853761500410008c068516f801d8a1d7f1d98bb6f8b6d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61291163d64264129c8f06946a0b89468aa39d4bb9ae88b478772c642b4b07550dc1da34f36903b14c4e091a3825c131c3d2abb96851f53c7d3f6ceeb8e0e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324c6fe218ead3c471060f914ea9c6142783a914f4cbac045bf5e3d1e6a390a251b31b46c686a0603d2531d2af39ad0864e9bf60ee209ffd7d3962a53ea99a3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1be3ece65c0a76866ff4c52c2879641585300a8ee635cc88357a63d13e95f9d55e75e3d2b581e299376bca2b6f69fb241bb2dfb3a25515d2766634dfcf49fb15"} 07:37:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:37 INFO - Contents: 07:37:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/891cdc193a014af4a71268b38505f8a7a3d753ffda4b7a03581eeb482407f3484965fa70df7192995853761500410008c068516f801d8a1d7f1d98bb6f8b6d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61291163d64264129c8f06946a0b89468aa39d4bb9ae88b478772c642b4b07550dc1da34f36903b14c4e091a3825c131c3d2abb96851f53c7d3f6ceeb8e0e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324c6fe218ead3c471060f914ea9c6142783a914f4cbac045bf5e3d1e6a390a251b31b46c686a0603d2531d2af39ad0864e9bf60ee209ffd7d3962a53ea99a3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1be3ece65c0a76866ff4c52c2879641585300a8ee635cc88357a63d13e95f9d55e75e3d2b581e299376bca2b6f69fb241bb2dfb3a25515d2766634dfcf49fb15"} 07:37:37 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:37 INFO - Copying logs to upload dir... 07:37:37 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.971073 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 07:37:37.579877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:37:37.583096) ========= 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.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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/891cdc193a014af4a71268b38505f8a7a3d753ffda4b7a03581eeb482407f3484965fa70df7192995853761500410008c068516f801d8a1d7f1d98bb6f8b6d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61291163d64264129c8f06946a0b89468aa39d4bb9ae88b478772c642b4b07550dc1da34f36903b14c4e091a3825c131c3d2abb96851f53c7d3f6ceeb8e0e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324c6fe218ead3c471060f914ea9c6142783a914f4cbac045bf5e3d1e6a390a251b31b46c686a0603d2531d2af39ad0864e9bf60ee209ffd7d3962a53ea99a3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1be3ece65c0a76866ff4c52c2879641585300a8ee635cc88357a63d13e95f9d55e75e3d2b581e299376bca2b6f69fb241bb2dfb3a25515d2766634dfcf49fb15"} build_url:https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/BGlanv50TvyZX-5glvJ-Qg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/891cdc193a014af4a71268b38505f8a7a3d753ffda4b7a03581eeb482407f3484965fa70df7192995853761500410008c068516f801d8a1d7f1d98bb6f8b6d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61291163d64264129c8f06946a0b89468aa39d4bb9ae88b478772c642b4b07550dc1da34f36903b14c4e091a3825c131c3d2abb96851f53c7d3f6ceeb8e0e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324c6fe218ead3c471060f914ea9c6142783a914f4cbac045bf5e3d1e6a390a251b31b46c686a0603d2531d2af39ad0864e9bf60ee209ffd7d3962a53ea99a3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1be3ece65c0a76866ff4c52c2879641585300a8ee635cc88357a63d13e95f9d55e75e3d2b581e299376bca2b6f69fb241bb2dfb3a25515d2766634dfcf49fb15"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:37:37.622979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:37:37.623321) ========= 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.oRAFgoNVrF/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.CletfVHKva/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:37:37.678873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:37:37.679237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:37:37.679606) ========= ========= Total master_lag: 0.19 =========