builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1474980876.49 results: success (0) buildid: 20160927033952 builduid: 67c6f7906dd94832abc4f5744dc89427 revision: e289c0bdae843b7262108b3c53460ae1622530e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:36.493431) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:36.493871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:36.494379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:36.590781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:36.591142) ========= 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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 05:54:36-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.4M=0s 2016-09-27 05:54:37 (26.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.609564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:37.224942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:37.225259) ========= 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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.027608 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:37.276964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 05:54:37.277498) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e289c0bdae843b7262108b3c53460ae1622530e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e289c0bdae843b7262108b3c53460ae1622530e9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 05:54:37,359 truncating revision to first 12 chars 2016-09-27 05:54:37,360 Setting DEBUG logging. 2016-09-27 05:54:37,360 attempt 1/10 2016-09-27 05:54:37,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e289c0bdae84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 05:54:38,787 unpacking tar archive at: fx-team-e289c0bdae84/testing/mozharness/ program finished with exit code 0 elapsedTime=1.701723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 05:54:39.002953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:39.003254) ========= script_repo_revision: e289c0bdae843b7262108b3c53460ae1622530e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:39.003657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:39.003932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 05:54:39.022692) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-27 05:54:39.023099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:54:39 INFO - MultiFileLogger online at 20160927 05:54:39 in /builds/slave/test 05:54:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:54:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:39 INFO - {'append_to_log': False, 05:54:39 INFO - 'base_work_dir': '/builds/slave/test', 05:54:39 INFO - 'blob_upload_branch': 'Fx-Team', 05:54:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:39 INFO - 'branch': 'Fx-Team', 05:54:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:39 INFO - 'config_files': ('talos/mac_config.py',), 05:54:39 INFO - 'default_actions': ('clobber', 05:54:39 INFO - 'read-buildbot-config', 05:54:39 INFO - 'download-and-extract', 05:54:39 INFO - 'populate-webroot', 05:54:39 INFO - 'create-virtualenv', 05:54:39 INFO - 'install', 05:54:39 INFO - 'run-tests'), 05:54:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:39 INFO - 'download_minidump_stackwalk': True, 05:54:39 INFO - 'download_symbols': 'ondemand', 05:54:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:39 INFO - 'installer_path': 'installer.exe', 05:54:39 INFO - 'log_level': 'info', 05:54:39 INFO - 'log_name': 'talos', 05:54:39 INFO - 'log_to_console': True, 05:54:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:39 INFO - 'opt_config_files': (), 05:54:39 INFO - 'pip_index': False, 05:54:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:39 INFO - 'cmd': ('bash', 05:54:39 INFO - '-c', 05:54:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:39 INFO - 'enabled': True, 05:54:39 INFO - 'halt_on_failure': False, 05:54:39 INFO - 'name': 'check_screen_resolution'},), 05:54:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:39 INFO - 'cmd': ('bash', 05:54:39 INFO - '-c', 05:54:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:39 INFO - 'enabled': True, 05:54:39 INFO - 'halt_on_failure': False, 05:54:39 INFO - 'name': 'check_screen_resolution'},), 05:54:39 INFO - 'run_cmd_checks_enabled': True, 05:54:39 INFO - 'sps_profile': False, 05:54:39 INFO - 'sps_profile_interval': 0, 05:54:39 INFO - 'suite': 'dromaeojs', 05:54:39 INFO - 'system_bits': '32', 05:54:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:39 INFO - 'title': 't-yosemite-r7-0114', 05:54:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:39 INFO - 'use_talos_json': True, 05:54:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:39 INFO - 'work_dir': 'build'} 05:54:39 INFO - [mozharness: 2016-09-27 12:54:39.235611Z] Running clobber step. 05:54:39 INFO - Running pre-action listener: _resource_record_pre_action 05:54:39 INFO - Running main action method: clobber 05:54:39 INFO - rmtree: /builds/slave/test/build 05:54:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:41 INFO - Running post-action listener: _resource_record_post_action 05:54:41 INFO - [mozharness: 2016-09-27 12:54:41.364519Z] Finished clobber step (success) 05:54:41 INFO - [mozharness: 2016-09-27 12:54:41.364645Z] Running read-buildbot-config step. 05:54:41 INFO - Running pre-action listener: _resource_record_pre_action 05:54:41 INFO - Running main action method: read_buildbot_config 05:54:41 INFO - Using buildbot properties: 05:54:41 INFO - { 05:54:41 INFO - "project": "", 05:54:41 INFO - "product": "firefox", 05:54:41 INFO - "script_repo_revision": "production", 05:54:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:54:41 INFO - "repository": "", 05:54:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:54:41 INFO - "buildid": "20160927033952", 05:54:41 INFO - "pgo_build": "False", 05:54:41 INFO - "basedir": "/builds/slave/test", 05:54:41 INFO - "buildnumber": 839, 05:54:41 INFO - "slavename": "t-yosemite-r7-0114", 05:54:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:54:41 INFO - "platform": "yosemite_r7", 05:54:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:54:41 INFO - "branch": "fx-team", 05:54:41 INFO - "repo_path": "integration/fx-team", 05:54:41 INFO - "revision": "e289c0bdae843b7262108b3c53460ae1622530e9", 05:54:41 INFO - "stage_platform": "macosx64", 05:54:41 INFO - "builduid": "67c6f7906dd94832abc4f5744dc89427", 05:54:41 INFO - "slavebuilddir": "test" 05:54:41 INFO - } 05:54:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:54:41 INFO - Running post-action listener: _resource_record_post_action 05:54:41 INFO - [mozharness: 2016-09-27 12:54:41.367987Z] Finished read-buildbot-config step (success) 05:54:41 INFO - [mozharness: 2016-09-27 12:54:41.368111Z] Running download-and-extract step. 05:54:41 INFO - Running pre-action listener: _resource_record_pre_action 05:54:41 INFO - Running main action method: download_and_extract 05:54:41 INFO - mkdir: /builds/slave/test/build/tests 05:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:41 INFO - trying https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:41 INFO - Downloading https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:54:43 INFO - Downloaded 1199 bytes. 05:54:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:43 INFO - Using the following test package requirements: 05:54:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:54:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:54:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:54:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'jsshell-mac.zip'], 05:54:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:54:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:54:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:54:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:54:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:54:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:54:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:54:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:54:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:54:43 INFO - Fetch https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:54:43 INFO - Expected file size: 16470503 05:54:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:54:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:54:50 INFO - Fetch https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:54:51 INFO - Expected file size: 16470503 05:54:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:54:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:54:58 INFO - Fetch https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:54:58 INFO - Expected file size: 14414057 05:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:59 INFO - trying https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:54:59 INFO - Downloading https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:55:02 INFO - Downloaded 111531073 bytes. 05:55:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:55:02 INFO - mkdir: /builds/slave/test/properties 05:55:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:02 INFO - Contents: 05:55:02 INFO - build_url:https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - Running post-action listener: set_extra_try_arguments 05:55:03 INFO - [mozharness: 2016-09-27 12:55:03.618806Z] Finished download-and-extract step (success) 05:55:03 INFO - [mozharness: 2016-09-27 12:55:03.618935Z] Running populate-webroot step. 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: populate_webroot 05:55:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:03 INFO - '--tppagecycles', 05:55:03 INFO - '7'], 05:55:03 INFO - 'tests': ['tsvgm']}}, 05:55:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['damp', 'tps']}, 05:55:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['damp', 'tps']}, 05:55:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['dromaeo_dom']}, 05:55:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['basic_compositor_video']}, 05:55:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:55:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tsvgx', 05:55:03 INFO - 'tsvgr_opacity', 05:55:03 INFO - 'tart', 05:55:03 INFO - 'tscrollx', 05:55:03 INFO - 'cart']}, 05:55:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:03 INFO - 'tsvgr_opacity', 05:55:03 INFO - 'tart', 05:55:03 INFO - 'tscrollx', 05:55:03 INFO - 'cart']}, 05:55:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tp5o']}, 05:55:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['tp5o']}, 05:55:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s', 05:55:03 INFO - '--xperf_path', 05:55:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:03 INFO - 'tests': ['tp5n']}, 05:55:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--xperf_path', 05:55:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:03 INFO - 'tests': ['tp5n']}}, 05:55:03 INFO - 'talos.zip': {'path': '', 05:55:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - [mozharness: 2016-09-27 12:55:03.637812Z] Finished populate-webroot step (success) 05:55:03 INFO - [mozharness: 2016-09-27 12:55:03.637901Z] Running create-virtualenv step. 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: create_virtualenv 05:55:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:03 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 05:55:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:03 INFO - Using real prefix '/tools/python27' 05:55:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:07 INFO - Installing pip.................done. 05:55:07 INFO - Return code: 0 05:55:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:55:07 INFO - Reading from file tmpfile_stdout 05:55:07 INFO - Output received: 05:55:07 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) 05:55:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:07 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')]} 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 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')]} 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:07 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 05:55:07 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 05:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:07 INFO - 'HOME': '/Users/cltbld', 05:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PAGER': '/bin/cat', 05:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:07 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - 'XPC_FLAGS': '0x0', 05:55:07 INFO - 'XPC_SERVICE_NAME': '0', 05:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:07 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 05:55:07 INFO - Cleaning up... 05:55:07 INFO - Return code: 0 05:55:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55:07 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')]} 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 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')]} 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:07 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 05:55:07 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 05:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:07 INFO - 'HOME': '/Users/cltbld', 05:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PAGER': '/bin/cat', 05:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:07 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - 'XPC_FLAGS': '0x0', 05:55:07 INFO - 'XPC_SERVICE_NAME': '0', 05:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:08 INFO - Downloading/unpacking psutil>=3.1.1 05:55:08 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 05:55:08 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 05:55:08 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 05:55:08 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 05:55:08 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 05:55:08 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 05:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:11 INFO - Installing collected packages: psutil 05:55:11 INFO - Running setup.py install for psutil 05:55:12 INFO - building 'psutil._psutil_osx' extension 05:55:12 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 05:55:12 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 05:55:12 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 05:55:12 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 05:55:12 INFO - building 'psutil._psutil_posix' extension 05:55:12 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 05:55:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:55:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:55:12 INFO - ^ 05:55:12 INFO - 1 warning generated. 05:55:12 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 05:55:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:13 INFO - Successfully installed psutil 05:55:13 INFO - Cleaning up... 05:55:13 INFO - Return code: 0 05:55:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:13 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:13 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 05:55:13 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 05:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:13 INFO - 'HOME': '/Users/cltbld', 05:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PAGER': '/bin/cat', 05:55:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:13 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - 'XPC_FLAGS': '0x0', 05:55:13 INFO - 'XPC_SERVICE_NAME': '0', 05:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:16 INFO - Installing collected packages: mozsystemmonitor 05:55:16 INFO - Running setup.py install for mozsystemmonitor 05:55:16 INFO - Successfully installed mozsystemmonitor 05:55:16 INFO - Cleaning up... 05:55:16 INFO - Return code: 0 05:55:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:16 INFO - 'HOME': '/Users/cltbld', 05:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:16 INFO - 'LOGNAME': 'cltbld', 05:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:16 INFO - 'MOZ_NO_REMOTE': '1', 05:55:16 INFO - 'NO_EM_RESTART': '1', 05:55:16 INFO - 'PAGER': '/bin/cat', 05:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:16 INFO - 'PWD': '/builds/slave/test', 05:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:16 INFO - 'SHELL': '/bin/bash', 05:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:16 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:16 INFO - 'USER': 'cltbld', 05:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:16 INFO - 'XPC_FLAGS': '0x0', 05:55:16 INFO - 'XPC_SERVICE_NAME': '0', 05:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:19 INFO - warning: no files found matching '*.txt' 05:55:19 INFO - no previously-included directories found matching 'build' 05:55:19 INFO - no previously-included directories found matching 'dist' 05:55:19 INFO - no previously-included directories found matching '.git*' 05:55:19 INFO - Installing collected packages: jsonschema, functools32 05:55:19 INFO - Running setup.py install for functools32 05:55:19 INFO - warning: no files found matching '*.txt' 05:55:19 INFO - no previously-included directories found matching 'build' 05:55:19 INFO - no previously-included directories found matching 'dist' 05:55:19 INFO - no previously-included directories found matching '.git*' 05:55:19 INFO - Successfully installed jsonschema functools32 05:55:19 INFO - Cleaning up... 05:55:19 INFO - Return code: 0 05:55:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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', '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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:55: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 functools32==3.2.3-2 05:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:19 INFO - 'HOME': '/Users/cltbld', 05:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:19 INFO - 'LOGNAME': 'cltbld', 05:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:19 INFO - 'MOZ_NO_REMOTE': '1', 05:55:19 INFO - 'NO_EM_RESTART': '1', 05:55:19 INFO - 'PAGER': '/bin/cat', 05:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:19 INFO - 'PWD': '/builds/slave/test', 05:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:19 INFO - 'SHELL': '/bin/bash', 05:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:19 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:19 INFO - 'USER': 'cltbld', 05:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:19 INFO - 'XPC_FLAGS': '0x0', 05:55:19 INFO - 'XPC_SERVICE_NAME': '0', 05:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:19 INFO - Cleaning up... 05:55:19 INFO - Return code: 0 05:55:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:20 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')]} 05:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:20 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:20 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 05:55:20 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 05:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:20 INFO - 'HOME': '/Users/cltbld', 05:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:20 INFO - 'LOGNAME': 'cltbld', 05:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:20 INFO - 'MOZ_NO_REMOTE': '1', 05:55:20 INFO - 'NO_EM_RESTART': '1', 05:55:20 INFO - 'PAGER': '/bin/cat', 05:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:20 INFO - 'PWD': '/builds/slave/test', 05:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:20 INFO - 'SHELL': '/bin/bash', 05:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:20 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:20 INFO - 'USER': 'cltbld', 05:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:20 INFO - 'XPC_FLAGS': '0x0', 05:55:20 INFO - 'XPC_SERVICE_NAME': '0', 05:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:23 INFO - Downloading docopt-0.6.1.tar.gz 05:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:23 INFO - Running setup.py install for blobuploader 05:55:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:24 INFO - Running setup.py install for requests 05:55:24 INFO - Running setup.py install for docopt 05:55:24 INFO - Successfully installed blobuploader requests docopt 05:55:24 INFO - Cleaning up... 05:55:24 INFO - Return code: 0 05:55:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:24 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:24 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 05:55:24 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 05:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:24 INFO - 'HOME': '/Users/cltbld', 05:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:24 INFO - 'LOGNAME': 'cltbld', 05:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:24 INFO - 'MOZ_NO_REMOTE': '1', 05:55:24 INFO - 'NO_EM_RESTART': '1', 05:55:24 INFO - 'PAGER': '/bin/cat', 05:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:24 INFO - 'PWD': '/builds/slave/test', 05:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:24 INFO - 'SHELL': '/bin/bash', 05:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:24 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:24 INFO - 'USER': 'cltbld', 05:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:24 INFO - 'XPC_FLAGS': '0x0', 05:55:24 INFO - 'XPC_SERVICE_NAME': '0', 05:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LXXTp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-dR056K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-M2T5zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-DPc0Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-y1ARwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KacCGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5lqzjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OkI807-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-By7Lh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:25 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-RNEJql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-0y4LXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-D4jQX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bpiQOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CW06Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2xgCkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OA8q8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:26 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bcvV3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:26 INFO - Running setup.py install for manifestparser 05:55:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Running setup.py install for mozcrash 05:55:27 INFO - Running setup.py install for mozdebug 05:55:27 INFO - Running setup.py install for mozdevice 05:55:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Running setup.py install for mozfile 05:55:27 INFO - Running setup.py install for mozhttpd 05:55:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Running setup.py install for mozinfo 05:55:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Running setup.py install for mozInstall 05:55:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Running setup.py install for mozleak 05:55:28 INFO - Running setup.py install for mozlog 05:55:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Running setup.py install for moznetwork 05:55:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Running setup.py install for mozprocess 05:55:28 INFO - Running setup.py install for mozprofile 05:55:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Running setup.py install for mozrunner 05:55:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:28 INFO - Running setup.py install for mozscreenshot 05:55:29 INFO - Running setup.py install for moztest 05:55:29 INFO - Running setup.py install for mozversion 05:55:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:29 INFO - Cleaning up... 05:55:29 INFO - Return code: 0 05:55:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:29 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')]} 05:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:29 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')]} 05:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:29 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:29 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 05:55:29 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 05:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:29 INFO - 'HOME': '/Users/cltbld', 05:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:29 INFO - 'LOGNAME': 'cltbld', 05:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:29 INFO - 'MOZ_NO_REMOTE': '1', 05:55:29 INFO - 'NO_EM_RESTART': '1', 05:55:29 INFO - 'PAGER': '/bin/cat', 05:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:29 INFO - 'PWD': '/builds/slave/test', 05:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:29 INFO - 'SHELL': '/bin/bash', 05:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:29 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:29 INFO - 'USER': 'cltbld', 05:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:29 INFO - 'XPC_FLAGS': '0x0', 05:55:29 INFO - 'XPC_SERVICE_NAME': '0', 05:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-yKikVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:29 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)) 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LFZwVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-u8bewe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JRJPkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-r5K2nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9XSy7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-z5U08b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-R_kzrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-sZtaSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-S6Q5cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-MtOw1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:30 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)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-vP9dcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:30 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-UkamCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:31 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)) 05:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Tymy2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-74WWC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:31 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)) 05:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YvbNMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-4hHOVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:31 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)) 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:31 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)) 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:33 INFO - Downloading blessings-1.6.tar.gz 05:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:34 INFO - Installing collected packages: blessings 05:55:34 INFO - Running setup.py install for blessings 05:55:34 INFO - Successfully installed blessings 05:55:34 INFO - Cleaning up... 05:55:34 INFO - Return code: 0 05:55:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:34 INFO - Reading from file tmpfile_stdout 05:55:34 INFO - Current package versions: 05:55:34 INFO - blessings == 1.6 05:55:34 INFO - blobuploader == 1.2.4 05:55:34 INFO - docopt == 0.6.1 05:55:34 INFO - functools32 == 3.2.3-2 05:55:34 INFO - jsonschema == 2.5.1 05:55:34 INFO - manifestparser == 1.1 05:55:34 INFO - mozInstall == 1.12 05:55:34 INFO - mozcrash == 0.17 05:55:34 INFO - mozdebug == 0.1 05:55:34 INFO - mozdevice == 0.48 05:55:34 INFO - mozfile == 1.2 05:55:34 INFO - mozhttpd == 0.7 05:55:34 INFO - mozinfo == 0.9 05:55:34 INFO - mozleak == 0.1 05:55:34 INFO - mozlog == 3.4 05:55:34 INFO - moznetwork == 0.27 05:55:34 INFO - mozprocess == 0.23 05:55:34 INFO - mozprofile == 0.28 05:55:34 INFO - mozrunner == 6.12 05:55:34 INFO - mozscreenshot == 0.1 05:55:34 INFO - mozsystemmonitor == 0.3 05:55:34 INFO - moztest == 0.7 05:55:34 INFO - mozversion == 1.4 05:55:34 INFO - psutil == 3.1.1 05:55:34 INFO - requests == 1.2.3 05:55:34 INFO - wsgiref == 0.1.2 05:55:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:34 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 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:34 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 05:55:34 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 05:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:34 INFO - 'HOME': '/Users/cltbld', 05:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:34 INFO - 'LOGNAME': 'cltbld', 05:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:34 INFO - 'MOZ_NO_REMOTE': '1', 05:55:34 INFO - 'NO_EM_RESTART': '1', 05:55:34 INFO - 'PAGER': '/bin/cat', 05:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:34 INFO - 'PWD': '/builds/slave/test', 05:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:34 INFO - 'SHELL': '/bin/bash', 05:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:34 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:34 INFO - 'USER': 'cltbld', 05:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:34 INFO - 'XPC_FLAGS': '0x0', 05:55:34 INFO - 'XPC_SERVICE_NAME': '0', 05:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 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)) 05:55:34 INFO - Cleaning up... 05:55:34 INFO - Return code: 0 05:55:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110277490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2dbd6c830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, '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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 05:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:34 INFO - 'HOME': '/Users/cltbld', 05:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:34 INFO - 'LOGNAME': 'cltbld', 05:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:34 INFO - 'MOZ_NO_REMOTE': '1', 05:55:34 INFO - 'NO_EM_RESTART': '1', 05:55:34 INFO - 'PAGER': '/bin/cat', 05:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:34 INFO - 'PWD': '/builds/slave/test', 05:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:34 INFO - 'SHELL': '/bin/bash', 05:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:55:34 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:34 INFO - 'USER': 'cltbld', 05:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:34 INFO - 'XPC_FLAGS': '0x0', 05:55:34 INFO - 'XPC_SERVICE_NAME': '0', 05:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:35 INFO - Cleaning up... 05:55:35 INFO - Return code: 0 05:55:35 INFO - Running post-action listener: _resource_record_post_action 05:55:35 INFO - Running post-action listener: _start_resource_monitoring 05:55:35 INFO - Starting resource monitoring. 05:55:35 INFO - [mozharness: 2016-09-27 12:55:35.186365Z] Finished create-virtualenv step (success) 05:55:35 INFO - [mozharness: 2016-09-27 12:55:35.187395Z] Running install step. 05:55:35 INFO - Running pre-action listener: _resource_record_pre_action 05:55:35 INFO - Running main action method: install 05:55:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:35 INFO - Reading from file tmpfile_stdout 05:55:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:35 INFO - Reading from file tmpfile_stdout 05:55:35 INFO - Output received: 05:55:35 INFO - Usage: mozinstall [options] installer 05:55:35 INFO - Options: 05:55:35 INFO - -h, --help show this help message and exit 05:55:35 INFO - -d DEST, --destination=DEST 05:55:35 INFO - Directory to install application into. [default: 05:55:35 INFO - "/builds/slave/test"] 05:55:35 INFO - --app=APP Application being installed. [default: firefox] 05:55:35 INFO - mkdir: /builds/slave/test/build/application 05:55:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:56:09 INFO - Reading from file tmpfile_stdout 05:56:09 INFO - Output received: 05:56:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:56:09 INFO - Running post-action listener: _resource_record_post_action 05:56:09 INFO - [mozharness: 2016-09-27 12:56:09.506871Z] Finished install step (success) 05:56:09 INFO - [mozharness: 2016-09-27 12:56:09.507004Z] Running run-tests step. 05:56:09 INFO - Running pre-action listener: _resource_record_pre_action 05:56:09 INFO - Running main action method: run_tests 05:56:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:09 INFO - 2016-09-27 05:56:09.521 screenresolution[1649:7976] starting screenresolution argv=screenresolution get 05:56:09 INFO - 2016-09-27 05:56:09.524 screenresolution[1649:7976] Display 0: 1600x1200x32@60 05:56:09 INFO - 2016-09-27 05:56:09.530 screenresolution[1650:7978] starting screenresolution argv=screenresolution list 05:56:09 INFO - Available Modes on Display 0 05:56:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:09 INFO - Intel Iris: 05:56:09 INFO - Chipset Model: Intel Iris 05:56:09 INFO - Type: GPU 05:56:09 INFO - Bus: Built-In 05:56:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:09 INFO - Vendor: Intel (0x8086) 05:56:09 INFO - Device ID: 0x0a2e 05:56:09 INFO - Revision ID: 0x0009 05:56:09 INFO - Displays: 05:56:09 INFO - Display: 05:56:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:09 INFO - Display Serial Number: 1600x1200 60 05:56:09 INFO - Main Display: Yes 05:56:09 INFO - Mirror: Off 05:56:09 INFO - Online: Yes 05:56:09 INFO - Rotation: Supported 05:56:09 INFO - Return code: 0 05:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:56:09 INFO - Python 2.7.3 05:56:09 INFO - Return code: 0 05:56:09 INFO - grabbing minidump binary from tooltool 05:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008bd30>, '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 0x10feb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110083b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:56:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:56:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:56:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:56:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:56:09 INFO - Return code: 0 05:56:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:56:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:56:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:56:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:56:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 05:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 05:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aFjDUVhqWe/Render', 05:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:09 INFO - 'HOME': '/Users/cltbld', 05:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:09 INFO - 'LOGNAME': 'cltbld', 05:56:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:56:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:09 INFO - 'MOZ_NO_REMOTE': '1', 05:56:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:56:09 INFO - 'NO_EM_RESTART': '1', 05:56:09 INFO - 'PAGER': '/bin/cat', 05:56:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:09 INFO - 'PWD': '/builds/slave/test', 05:56:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:09 INFO - 'SHELL': '/bin/bash', 05:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o8Hu24oRSw/Listeners', 05:56:09 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 05:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:09 INFO - 'USER': 'cltbld', 05:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:09 INFO - 'XPC_FLAGS': '0x0', 05:56:09 INFO - 'XPC_SERVICE_NAME': '0', 05:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 05:56:10 INFO - mozversion application_buildid: 20160927033952 05:56:10 INFO - mozversion application_changeset: e289c0bdae843b7262108b3c53460ae1622530e9 05:56:10 INFO - mozversion application_display_name: Nightly 05:56:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:56:10 INFO - mozversion application_name: Firefox 05:56:10 INFO - mozversion application_remotingname: firefox 05:56:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:56:10 INFO - mozversion application_vendor: Mozilla 05:56:10 INFO - mozversion application_version: 52.0a1 05:56:10 INFO - mozversion platform_buildid: 20160927033952 05:56:10 INFO - mozversion platform_changeset: e289c0bdae843b7262108b3c53460ae1622530e9 05:56:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:56:10 INFO - mozversion platform_version: 52.0a1 05:56:10 INFO - using testdate: 1474980970 05:56:10 INFO - actual date: 1474980970 05:56:10 INFO - starting webserver on 'localhost:49268' 05:56:10 INFO - SUITE-START | Running 2 tests 05:56:10 INFO - TEST-START | dromaeo_css 05:56:10 INFO - operating with platform_type : mac_ 05:56:10 INFO - Initialising browser for dromaeo_css test... 05:56:10 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpm9YVKC/profile http://localhost:49268/getInfo.html) 05:56:12 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:56:12 INFO - PROCESS | 1660 | colorDepth:24 05:56:12 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:56:12 INFO - PROCESS | 1660 | __metrics 05:56:12 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:56:12 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:13 INFO - TEST-INFO | 1660: exit 0 05:56:13 INFO - Browser initialized. 05:56:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:56:13 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpm9YVKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:25 INFO - PROCESS | 1663 | RSS: Main: 235577344 05:56:25 INFO - PROCESS | 1663 | 05:57:16 INFO - PROCESS | 1663 | 1474981036961 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:59:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 05:59:29 INFO - PROCESS | 1663 | RSS: Main: 392007680 05:59:29 INFO - PROCESS | 1663 | 06:02:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 06:02:33 INFO - PROCESS | 1663 | RSS: Main: 383315968 06:02:33 INFO - PROCESS | 1663 | 06:05:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 06:05:35 INFO - PROCESS | 1663 | RSS: Main: 366456832 06:05:35 INFO - PROCESS | 1663 | 06:08:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 06:08:38 INFO - PROCESS | 1663 | RSS: Main: 345673728 06:08:38 INFO - PROCESS | 1663 | 06:11:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 06:11:42 INFO - PROCESS | 1663 | RSS: Main: 324743168 06:11:42 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 06:14:46 INFO - PROCESS | 1663 | RSS: Main: 492859392 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | __start_tp_report 06:14:46 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 06:14:46 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 06:14:46 INFO - PROCESS | 1663 | |i|pagename|runs| 06:14:46 INFO - PROCESS | 1663 | |0;dojo.html;2964.570137330087;3292.687194716502;3307.6361600223972;3323.966760332396;3370.9831450842744;5457.754401051952;5529.6129270951;5547.33431988161;5628.634138780982;5659.688717120562;5534.695591742453;5594;5652.349979752319;5657.434256574341;5662.943370566293;5110.105731496992;5172.741362931848;5183.092958732207;5190.818321358754;5217.686938783666;4677.298405239208;5039.899202015958;5079.873003174932;5192.013517431695;5192.584593232532;4551.795169217393;4887.926681099786;5228.555572776299;5241.9213711794355;5283.445238249986;5058.544730974193;5179.663321884065;5182.37811462625;5196.766145523423;5209.765560549784;5048.5203905628905;5057.5448209660935;5117.104506711311;5138.922916156261;5160.870978225536;5440.891182176334;5450.836474905759;5471.534919531845;5478.150886612581;5489.615726899118;6102.7864024759365;6103.816885493442;6113.694315284218;6115.571909966304;6121.846953826145;6050.576459647827;6056.364081771395;6113.816585502442;6124.778783120226;6173.074038894157;5693.117566777156;5699.5725320600295;5699.800506982318;5704.686242256675;5728.398518155617;6289.7169627366875;6303.180586523723;6307.905381419282;6308.337624549448;6310.716017779119;5837.3287071986415;5896.675682837399;5899.557533185029;5971.7611295547695;6051.515878729691;6104.489471593149;6105.8843398869885;6111.5309653553995;6111.7688611196745;6113.962834745988;6023.759049637965;6029.095635654687;6071.150038994544;6077.453029227302;6140.473573783631;6116.66358350295;6130.601510901777;6130.754769809247;6133.44798968095;6149.907751383733;4844.975775121173;4854.708717476963;4856.344393506902;4864.902701945941;4882.9257563336005;4307.289297265916;4313.460817397825;4319.568043195718;4343.087951530151;4348.2825333819565;5646.463585959327;5657.547396208293;5661.915071273934;5700.7719691212715;5719.456651618089;6146.170267013896;6188.164597779332;6201.255849298022;6215.223097112861;6218;5550.888982220333;5584.357798853184;5602.579806514527;5647.096464565732;5675.971620141873;5269.314989051475;5293.550048245942;5331.86670333237;5334.11987022137;5376;6316.242050953823;6322.462590679844;6336.1762970814425;6344.524160687874;6359.650219237987;5985.191999080069;6187.628742275478;6189.35011823752;6194.473469754941;6203.844903877439;6200.844978875564;6219.036049412348;6242.781502647385;6305;6306.432421082125;6081.148639190428;6085;6091.451769340781;6099.054646529795;6111.96944015277;6118.908216376669;6155.538334624832;6161.4146656067605;6162.691865406801;6164.229471316085;5760.971195143998;5819.098039803837;5921.792737254348;5942.1383899335215;5999.850003749942;5961.552883533665;6012.939870601238;6016.699165041643;6054.84862878414;6066.605670631395;5632.1551767233605;5828.970855145697;5833.591648584558;5833.970830145822;5838.1826544282985;5753;5847;5851.063829787214;5932.703364831655;5978.4021597839865;5708.743106560131;5800.56495762811;5807.970960145172;5840.883182336244;5853.912191317048 06:14:46 INFO - PROCESS | 1663 | |1;ext.html;449.7391512922504;500.859759267405;517.051211027764;519.6726062580576;526.0426024635163;31083;40244.396334054974;41325.38011929816;41330.79334603323;41500.58499415005;42333.57666423335;42985.14029719404;43338.566614333846;43370.132597348034;43378.783106084426;9807.852882206773;9986.550605222783;9996.90003099967;10000.449975251358;10019.44893030883;8846.20384165425;9110.316726245524;12097.939510302436;12354.320512371816;12370.44333005017;12131.090168237373;12162.695932601668;12207.572734954278;12214.083943704214;12364.752704945895;12155;12205.755884882341;12207.633770986884;12222.022238220965;12235.510579576807;12002.51989920402;12073.154879158463;12091.818622720666;12103.576374826927;12104.576339828063;40457.190856182715;40664.983375415555;40696;40794.59205407967;40921.181576368304;3175.809451432898;3277.049655599873;3291.4733642617307;3373.477111047767;3471.548698669182;28599.85700071507;30176.24559386011;30614.234644133852;31438.842805786055;32023.51964720531;2884.351021020275;3017.9245518862203;3035.741961933238;3068.6317641883115;3118.5322201669705;486903;489074;490310.54844725545;490523;498830;63115.6844215776;63466.68266658637;63504.36495635077;63505.36494635087;63589.68205158944;34492.48261276083;35153.64846351555;35369.46945795815;65671.34328656652;65907.67046164739;15981.44064957721;16322.918385407997;16372;16373.508794736177;16389;11458.885411145782;11669;12285.01719862409;12313.199642023239;12339.50641974329;18943.52641183954;19165.520861978282;19248.518787030156;19429.542784290952;19434.319798806973;7784.754439289686;7825.4130940178575;7950.761477155695;8041.3968952328805;8255.876161857577;709.9503034787618;885.7829831691148;945.6122989574242;1002.7793885345212;1012.4431562640518;29988.55017174744;30051.549226761617;30183;30737.38525229483;30821.61302741382;817.464560712734;878.2622597018535;992.811365840488;1020.5101551255291;1034.4724190662816;12380.81428778569;15407.845921540866;15548.067115972852;15619.219039048003;15811.841881581036;688844.8904288326;693290;693302.6004609935;693819;694749;58264.70867645634;58580;58626.18929769551;58749;58817.41182588205;1176.1414167657488;1252.1923359433115;1300.2133709105856;1304.067591671959;1362.3801170467216;30650.233744156576;31476;31609.683903160672;31728;32244.677553224166;50786.23820642619;51279.74360128325;51335;51427.48572514227;51471;572501;580714.0964295152;581238;581367;581429;26186.86906565455;26779.732202677726;27371.86314068417;27404.314892127855;27968.720312796613;46572.767136164104;46922.765386172854;47199.764001181145;47507;47906.85583450752;33399.33201336008;38518.2296354077;38815.6118438812;38826.6117338823;40447;39068.6093139065;39321.80339098286;39333;39984.4002339971;41224.38163427611;37988.430173547975;38558.228835422575;38651.42022869603;38813.611863881;38847.47491413049;32999;34819.82590087033;35321.64678353183;35462.645373545936;35937.640623594474;22011.889940550194;25052.123175688765;25587.616185756855;25700.614490782278;25745.227643170736 06:14:46 INFO - PROCESS | 1663 | |2;jquery.html;330.98179600122;345.93427248822724;349.80585774894956;380.773439803317;385.00092260583773;15139;15566.143862087582;16066.196690165489;20569.691454628155;21131.683024754642;19773.307934222306;19914.10386532606;21068.946552672383;21072.78927210731;21394.57210855786;5331.520163185312;5996.730147143389;6234.781782637609;6260.593061451013;6261.279952805417;5122.513361230677;6811.863762724743;6907.585544867324;6967.79096627102;6983.2318444971015;6651.268360480343;6874.243833178346;6935.271796461349;6935.757248496304;6958.478114141434;6621.304762999912;6858.6570671466225;6898;6905.516613837033;6918.619475928847;5911.438413350767;5954.851128721773;5970.373110823388;5983.820485385445;5988.071848863389;25447.61828572573;26012;26014.739852601422;26070;26681;2423.478952025323;2435.5981263091567;2457.7910877575428;2508.5610018246734;2511.0834545390985;13957.674020967992;15097.3206205721;15813.294774789147;16064.357425702958;16215.594610134842;1454.6581553334959;1780.9821901781077;1819.381410320484;1880.4452686457528;1900.809919008102;79276;122248.99999999911;123471;124661;126227;10498.475076246157;10737.83893241602;10763.83854242187;11064.28082174656;11284.661460156045;13746.587602371945;13774.242416667179;13784.760581263396;13788.793168102486;13811.240381779098;6687.799366019027;8571.057183709787;8586.957065214634;8721.476711397336;8770.12298770118;8598.011228708654;8598.871016934625;8649.221570058726;8787.253083487974;8789.428687135316;5604.299462567179;6353.491720662336;6582.486028213538;6597.967010164918;6598.670066496656;1797.7932537758063;1837.0906401331426;1866.3934221378106;1870.6352261309187;1871.335675835059;773.8761798112388;850.4387104510993;906.5421961909326;921.8525035994209;1018.7351288665001;21439.57120857574;21991.560168796856;22730.318090457313;22775.088996439958;22817;935.6117211357347;969.9951500242595;971.1647982734843;978.3738407419257;1047.8113939490813;11027.724306892393;11846.585369512026;11959.282443053271;11985.101117416229;12088;584886;587433;588719;609336;612515;100047;103089;107578.92421075846;110222;110268;955;964.2671569607008;1000.9899901000897;1001.4692213127055;1001.9549120289604;19363.709544356563;19687.40937771869;19900.90049549743;19914.800851991295;19932.800671993093;37075.62924370722;50483.242751358026;52525.47474525206;53567.7145828325;53659.63403659603;74251.8862217078;75390;75592.62203688946;75653.62173189099;77828;7881.369490440866;7893.329067029367;8113.59432028408;8198.426110172231;8475;13588.456461741815;13671.931640341734;13846.169229846242;13922.164670119826;14010.159390436607;11061.446927653746;11406.258593191416;11503.606436101538;11839.28964262147;11949.761004779682;11235.606753763579;11377.4880130396;11378.31730096197;11649.184557081262;11659.358735269641;9807.705768826661;11511.654650360502;11726.237794543327;11924.582639607572;12045.75908481843;7958.647030004798;8018.799530011796;8313.41806073569;8320.750377488685;8371.079181290175;11442;11701.88298117042;11914.463849126636;11991.76016479683;12053.035757139232 06:14:46 INFO - PROCESS | 1663 | |3;mootools.html;1321.5969129415537;1479.874210692091;1491.6718321969167;1697.3719723702225;1899.5346140195654;7837.490563113393;8305.460145090572;8459.280961118304;8646.91353086469;8824.161704638065;8554.615042323096;8778.604962776675;8796.428232164904;8799.384043116985;8808.77978050549;2337.6259798432297;2394.1859767678984;2394.676718642987;2399.256230568529;2399.3042017814814;2012.7182194492782;2333.8949747261413;2372.41875740443;2390.5935990881594;2399.2442380650127;2339.485313231095;2350.565145448089;2351.235848349285;2382.3210385040265;2385.355953892448;2332.8833558322017;2365.266767302142;2369.597168481362;2372.8220383471307;2375.9524809503887;2329.4991576811067;2345.988270058656;2360.480694247263;2363.7636236376397;2367.9644805327935;8681.869771953427;8725.214730674206;8727.345449091343;8743.169398907157;8749.825003499958;5153.252778347156;5255.816046438395;5389.9191512127345;5397.73011349431;5405.864853378657;3024.9546256806166;3505.1762835733584;3567.1795487037866;3592.209713862946;3600.171960449085;1024.7130803375067;1054.5201933120488;1058.3385384134915;1702.2510095557916;1752.1326943163215;11649.47577359021;11713.765724685543;11837.644870653894;11858.229215101077;11863.94068029663;4614;4708.176069187947;4869.245266983623;4872.6589138760655;4873.439554451284;9839.80320393588;10084.445355505371;10147.64483243083;10152.593896244067;10175.491225438698;5404.459554044564;5406.513413792777;5409.107497262986;5409.377921539073;5419.701916394636;3916.706247031484;4382.583654552813;4526.253168227271;4540.500544940054;4931.432885218174;3883.786391748481;3942.3692209246383;3963.5243770747693;3994.6205110514456;4001.1797581495725;1252.1485389934749;1276.189619591566;1276.4766445757195;1277.367702987009;1290.7805673035607;781.8397228568243;874.7987962768472;889.0664801957919;936.5317341329335;939.262678797141;5787.855303617359;5953.523718102541;6047.848803779941;6169.660668663177;6329.2721337045905;884.7036242858586;900.401233179928;907.5099446299057;911.5715613661569;964.3153361113548;3917.4123881418013;3981.960180398217;4014.9561114110543;4117.464729585195;4141.4409054777825;10411.895881041093;10884.836727449094;10885.945570272099;10899.455027248607;10914.672559823219;10054;10644.338915271182;10657;10860.891391086147;10878.292910960763;8114.513129212266;8303.8339233215;8305.21100495464;8305.501669899826;8321.833563328699;5907.49786268172;5929.555283353679;6002.429769171922;6126.877462450815;6239.845628558731;7759.806004849924;9823.36148150368;9875.407475551203;10127.7468063299;10226.23303252274;10129.341592796445;10207.795844083224;10342.5345859435;10365.9481702591;10438.791224175626;7527.870819377137;7569.735059272899;7676.232376762502;7676.270754278335;7715.768526944201;7678;7830.1386847447875;7833.725819596287;7836;7842.019747531559;7406.296401841816;7508.962455187689;7514.661840217313;7563.584002879895;7673.8848917267405;7254.818629534304;7406.962965185139;7437.144728356308;7449.14334851499;7499.962500187682;7035.929640703527;7050.294970502909;7126.572405655677;7131.393831524379;7157.964210178916;5040.269160971712;5063.291139240583;5093.974530127474;5106.412762532208;5182.378114626118;5012.223105418666;5069.31564238823;5224.7648855802345;5256.290400795997;5295.788168473218 06:14:46 INFO - PROCESS | 1663 | |4;prototype.html;263.70991908900214;302.7230084472706;312.3425189975102;315.36611411063757;319.8352848283136;5237.355135656493;5283.260343551906;5284.286621306118;5327.534927894831;5332.2137084076885;4823.1189835964005;4848.248521479177;5053.36832895888;5072.72100034498;5247.842564723064;3433.5879694436703;3816.664167541366;3950.6246906543834;3968.8610898618554;3977.1846771411792;4030.146132778925;4050.696197785178;4055.3105971984687;4070.7761073140964;4111.691623128262;3763.41667041609;3880.2821478026513;3996.3006473867104;4020.115574573589;4026.516817981846;3223.951640725391;3345.5483509726364;4043.4945631796027;4056.675465962716;4060.1473690525027;2908.4003797911278;3525.9294814103832;3541.451075083366;3542.1662669864004;3553.3248682750195;4540.841070562547;4764;5158.819441319536;5201.453847346012;5224.425313215544;4283.678724095706;4589.5639914208095;4619;4632.5830675239395;4670.579647831712;5550.4449555044175;5557.861053473695;5571.637843540157;5574.693391863446;5590.972045139789;3657.6159503252043;3865.6714179294795;3867.6325749054076;3873.4964454621;3884.9805750971345;4661.696989695659;5146.511081447256;5275.841724748264;5834.183214349994;5856.209411729405;3939.3697008478507;3956.3669812829808;3956.9208615827524;3968.444417781513;3986.9202615948097;3433.7081348085194;3526.85377252394;3884.776295466919;4020.4572382728543;4034.919301613951;3682.815859207029;4199.4120823084795;4517.757616655446;4659.883502912454;4667.95332046682;4910.8281210157475;5553.195636203772;5577.721113944286;5578.8047418340975;5622.353429355595;1263.9130347900798;1264.2477725753163;1345.865413458666;1370.3627813066971;1371.1841454334656;862.9266512346395;886.6409104312763;888.9199972002551;889.1997202517786;889.9199072083544;4465.307877279027;5083.644144909821;5115.693058416507;5179.404368497596;5265.947340526623;4468.262736648481;4999.925001124986;5666.518345940642;5676.801311954062;5697.430256974352;4959.950400496021;5197.480251974848;5230.163173892235;5249.396319423239;5293.232481290192;2424.272718184573;2928.428956353491;2966.9109926702235;2971.8305636885193;2988.44713727961;4892.461829198785;4907.950920490749;5622.353429355595;5829.551588332825;5863.442972917566;4664.743439110882;5247.763850626731;5670.858228544319;5715.342735585377;5815.41845815415;4853.126437241331;5091.41448733393;5830.5044071254415;5836.007878660553;5874.236349274653;4432.512423633462;5598.832035038955;5622.7750889963945;5625.943740562542;5653;5026.421961474477;5722.5421966241765;5725.713714314351;5730.684812335361;5741.5119714824705;5988.910166347596;6028.668423236764;6029.638221706711;6033.698315084316;6035;3569.8215089245955;3790.639889210521;3806.200697853371;3820.8089595519555;3859.3053250415196;5679.8864022720145;5683.215224540028;5703.089465029096;5719.942800571941;5736.885262294814;4155.916881662411;5511.704749383972;5578.358488773681;5629.437056294338;5635.943640563706;4619.538046195354;4621.676482646182;4828.444728856227;5249.842504724865;5378.784848606168;4513.269471969411;5037;5403.86547313801;5439.4288599696465;5444.047291724011;5112.948870511247;5402.72986350673;5465.836024919259;5549.556035517229;5583.302087239095;5222.764975576184;5419.891602168013;5467.644603100785;5469.1951655954235;5475.260839786737 06:14:46 INFO - PROCESS | 1663 | |5;yui.html;665.4377051391574;725.4522835259378;776.4758787818221;799.6601444386134;827.7144385187116;13213.273269970148;15469.690606187884;15846.28691708873;15860.682786344267;15867.841321586795;14146.221957792317;14269.286535673227;14291;14298.499552515665;14655.780163297559;683.2006552333756;708.3624737736053;708.922018577956;844.3582877013453;844.4553263145268;856.9700060497884;861.8534849075672;867.397158974513;871.4292138649195;872.3413822563955;925.4447331601053;928.0348437624862;928.3362395886974;931.4085555672164;932.3566738950136;723.0997408226739;749.913759917611;925.7361651929201;926.2867591954158;928.3455164109321;563.9041362968305;655.6951017776756;659.9604023758542;680.2245440198178;682.9829254268633;14881.032732872329;14897.702045959128;14926.477573284883;14928.62678433037;14933.328000240015;13533.864661353358;13759.523514083634;13895.305234738222;13980.300984950814;14238.572842814732;12265.570705025371;12691.619251422471;12743.490260389573;12756.2984035878;13108.672283192996;4085.8978525536804;4263.531011588722;4578.610818080467;4579.473360563511;4688.671792974493;123305;125001.99999999908;125449;125507.15364080796;125782;9165.862512062324;10910.127189824794;10943.179261555415;11027.283226590245;11311.886881131084;22154.778452215593;22258.10967561312;22262.77737222607;22279.44301392478;22288.108475661116;7670.4247181461615;7740.303372696371;7859.410544209207;7885.881711774328;7921.801954951057;4293.334533147367;4310.353446982977;4314.80583373749;4318.58973397533;4341.891452713708;3469.8612055517497;3537.7523573349617;3549.307884962459;3583.372909740785;3586.964130358715;645.7965740791635;652.4095693397483;657.2769953051701;663.8838203314497;670.6546128743701;541.8618252345706;565.592773203293;590.1413443439785;616.7933742196325;620.6954768679134;8588.355873309401;9096.454212747256;9148.679796207234;9157.908420915839;9183.862242066374;558.6983029164206;591.2756872830748;626.1359324132668;630.2311180359953;641.0928536121336;4245.596668316505;4367.847125350598;4430.269005614102;4452.9109417812115;4522.88692782683;98499;100132;141212;155091;159782;133536;135647;135777;135890;139441;78074;94237;108120;116221;117255.65488690179;8405.87391189145;8426.4944103354;8494.53280069602;8622.61198246093;8765.605547750494;64808.67595661992;65939.67030164819;66047.66976165089;66248.66875665591;66289;88027;96150;98411;99903.00096998937;102948;9643.710688679352;11700.765984680089;11878.881211187778;11981.700457488632;12257.754844903231;12032.27806331623;12397.318147501974;12516.436760345625;12662.303573303558;12732;12239.816402753788;12988.805167922299;13268.535601254296;13723.176609403468;13844.861551384358;13626.182429054288;13813.930930345285;13878.375473103937;14124.364403602069;14135.363908623931;11752.941235293769;13582.320883955565;13628.909687225196;13770.173789572658;14055;9810.215182785218;11363.431828408382;11381.829272560753;11444.885551144382;11830.290182589073;9882.802343953224;9934.205263578751;10425.426601536989;11521.135914806255;11556.711082223012 06:14:46 INFO - PROCESS | 1663 | __end_tp_report 06:14:46 INFO - PROCESS | 1663 | __start_cc_report 06:14:46 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1399 06:14:46 INFO - PROCESS | 1663 | __end_cc_report 06:14:46 INFO - PROCESS | 1663 | __startTimestamp1474982086465__endTimestamp 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | ------- Summary: start ------- 06:14:46 INFO - PROCESS | 1663 | Number of tests: 6 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5643.90 Median:5828.97 stddev:645.20 (11.1%) stddev-sans-first:611.99 06:14:46 INFO - PROCESS | 1663 | Values: 2964.6 3292.7 3307.6 3324.0 3371.0 5457.8 5529.6 5547.3 5628.6 5659.7 5534.7 5594.0 5652.3 5657.4 5662.9 5110.1 5172.7 5183.1 5190.8 5217.7 4677.3 5039.9 5079.9 5192.0 5192.6 4551.8 4887.9 5228.6 5241.9 5283.4 5058.5 5179.7 5182.4 5196.8 5209.8 5048.5 5057.5 5117.1 5138.9 5160.9 5440.9 5450.8 5471.5 5478.2 5489.6 6102.8 6103.8 6113.7 6115.6 6121.8 6050.6 6056.4 6113.8 6124.8 6173.1 5693.1 5699.6 5699.8 5704.7 5728.4 6289.7 6303.2 6307.9 6308.3 6310.7 5837.3 5896.7 5899.6 5971.8 6051.5 6104.5 6105.9 6111.5 6111.8 6114.0 6023.8 6029.1 6071.2 6077.5 6140.5 6116.7 6130.6 6130.8 6133.4 6149.9 4845.0 4854.7 4856.3 4864.9 4882.9 4307.3 4313.5 4319.6 4343.1 4348.3 5646.5 5657.5 5661.9 5700.8 5719.5 6146.2 6188.2 6201.3 6215.2 6218.0 5550.9 5584.4 5602.6 5647.1 5676.0 5269.3 5293.6 5331.9 5334.1 5376.0 6316.2 6322.5 6336.2 6344.5 6359.7 5985.2 6187.6 6189.4 6194.5 6203.8 6200.8 6219.0 6242.8 6305.0 6306.4 6081.1 6085.0 6091.5 6099.1 6112.0 6118.9 6155.5 6161.4 6162.7 6164.2 5761.0 5819.1 5921.8 5942.1 5999.9 5961.6 6012.9 6016.7 6054.8 6066.6 5632.2 5829.0 5833.6 5834.0 5838.2 5753.0 5847.0 5851.1 5932.7 5978.4 5708.7 5800.6 5808.0 5840.9 5853.9 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:71879.89 Median:35345.56 stddev:158776.94 (449.2%) stddev-sans-first:159131.78 06:14:46 INFO - PROCESS | 1663 | Values: 449.7 500.9 517.1 519.7 526.0 31083.0 40244.4 41325.4 41330.8 41500.6 42333.6 42985.1 43338.6 43370.1 43378.8 9807.9 9986.6 9996.9 10000.4 10019.4 8846.2 9110.3 12097.9 12354.3 12370.4 12131.1 12162.7 12207.6 12214.1 12364.8 12155.0 12205.8 12207.6 12222.0 12235.5 12002.5 12073.2 12091.8 12103.6 12104.6 40457.2 40665.0 40696.0 40794.6 40921.2 3175.8 3277.0 3291.5 3373.5 3471.5 28599.9 30176.2 30614.2 31438.8 32023.5 2884.4 3017.9 3035.7 3068.6 3118.5 486903.0 489074.0 490310.5 490523.0 498830.0 63115.7 63466.7 63504.4 63505.4 63589.7 34492.5 35153.6 35369.5 65671.3 65907.7 15981.4 16322.9 16372.0 16373.5 16389.0 11458.9 11669.0 12285.0 12313.2 12339.5 18943.5 19165.5 19248.5 19429.5 19434.3 7784.8 7825.4 7950.8 8041.4 8255.9 710.0 885.8 945.6 1002.8 1012.4 29988.6 30051.5 30183.0 30737.4 30821.6 817.5 878.3 992.8 1020.5 1034.5 12380.8 15407.8 15548.1 15619.2 15811.8 688844.9 693290.0 693302.6 693819.0 694749.0 58264.7 58580.0 58626.2 58749.0 58817.4 1176.1 1252.2 1300.2 1304.1 1362.4 30650.2 31476.0 31609.7 31728.0 32244.7 50786.2 51279.7 51335.0 51427.5 51471.0 572501.0 580714.1 581238.0 581367.0 581429.0 26186.9 26779.7 27371.9 27404.3 27968.7 46572.8 46922.8 47199.8 47507.0 47906.9 33399.3 38518.2 38815.6 38826.6 40447.0 39068.6 39321.8 39333.0 39984.4 41224.4 37988.4 38558.2 38651.4 38813.6 38847.5 32999.0 34819.8 35321.6 35462.6 35937.6 22011.9 25052.1 25587.6 25700.6 25745.2 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34521.11 Median:2483.18 stddev:98951.39 (3984.9%) stddev-sans-first:99195.67 06:14:46 INFO - PROCESS | 1663 | Values: 331.0 345.9 349.8 380.8 385.0 15139.0 15566.1 16066.2 20569.7 21131.7 19773.3 19914.1 21068.9 21072.8 21394.6 5331.5 5996.7 6234.8 6260.6 6261.3 5122.5 6811.9 6907.6 6967.8 6983.2 6651.3 6874.2 6935.3 6935.8 6958.5 6621.3 6858.7 6898.0 6905.5 6918.6 5911.4 5954.9 5970.4 5983.8 5988.1 25447.6 26012.0 26014.7 26070.0 26681.0 2423.5 2435.6 2457.8 2508.6 2511.1 13957.7 15097.3 15813.3 16064.4 16215.6 1454.7 1781.0 1819.4 1880.4 1900.8 79276.0 122249.0 123471.0 124661.0 126227.0 10498.5 10737.8 10763.8 11064.3 11284.7 13746.6 13774.2 13784.8 13788.8 13811.2 6687.8 8571.1 8587.0 8721.5 8770.1 8598.0 8598.9 8649.2 8787.3 8789.4 5604.3 6353.5 6582.5 6598.0 6598.7 1797.8 1837.1 1866.4 1870.6 1871.3 773.9 850.4 906.5 921.9 1018.7 21439.6 21991.6 22730.3 22775.1 22817.0 935.6 970.0 971.2 978.4 1047.8 11027.7 11846.6 11959.3 11985.1 12088.0 584886.0 587433.0 588719.0 609336.0 612515.0 100047.0 103089.0 107578.9 110222.0 110268.0 955.0 964.3 1001.0 1001.5 1002.0 19363.7 19687.4 19900.9 19914.8 19932.8 37075.6 50483.2 52525.5 53567.7 53659.6 74251.9 75390.0 75592.6 75653.6 77828.0 7881.4 7893.3 8113.6 8198.4 8475.0 13588.5 13671.9 13846.2 13922.2 14010.2 11061.4 11406.3 11503.6 11839.3 11949.8 11235.6 11377.5 11378.3 11649.2 11659.4 9807.7 11511.7 11726.2 11924.6 12045.8 7958.6 8018.8 8313.4 8320.8 8371.1 11442.0 11701.9 11914.5 11991.8 12053.0 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5730.84 Median:4971.83 stddev:3193.22 (64.2%) stddev-sans-first:3184.98 06:14:46 INFO - PROCESS | 1663 | Values: 1321.6 1479.9 1491.7 1697.4 1899.5 7837.5 8305.5 8459.3 8646.9 8824.2 8554.6 8778.6 8796.4 8799.4 8808.8 2337.6 2394.2 2394.7 2399.3 2399.3 2012.7 2333.9 2372.4 2390.6 2399.2 2339.5 2350.6 2351.2 2382.3 2385.4 2332.9 2365.3 2369.6 2372.8 2376.0 2329.5 2346.0 2360.5 2363.8 2368.0 8681.9 8725.2 8727.3 8743.2 8749.8 5153.3 5255.8 5389.9 5397.7 5405.9 3025.0 3505.2 3567.2 3592.2 3600.2 1024.7 1054.5 1058.3 1702.3 1752.1 11649.5 11713.8 11837.6 11858.2 11863.9 4614.0 4708.2 4869.2 4872.7 4873.4 9839.8 10084.4 10147.6 10152.6 10175.5 5404.5 5406.5 5409.1 5409.4 5419.7 3916.7 4382.6 4526.3 4540.5 4931.4 3883.8 3942.4 3963.5 3994.6 4001.2 1252.1 1276.2 1276.5 1277.4 1290.8 781.8 874.8 889.1 936.5 939.3 5787.9 5953.5 6047.8 6169.7 6329.3 884.7 900.4 907.5 911.6 964.3 3917.4 3982.0 4015.0 4117.5 4141.4 10411.9 10884.8 10885.9 10899.5 10914.7 10054.0 10644.3 10657.0 10860.9 10878.3 8114.5 8303.8 8305.2 8305.5 8321.8 5907.5 5929.6 6002.4 6126.9 6239.8 7759.8 9823.4 9875.4 10127.7 10226.2 10129.3 10207.8 10342.5 10365.9 10438.8 7527.9 7569.7 7676.2 7676.3 7715.8 7678.0 7830.1 7833.7 7836.0 7842.0 7406.3 7509.0 7514.7 7563.6 7673.9 7254.8 7407.0 7437.1 7449.1 7500.0 7035.9 7050.3 7126.6 7131.4 7158.0 5040.3 5063.3 5094.0 5106.4 5182.4 5012.2 5069.3 5224.8 5256.3 5295.8 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4473.72 Median:5031.71 stddev:1372.15 (27.3%) stddev-sans-first:1339.12 06:14:46 INFO - PROCESS | 1663 | Values: 263.7 302.7 312.3 315.4 319.8 5237.4 5283.3 5284.3 5327.5 5332.2 4823.1 4848.2 5053.4 5072.7 5247.8 3433.6 3816.7 3950.6 3968.9 3977.2 4030.1 4050.7 4055.3 4070.8 4111.7 3763.4 3880.3 3996.3 4020.1 4026.5 3224.0 3345.5 4043.5 4056.7 4060.1 2908.4 3525.9 3541.5 3542.2 3553.3 4540.8 4764.0 5158.8 5201.5 5224.4 4283.7 4589.6 4619.0 4632.6 4670.6 5550.4 5557.9 5571.6 5574.7 5591.0 3657.6 3865.7 3867.6 3873.5 3885.0 4661.7 5146.5 5275.8 5834.2 5856.2 3939.4 3956.4 3956.9 3968.4 3986.9 3433.7 3526.9 3884.8 4020.5 4034.9 3682.8 4199.4 4517.8 4659.9 4668.0 4910.8 5553.2 5577.7 5578.8 5622.4 1263.9 1264.2 1345.9 1370.4 1371.2 862.9 886.6 888.9 889.2 889.9 4465.3 5083.6 5115.7 5179.4 5265.9 4468.3 4999.9 5666.5 5676.8 5697.4 4960.0 5197.5 5230.2 5249.4 5293.2 2424.3 2928.4 2966.9 2971.8 2988.4 4892.5 4908.0 5622.4 5829.6 5863.4 4664.7 5247.8 5670.9 5715.3 5815.4 4853.1 5091.4 5830.5 5836.0 5874.2 4432.5 5598.8 5622.8 5625.9 5653.0 5026.4 5722.5 5725.7 5730.7 5741.5 5988.9 6028.7 6029.6 6033.7 6035.0 3569.8 3790.6 3806.2 3820.8 3859.3 5679.9 5683.2 5703.1 5719.9 5736.9 4155.9 5511.7 5578.4 5629.4 5635.9 4619.5 4621.7 4828.4 5249.8 5378.8 4513.3 5037.0 5403.9 5439.4 5444.0 5112.9 5402.7 5465.8 5549.6 5583.3 5222.8 5419.9 5467.6 5469.2 5475.3 06:14:46 INFO - PROCESS | 1663 | 06:14:46 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24911.10 Median:4278.43 stddev:39979.29 (934.4%) stddev-sans-first:40049.99 06:14:46 INFO - PROCESS | 1663 | Values: 665.4 725.5 776.5 799.7 827.7 13213.3 15469.7 15846.3 15860.7 15867.8 14146.2 14269.3 14291.0 14298.5 14655.8 683.2 708.4 708.9 844.4 844.5 857.0 861.9 867.4 871.4 872.3 925.4 928.0 928.3 931.4 932.4 723.1 749.9 925.7 926.3 928.3 563.9 655.7 660.0 680.2 683.0 14881.0 14897.7 14926.5 14928.6 14933.3 13533.9 13759.5 13895.3 13980.3 14238.6 12265.6 12691.6 12743.5 12756.3 13108.7 4085.9 4263.5 4578.6 4579.5 4688.7 123305.0 125002.0 125449.0 125507.2 125782.0 9165.9 10910.1 10943.2 11027.3 11311.9 22154.8 22258.1 22262.8 22279.4 22288.1 7670.4 7740.3 7859.4 7885.9 7921.8 4293.3 4310.4 4314.8 4318.6 4341.9 3469.9 3537.8 3549.3 3583.4 3587.0 645.8 652.4 657.3 663.9 670.7 541.9 565.6 590.1 616.8 620.7 8588.4 9096.5 9148.7 9157.9 9183.9 558.7 591.3 626.1 630.2 641.1 4245.6 4367.8 4430.3 4452.9 4522.9 98499.0 100132.0 141212.0 155091.0 159782.0 133536.0 135647.0 135777.0 135890.0 139441.0 78074.0 94237.0 108120.0 116221.0 117255.7 8405.9 8426.5 8494.5 8622.6 8765.6 64808.7 65939.7 66047.7 66248.7 66289.0 88027.0 96150.0 98411.0 99903.0 102948.0 9643.7 11700.8 11878.9 11981.7 12257.8 12032.3 12397.3 12516.4 12662.3 12732.0 12239.8 12988.8 13268.5 13723.2 13844.9 13626.2 13813.9 13878.4 14124.4 14135.4 11752.9 13582.3 13628.9 13770.2 14055.0 9810.2 11363.4 11381.8 11444.9 11830.3 9882.8 9934.2 10425.4 11521.1 11556.7 06:14:46 INFO - PROCESS | 1663 | -------- Summary: end -------- 06:14:46 INFO - PROCESS | 1663 | 06:14:47 INFO - TEST-INFO | 1663: exit 0 06:14:47 INFO - TEST-OK | dromaeo_css | took 1117004ms 06:14:47 INFO - TEST-START | kraken 06:14:47 INFO - operating with platform_type : mac_ 06:14:47 INFO - Initialising browser for kraken test... 06:14:47 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpKC4E59/profile http://localhost:49268/getInfo.html) 06:14:49 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 06:14:49 INFO - PROCESS | 1668 | colorDepth:24 06:14:49 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 06:14:49 INFO - PROCESS | 1668 | __metrics 06:14:49 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:14:49 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:50 INFO - TEST-INFO | 1668: exit 0 06:14:50 INFO - Browser initialized. 06:14:50 INFO - Running cycle 1/1 for kraken test... 06:14:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpKC4E59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:02 INFO - PROCESS | 1669 | RSS: Main: 235819008 06:15:02 INFO - PROCESS | 1669 | 06:15:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 06:15:06 INFO - PROCESS | 1669 | RSS: Main: 294330368 06:15:06 INFO - PROCESS | 1669 | 06:15:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 06:15:09 INFO - PROCESS | 1669 | RSS: Main: 293376000 06:15:09 INFO - PROCESS | 1669 | 06:15:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 06:15:13 INFO - PROCESS | 1669 | RSS: Main: 383332352 06:15:13 INFO - PROCESS | 1669 | 06:15:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 06:15:16 INFO - PROCESS | 1669 | RSS: Main: 287617024 06:15:16 INFO - PROCESS | 1669 | 06:15:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:15:18 INFO - PROCESS | 1669 | RSS: Main: 290254848 06:15:18 INFO - PROCESS | 1669 | 06:15:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:22 INFO - PROCESS | 1669 | RSS: Main: 328679424 06:15:22 INFO - PROCESS | 1669 | 06:15:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:25 INFO - PROCESS | 1669 | RSS: Main: 329330688 06:15:25 INFO - PROCESS | 1669 | 06:15:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 06:15:29 INFO - PROCESS | 1669 | RSS: Main: 328499200 06:15:29 INFO - PROCESS | 1669 | 06:15:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:31 INFO - PROCESS | 1669 | RSS: Main: 304447488 06:15:31 INFO - PROCESS | 1669 | 06:15:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:33 INFO - PROCESS | 1669 | RSS: Main: 305303552 06:15:33 INFO - PROCESS | 1669 | 06:15:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:36 INFO - PROCESS | 1669 | RSS: Main: 309047296 06:15:36 INFO - PROCESS | 1669 | 06:15:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:40 INFO - PROCESS | 1669 | RSS: Main: 316604416 06:15:40 INFO - PROCESS | 1669 | 06:15:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:44 INFO - PROCESS | 1669 | RSS: Main: 318390272 06:15:44 INFO - PROCESS | 1669 | 06:15:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 06:15:46 INFO - PROCESS | 1669 | RSS: Main: 362016768 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | __start_tp_report 06:15:46 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 06:15:46 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 06:15:46 INFO - PROCESS | 1669 | |i|pagename|runs| 06:15:46 INFO - PROCESS | 1669 | |0;ai-astar;109;113;111;113;113;113;113;117;164;166 06:15:46 INFO - PROCESS | 1669 | |1;audio-beat-detection;145;109;110;147;111;109;109;109;159;140 06:15:46 INFO - PROCESS | 1669 | |2;audio-dft;183;182;179;182;184;182;182;180;179;182 06:15:46 INFO - PROCESS | 1669 | |3;audio-fft;81;59;59;91;84;68;59;58;90;59 06:15:46 INFO - PROCESS | 1669 | |4;audio-oscillator;87;69;93;69;67;69;90;67;69;90 06:15:46 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;87;83;85;83;87;131;88;85;135;127 06:15:46 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;94;94;95;95;96;95;96;96;95 06:15:46 INFO - PROCESS | 1669 | |7;imaging-desaturate;95;134;130;86;86;86;87;87;92;85 06:15:46 INFO - PROCESS | 1669 | |8;json-parse-financial;55;53;53;53;55;53;53;54;54;55 06:15:46 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;65;66;72;75;77;70;68;68;68;70 06:15:46 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;103;106;106;105;88;85;87;85;86;85 06:15:46 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;141;141;139;146;148;153;151;142;169;138 06:15:46 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;169;170;184;239;194;169;168;169;167;168 06:15:46 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;70;69;82;85;66;68;66;67;69 06:15:46 INFO - PROCESS | 1669 | __end_tp_report 06:15:46 INFO - PROCESS | 1669 | __start_cc_report 06:15:46 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1936 06:15:46 INFO - PROCESS | 1669 | __end_cc_report 06:15:46 INFO - PROCESS | 1669 | __startTimestamp1474982146136__endTimestamp 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | ------- Summary: start ------- 06:15:46 INFO - PROCESS | 1669 | Number of tests: 14 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:123.20 Median:113.00 stddev:22.12 (19.6%) stddev-sans-first:22.86 06:15:46 INFO - PROCESS | 1669 | Values: 109.0 113.0 111.0 113.0 113.0 113.0 113.0 117.0 164.0 166.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:125.50 stddev:20.30 (16.2%) stddev-sans-first:20.17 06:15:46 INFO - PROCESS | 1669 | Values: 145.0 109.0 110.0 147.0 111.0 109.0 109.0 109.0 159.0 140.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:181.50 Median:182.00 stddev:1.65 (0.9%) stddev-sans-first:1.66 06:15:46 INFO - PROCESS | 1669 | Values: 183.0 182.0 179.0 182.0 184.0 182.0 182.0 180.0 179.0 182.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:70.80 Median:74.50 stddev:14.08 (18.9%) stddev-sans-first:14.44 06:15:46 INFO - PROCESS | 1669 | Values: 81.0 59.0 59.0 91.0 84.0 68.0 59.0 58.0 90.0 59.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.00 stddev:11.30 (14.5%) stddev-sans-first:11.40 06:15:46 INFO - PROCESS | 1669 | Values: 87.0 69.0 93.0 69.0 67.0 69.0 90.0 67.0 69.0 90.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:85.00 stddev:22.15 (26.1%) stddev-sans-first:23.06 06:15:46 INFO - PROCESS | 1669 | Values: 87.0 83.0 85.0 83.0 87.0 131.0 88.0 85.0 135.0 127.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 06:15:46 INFO - PROCESS | 1669 | Values: 95.0 94.0 94.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:86.50 stddev:18.84 (21.8%) stddev-sans-first:19.97 06:15:46 INFO - PROCESS | 1669 | Values: 95.0 134.0 130.0 86.0 86.0 86.0 87.0 87.0 92.0 85.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 06:15:46 INFO - PROCESS | 1669 | Values: 55.0 53.0 53.0 53.0 55.0 53.0 53.0 54.0 54.0 55.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.81 (5.4%) stddev-sans-first:3.61 06:15:46 INFO - PROCESS | 1669 | Values: 65.0 66.0 72.0 75.0 77.0 70.0 68.0 68.0 68.0 70.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:85.00 stddev:9.89 (11.6%) stddev-sans-first:9.89 06:15:46 INFO - PROCESS | 1669 | Values: 103.0 106.0 106.0 105.0 88.0 85.0 87.0 85.0 86.0 85.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:147.00 stddev:9.31 (6.3%) stddev-sans-first:9.63 06:15:46 INFO - PROCESS | 1669 | Values: 141.0 141.0 139.0 146.0 148.0 153.0 151.0 142.0 169.0 138.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:169.50 stddev:22.64 (13.4%) stddev-sans-first:23.68 06:15:46 INFO - PROCESS | 1669 | Values: 169.0 170.0 184.0 239.0 194.0 169.0 168.0 169.0 167.0 168.0 06:15:46 INFO - PROCESS | 1669 | 06:15:46 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:69.00 stddev:6.75 (9.8%) stddev-sans-first:7.07 06:15:46 INFO - PROCESS | 1669 | Values: 68.0 70.0 69.0 82.0 85.0 66.0 68.0 66.0 67.0 69.0 06:15:46 INFO - PROCESS | 1669 | -------- Summary: end -------- 06:15:46 INFO - PROCESS | 1669 | 06:15:47 INFO - TEST-INFO | 1669: exit 0 06:15:47 INFO - TEST-OK | kraken | took 60048ms 06:15:47 INFO - SUITE-END | took 1177s 06:15:47 INFO - Completed test suite (00:19:37) 06:15:47 INFO - javascript benchmark 06:15:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2964.570137330087, 3292.687194716502, 3307.6361600223972, 3323.966760332396, 3370.9831450842744, 5457.754401051952, 5529.6129270951, 5547.33431988161, 5628.634138780982, 5659.688717120562, 5534.695591742453, 5594.0, 5652.349979752319, 5657.434256574341, 5662.943370566293, 5110.105731496992, 5172.741362931848, 5183.092958732207, 5190.818321358754, 5217.686938783666, 4677.298405239208, 5039.899202015958, 5079.873003174932, 5192.013517431695, 5192.584593232532, 4551.795169217393, 4887.926681099786, 5228.555572776299, 5241.9213711794355, 5283.445238249986, 5058.544730974193, 5179.663321884065, 5182.37811462625, 5196.766145523423, 5209.765560549784, 5048.5203905628905, 5057.5448209660935, 5117.104506711311, 5138.922916156261, 5160.870978225536, 5440.891182176334, 5450.836474905759, 5471.534919531845, 5478.150886612581, 5489.615726899118, 6102.7864024759365, 6103.816885493442, 6113.694315284218, 6115.571909966304, 6121.846953826145, 6050.576459647827, 6056.364081771395, 6113.816585502442, 6124.778783120226, 6173.074038894157, 5693.117566777156, 5699.5725320600295, 5699.800506982318, 5704.686242256675, 5728.398518155617, 6289.7169627366875, 6303.180586523723, 6307.905381419282, 6308.337624549448, 6310.716017779119, 5837.3287071986415, 5896.675682837399, 5899.557533185029, 5971.7611295547695, 6051.515878729691, 6104.489471593149, 6105.8843398869885, 6111.5309653553995, 6111.7688611196745, 6113.962834745988, 6023.759049637965, 6029.095635654687, 6071.150038994544, 6077.453029227302, 6140.473573783631, 6116.66358350295, 6130.601510901777, 6130.754769809247, 6133.44798968095, 6149.907751383733, 4844.975775121173, 4854.708717476963, 4856.344393506902, 4864.902701945941, 4882.9257563336005, 4307.289297265916, 4313.460817397825, 4319.568043195718, 4343.087951530151, 4348.2825333819565, 5646.463585959327, 5657.547396208293, 5661.915071273934, 5700.7719691212715, 5719.456651618089, 6146.170267013896, 6188.164597779332, 6201.255849298022, 6215.223097112861, 6218.0, 5550.888982220333, 5584.357798853184, 5602.579806514527, 5647.096464565732, 5675.971620141873, 5269.314989051475, 5293.550048245942, 5331.86670333237, 5334.11987022137, 5376.0, 6316.242050953823, 6322.462590679844, 6336.1762970814425, 6344.524160687874, 6359.650219237987, 5985.191999080069, 6187.628742275478, 6189.35011823752, 6194.473469754941, 6203.844903877439, 6200.844978875564, 6219.036049412348, 6242.781502647385, 6305.0, 6306.432421082125, 6081.148639190428, 6085.0, 6091.451769340781, 6099.054646529795, 6111.96944015277, 6118.908216376669, 6155.538334624832, 6161.4146656067605, 6162.691865406801, 6164.229471316085, 5760.971195143998, 5819.098039803837, 5921.792737254348, 5942.1383899335215, 5999.850003749942, 5961.552883533665, 6012.939870601238, 6016.699165041643, 6054.84862878414, 6066.605670631395, 5632.1551767233605, 5828.970855145697, 5833.591648584558, 5833.970830145822, 5838.1826544282985, 5753.0, 5847.0, 5851.063829787214, 5932.703364831655, 5978.4021597839865, 5708.743106560131, 5800.56495762811, 5807.970960145172, 5840.883182336244, 5853.912191317048], "value": 5600.7460724973225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.7391512922504, 500.859759267405, 517.051211027764, 519.6726062580576, 526.0426024635163, 31083.0, 40244.396334054974, 41325.38011929816, 41330.79334603323, 41500.58499415005, 42333.57666423335, 42985.14029719404, 43338.566614333846, 43370.132597348034, 43378.783106084426, 9807.852882206773, 9986.550605222783, 9996.90003099967, 10000.449975251358, 10019.44893030883, 8846.20384165425, 9110.316726245524, 12097.939510302436, 12354.320512371816, 12370.44333005017, 12131.090168237373, 12162.695932601668, 12207.572734954278, 12214.083943704214, 12364.752704945895, 12155.0, 12205.755884882341, 12207.633770986884, 12222.022238220965, 12235.510579576807, 12002.51989920402, 12073.154879158463, 12091.818622720666, 12103.576374826927, 12104.576339828063, 40457.190856182715, 40664.983375415555, 40696.0, 40794.59205407967, 40921.181576368304, 3175.809451432898, 3277.049655599873, 3291.4733642617307, 3373.477111047767, 3471.548698669182, 28599.85700071507, 30176.24559386011, 30614.234644133852, 31438.842805786055, 32023.51964720531, 2884.351021020275, 3017.9245518862203, 3035.741961933238, 3068.6317641883115, 3118.5322201669705, 486903.0, 489074.0, 490310.54844725545, 490523.0, 498830.0, 63115.6844215776, 63466.68266658637, 63504.36495635077, 63505.36494635087, 63589.68205158944, 34492.48261276083, 35153.64846351555, 35369.46945795815, 65671.34328656652, 65907.67046164739, 15981.44064957721, 16322.918385407997, 16372.0, 16373.508794736177, 16389.0, 11458.885411145782, 11669.0, 12285.01719862409, 12313.199642023239, 12339.50641974329, 18943.52641183954, 19165.520861978282, 19248.518787030156, 19429.542784290952, 19434.319798806973, 7784.754439289686, 7825.4130940178575, 7950.761477155695, 8041.3968952328805, 8255.876161857577, 709.9503034787618, 885.7829831691148, 945.6122989574242, 1002.7793885345212, 1012.4431562640518, 29988.55017174744, 30051.549226761617, 30183.0, 30737.38525229483, 30821.61302741382, 817.464560712734, 878.2622597018535, 992.811365840488, 1020.5101551255291, 1034.4724190662816, 12380.81428778569, 15407.845921540866, 15548.067115972852, 15619.219039048003, 15811.841881581036, 688844.8904288326, 693290.0, 693302.6004609935, 693819.0, 694749.0, 58264.70867645634, 58580.0, 58626.18929769551, 58749.0, 58817.41182588205, 1176.1414167657488, 1252.1923359433115, 1300.2133709105856, 1304.067591671959, 1362.3801170467216, 30650.233744156576, 31476.0, 31609.683903160672, 31728.0, 32244.677553224166, 50786.23820642619, 51279.74360128325, 51335.0, 51427.48572514227, 51471.0, 572501.0, 580714.0964295152, 581238.0, 581367.0, 581429.0, 26186.86906565455, 26779.732202677726, 27371.86314068417, 27404.314892127855, 27968.720312796613, 46572.767136164104, 46922.765386172854, 47199.764001181145, 47507.0, 47906.85583450752, 33399.33201336008, 38518.2296354077, 38815.6118438812, 38826.6117338823, 40447.0, 39068.6093139065, 39321.80339098286, 39333.0, 39984.4002339971, 41224.38163427611, 37988.430173547975, 38558.228835422575, 38651.42022869603, 38813.611863881, 38847.47491413049, 32999.0, 34819.82590087033, 35321.64678353183, 35462.645373545936, 35937.640623594474, 22011.889940550194, 25052.123175688765, 25587.616185756855, 25700.614490782278, 25745.227643170736], "value": 20284.602723787564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.98179600122, 345.93427248822724, 349.80585774894956, 380.773439803317, 385.00092260583773, 15139.0, 15566.143862087582, 16066.196690165489, 20569.691454628155, 21131.683024754642, 19773.307934222306, 19914.10386532606, 21068.946552672383, 21072.78927210731, 21394.57210855786, 5331.520163185312, 5996.730147143389, 6234.781782637609, 6260.593061451013, 6261.279952805417, 5122.513361230677, 6811.863762724743, 6907.585544867324, 6967.79096627102, 6983.2318444971015, 6651.268360480343, 6874.243833178346, 6935.271796461349, 6935.757248496304, 6958.478114141434, 6621.304762999912, 6858.6570671466225, 6898.0, 6905.516613837033, 6918.619475928847, 5911.438413350767, 5954.851128721773, 5970.373110823388, 5983.820485385445, 5988.071848863389, 25447.61828572573, 26012.0, 26014.739852601422, 26070.0, 26681.0, 2423.478952025323, 2435.5981263091567, 2457.7910877575428, 2508.5610018246734, 2511.0834545390985, 13957.674020967992, 15097.3206205721, 15813.294774789147, 16064.357425702958, 16215.594610134842, 1454.6581553334959, 1780.9821901781077, 1819.381410320484, 1880.4452686457528, 1900.809919008102, 79276.0, 122248.99999999911, 123471.0, 124661.0, 126227.0, 10498.475076246157, 10737.83893241602, 10763.83854242187, 11064.28082174656, 11284.661460156045, 13746.587602371945, 13774.242416667179, 13784.760581263396, 13788.793168102486, 13811.240381779098, 6687.799366019027, 8571.057183709787, 8586.957065214634, 8721.476711397336, 8770.12298770118, 8598.011228708654, 8598.871016934625, 8649.221570058726, 8787.253083487974, 8789.428687135316, 5604.299462567179, 6353.491720662336, 6582.486028213538, 6597.967010164918, 6598.670066496656, 1797.7932537758063, 1837.0906401331426, 1866.3934221378106, 1870.6352261309187, 1871.335675835059, 773.8761798112388, 850.4387104510993, 906.5421961909326, 921.8525035994209, 1018.7351288665001, 21439.57120857574, 21991.560168796856, 22730.318090457313, 22775.088996439958, 22817.0, 935.6117211357347, 969.9951500242595, 971.1647982734843, 978.3738407419257, 1047.8113939490813, 11027.724306892393, 11846.585369512026, 11959.282443053271, 11985.101117416229, 12088.0, 584886.0, 587433.0, 588719.0, 609336.0, 612515.0, 100047.0, 103089.0, 107578.92421075846, 110222.0, 110268.0, 955.0, 964.2671569607008, 1000.9899901000897, 1001.4692213127055, 1001.9549120289604, 19363.709544356563, 19687.40937771869, 19900.90049549743, 19914.800851991295, 19932.800671993093, 37075.62924370722, 50483.242751358026, 52525.47474525206, 53567.7145828325, 53659.63403659603, 74251.8862217078, 75390.0, 75592.62203688946, 75653.62173189099, 77828.0, 7881.369490440866, 7893.329067029367, 8113.59432028408, 8198.426110172231, 8475.0, 13588.456461741815, 13671.931640341734, 13846.169229846242, 13922.164670119826, 14010.159390436607, 11061.446927653746, 11406.258593191416, 11503.606436101538, 11839.28964262147, 11949.761004779682, 11235.606753763579, 11377.4880130396, 11378.31730096197, 11649.184557081262, 11659.358735269641, 9807.705768826661, 11511.654650360502, 11726.237794543327, 11924.582639607572, 12045.75908481843, 7958.647030004798, 8018.799530011796, 8313.41806073569, 8320.750377488685, 8371.079181290175, 11442.0, 11701.88298117042, 11914.463849126636, 11991.76016479683, 12053.035757139232], "value": 9880.540694994757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.5969129415537, 1479.874210692091, 1491.6718321969167, 1697.3719723702225, 1899.5346140195654, 7837.490563113393, 8305.460145090572, 8459.280961118304, 8646.91353086469, 8824.161704638065, 8554.615042323096, 8778.604962776675, 8796.428232164904, 8799.384043116985, 8808.77978050549, 2337.6259798432297, 2394.1859767678984, 2394.676718642987, 2399.256230568529, 2399.3042017814814, 2012.7182194492782, 2333.8949747261413, 2372.41875740443, 2390.5935990881594, 2399.2442380650127, 2339.485313231095, 2350.565145448089, 2351.235848349285, 2382.3210385040265, 2385.355953892448, 2332.8833558322017, 2365.266767302142, 2369.597168481362, 2372.8220383471307, 2375.9524809503887, 2329.4991576811067, 2345.988270058656, 2360.480694247263, 2363.7636236376397, 2367.9644805327935, 8681.869771953427, 8725.214730674206, 8727.345449091343, 8743.169398907157, 8749.825003499958, 5153.252778347156, 5255.816046438395, 5389.9191512127345, 5397.73011349431, 5405.864853378657, 3024.9546256806166, 3505.1762835733584, 3567.1795487037866, 3592.209713862946, 3600.171960449085, 1024.7130803375067, 1054.5201933120488, 1058.3385384134915, 1702.2510095557916, 1752.1326943163215, 11649.47577359021, 11713.765724685543, 11837.644870653894, 11858.229215101077, 11863.94068029663, 4614.0, 4708.176069187947, 4869.245266983623, 4872.6589138760655, 4873.439554451284, 9839.80320393588, 10084.445355505371, 10147.64483243083, 10152.593896244067, 10175.491225438698, 5404.459554044564, 5406.513413792777, 5409.107497262986, 5409.377921539073, 5419.701916394636, 3916.706247031484, 4382.583654552813, 4526.253168227271, 4540.500544940054, 4931.432885218174, 3883.786391748481, 3942.3692209246383, 3963.5243770747693, 3994.6205110514456, 4001.1797581495725, 1252.1485389934749, 1276.189619591566, 1276.4766445757195, 1277.367702987009, 1290.7805673035607, 781.8397228568243, 874.7987962768472, 889.0664801957919, 936.5317341329335, 939.262678797141, 5787.855303617359, 5953.523718102541, 6047.848803779941, 6169.660668663177, 6329.2721337045905, 884.7036242858586, 900.401233179928, 907.5099446299057, 911.5715613661569, 964.3153361113548, 3917.4123881418013, 3981.960180398217, 4014.9561114110543, 4117.464729585195, 4141.4409054777825, 10411.895881041093, 10884.836727449094, 10885.945570272099, 10899.455027248607, 10914.672559823219, 10054.0, 10644.338915271182, 10657.0, 10860.891391086147, 10878.292910960763, 8114.513129212266, 8303.8339233215, 8305.21100495464, 8305.501669899826, 8321.833563328699, 5907.49786268172, 5929.555283353679, 6002.429769171922, 6126.877462450815, 6239.845628558731, 7759.806004849924, 9823.36148150368, 9875.407475551203, 10127.7468063299, 10226.23303252274, 10129.341592796445, 10207.795844083224, 10342.5345859435, 10365.9481702591, 10438.791224175626, 7527.870819377137, 7569.735059272899, 7676.232376762502, 7676.270754278335, 7715.768526944201, 7678.0, 7830.1386847447875, 7833.725819596287, 7836.0, 7842.019747531559, 7406.296401841816, 7508.962455187689, 7514.661840217313, 7563.584002879895, 7673.8848917267405, 7254.818629534304, 7406.962965185139, 7437.144728356308, 7449.14334851499, 7499.962500187682, 7035.929640703527, 7050.294970502909, 7126.572405655677, 7131.393831524379, 7157.964210178916, 5040.269160971712, 5063.291139240583, 5093.974530127474, 5106.412762532208, 5182.378114626118, 5012.223105418666, 5069.31564238823, 5224.7648855802345, 5256.290400795997, 5295.788168473218], "value": 4621.1340064199785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.70991908900214, 302.7230084472706, 312.3425189975102, 315.36611411063757, 319.8352848283136, 5237.355135656493, 5283.260343551906, 5284.286621306118, 5327.534927894831, 5332.2137084076885, 4823.1189835964005, 4848.248521479177, 5053.36832895888, 5072.72100034498, 5247.842564723064, 3433.5879694436703, 3816.664167541366, 3950.6246906543834, 3968.8610898618554, 3977.1846771411792, 4030.146132778925, 4050.696197785178, 4055.3105971984687, 4070.7761073140964, 4111.691623128262, 3763.41667041609, 3880.2821478026513, 3996.3006473867104, 4020.115574573589, 4026.516817981846, 3223.951640725391, 3345.5483509726364, 4043.4945631796027, 4056.675465962716, 4060.1473690525027, 2908.4003797911278, 3525.9294814103832, 3541.451075083366, 3542.1662669864004, 3553.3248682750195, 4540.841070562547, 4764.0, 5158.819441319536, 5201.453847346012, 5224.425313215544, 4283.678724095706, 4589.5639914208095, 4619.0, 4632.5830675239395, 4670.579647831712, 5550.4449555044175, 5557.861053473695, 5571.637843540157, 5574.693391863446, 5590.972045139789, 3657.6159503252043, 3865.6714179294795, 3867.6325749054076, 3873.4964454621, 3884.9805750971345, 4661.696989695659, 5146.511081447256, 5275.841724748264, 5834.183214349994, 5856.209411729405, 3939.3697008478507, 3956.3669812829808, 3956.9208615827524, 3968.444417781513, 3986.9202615948097, 3433.7081348085194, 3526.85377252394, 3884.776295466919, 4020.4572382728543, 4034.919301613951, 3682.815859207029, 4199.4120823084795, 4517.757616655446, 4659.883502912454, 4667.95332046682, 4910.8281210157475, 5553.195636203772, 5577.721113944286, 5578.8047418340975, 5622.353429355595, 1263.9130347900798, 1264.2477725753163, 1345.865413458666, 1370.3627813066971, 1371.1841454334656, 862.9266512346395, 886.6409104312763, 888.9199972002551, 889.1997202517786, 889.9199072083544, 4465.307877279027, 5083.644144909821, 5115.693058416507, 5179.404368497596, 5265.947340526623, 4468.262736648481, 4999.925001124986, 5666.518345940642, 5676.801311954062, 5697.430256974352, 4959.950400496021, 5197.480251974848, 5230.163173892235, 5249.396319423239, 5293.232481290192, 2424.272718184573, 2928.428956353491, 2966.9109926702235, 2971.8305636885193, 2988.44713727961, 4892.461829198785, 4907.950920490749, 5622.353429355595, 5829.551588332825, 5863.442972917566, 4664.743439110882, 5247.763850626731, 5670.858228544319, 5715.342735585377, 5815.41845815415, 4853.126437241331, 5091.41448733393, 5830.5044071254415, 5836.007878660553, 5874.236349274653, 4432.512423633462, 5598.832035038955, 5622.7750889963945, 5625.943740562542, 5653.0, 5026.421961474477, 5722.5421966241765, 5725.713714314351, 5730.684812335361, 5741.5119714824705, 5988.910166347596, 6028.668423236764, 6029.638221706711, 6033.698315084316, 6035.0, 3569.8215089245955, 3790.639889210521, 3806.200697853371, 3820.8089595519555, 3859.3053250415196, 5679.8864022720145, 5683.215224540028, 5703.089465029096, 5719.942800571941, 5736.885262294814, 4155.916881662411, 5511.704749383972, 5578.358488773681, 5629.437056294338, 5635.943640563706, 4619.538046195354, 4621.676482646182, 4828.444728856227, 5249.842504724865, 5378.784848606168, 4513.269471969411, 5037.0, 5403.86547313801, 5439.4288599696465, 5444.047291724011, 5112.948870511247, 5402.72986350673, 5465.836024919259, 5549.556035517229, 5583.302087239095, 5222.764975576184, 5419.891602168013, 5467.644603100785, 5469.1951655954235, 5475.260839786737], "value": 4038.981434283898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.4377051391574, 725.4522835259378, 776.4758787818221, 799.6601444386134, 827.7144385187116, 13213.273269970148, 15469.690606187884, 15846.28691708873, 15860.682786344267, 15867.841321586795, 14146.221957792317, 14269.286535673227, 14291.0, 14298.499552515665, 14655.780163297559, 683.2006552333756, 708.3624737736053, 708.922018577956, 844.3582877013453, 844.4553263145268, 856.9700060497884, 861.8534849075672, 867.397158974513, 871.4292138649195, 872.3413822563955, 925.4447331601053, 928.0348437624862, 928.3362395886974, 931.4085555672164, 932.3566738950136, 723.0997408226739, 749.913759917611, 925.7361651929201, 926.2867591954158, 928.3455164109321, 563.9041362968305, 655.6951017776756, 659.9604023758542, 680.2245440198178, 682.9829254268633, 14881.032732872329, 14897.702045959128, 14926.477573284883, 14928.62678433037, 14933.328000240015, 13533.864661353358, 13759.523514083634, 13895.305234738222, 13980.300984950814, 14238.572842814732, 12265.570705025371, 12691.619251422471, 12743.490260389573, 12756.2984035878, 13108.672283192996, 4085.8978525536804, 4263.531011588722, 4578.610818080467, 4579.473360563511, 4688.671792974493, 123305.0, 125001.99999999908, 125449.0, 125507.15364080796, 125782.0, 9165.862512062324, 10910.127189824794, 10943.179261555415, 11027.283226590245, 11311.886881131084, 22154.778452215593, 22258.10967561312, 22262.77737222607, 22279.44301392478, 22288.108475661116, 7670.4247181461615, 7740.303372696371, 7859.410544209207, 7885.881711774328, 7921.801954951057, 4293.334533147367, 4310.353446982977, 4314.80583373749, 4318.58973397533, 4341.891452713708, 3469.8612055517497, 3537.7523573349617, 3549.307884962459, 3583.372909740785, 3586.964130358715, 645.7965740791635, 652.4095693397483, 657.2769953051701, 663.8838203314497, 670.6546128743701, 541.8618252345706, 565.592773203293, 590.1413443439785, 616.7933742196325, 620.6954768679134, 8588.355873309401, 9096.454212747256, 9148.679796207234, 9157.908420915839, 9183.862242066374, 558.6983029164206, 591.2756872830748, 626.1359324132668, 630.2311180359953, 641.0928536121336, 4245.596668316505, 4367.847125350598, 4430.269005614102, 4452.9109417812115, 4522.88692782683, 98499.0, 100132.0, 141212.0, 155091.0, 159782.0, 133536.0, 135647.0, 135777.0, 135890.0, 139441.0, 78074.0, 94237.0, 108120.0, 116221.0, 117255.65488690179, 8405.87391189145, 8426.4944103354, 8494.53280069602, 8622.61198246093, 8765.605547750494, 64808.67595661992, 65939.67030164819, 66047.66976165089, 66248.66875665591, 66289.0, 88027.0, 96150.0, 98411.0, 99903.00096998937, 102948.0, 9643.710688679352, 11700.765984680089, 11878.881211187778, 11981.700457488632, 12257.754844903231, 12032.27806331623, 12397.318147501974, 12516.436760345625, 12662.303573303558, 12732.0, 12239.816402753788, 12988.805167922299, 13268.535601254296, 13723.176609403468, 13844.861551384358, 13626.182429054288, 13813.930930345285, 13878.375473103937, 14124.364403602069, 14135.363908623931, 11752.941235293769, 13582.320883955565, 13628.909687225196, 13770.173789572658, 14055.0, 9810.215182785218, 11363.431828408382, 11381.829272560753, 11444.885551144382, 11830.290182589073, 9882.802343953224, 9934.205263578751, 10425.426601536989, 11521.135914806255, 11556.711082223012], "value": 7724.320951123787, "unit": "score"}], "name": "dromaeo_css", "value": 7382.218794521475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 111.0, 113.0, 113.0, 113.0, 113.0, 117.0, 164.0, 166.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 110.0, 147.0, 111.0, 109.0, 109.0, 109.0, 159.0, 140.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 179.0, 182.0, 184.0, 182.0, 182.0, 180.0, 179.0, 182.0], "value": 181.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 91.0, 84.0, 68.0, 59.0, 58.0, 90.0, 59.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 93.0, 69.0, 67.0, 69.0, 90.0, 67.0, 69.0, 90.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 83.0, 87.0, 131.0, 88.0, 85.0, 135.0, 127.0], "value": 99.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 134.0, 130.0, 86.0, 86.0, 86.0, 87.0, 87.0, 92.0, 85.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 55.0, 53.0, 53.0, 54.0, 54.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 72.0, 75.0, 77.0, 70.0, 68.0, 68.0, 68.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 106.0, 106.0, 105.0, 88.0, 85.0, 87.0, 85.0, 86.0, 85.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 139.0, 146.0, 148.0, 153.0, 151.0, 142.0, 169.0, 138.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 184.0, 239.0, 194.0, 169.0, 168.0, 169.0, 167.0, 168.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 82.0, 85.0, 66.0, 68.0, 66.0, 67.0, 69.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1483.1, "alertThreshold": 2.0}]} 06:15:47 INFO - Return code: 0 06:15:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:47 INFO - # TBPL SUCCESS # 06:15:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:47 INFO - 2016-09-27 06:15:47.465 screenresolution[1673:10164] starting screenresolution argv=screenresolution get 06:15:47 INFO - 2016-09-27 06:15:47.467 screenresolution[1673:10164] Display 0: 1600x1200x32@60 06:15:47 INFO - 2016-09-27 06:15:47.473 screenresolution[1674:10168] starting screenresolution argv=screenresolution list 06:15:47 INFO - Available Modes on Display 0 06:15:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:47 INFO - Intel Iris: 06:15:47 INFO - Chipset Model: Intel Iris 06:15:47 INFO - Type: GPU 06:15:47 INFO - Bus: Built-In 06:15:47 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:47 INFO - Vendor: Intel (0x8086) 06:15:47 INFO - Device ID: 0x0a2e 06:15:47 INFO - Revision ID: 0x0009 06:15:47 INFO - Displays: 06:15:47 INFO - Display: 06:15:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:47 INFO - Display Serial Number: 1600x1200 60 06:15:47 INFO - Main Display: Yes 06:15:47 INFO - Mirror: Off 06:15:47 INFO - Online: Yes 06:15:47 INFO - Rotation: Supported 06:15:47 INFO - Return code: 0 06:15:47 INFO - Running post-action listener: _resource_record_post_action 06:15:47 INFO - [mozharness: 2016-09-27 13:15:47.716287Z] Finished run-tests step (success) 06:15:47 INFO - Running post-run listener: _resource_record_post_run 06:15:47 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32988160; Write bytes: 707969536; Read time: 308; Write time: 2034 06:15:47 INFO - TinderboxPrint: CPU usage
53.5% 06:15:47 INFO - TinderboxPrint: I/O read bytes / time
32,988,160 / 308 06:15:47 INFO - TinderboxPrint: I/O write bytes / time
707,969,536 / 2,034 06:15:47 INFO - TinderboxPrint: CPU idle
2,257.4 (46.5%) 06:15:47 INFO - TinderboxPrint: CPU system
968.3 (20.0%) 06:15:47 INFO - TinderboxPrint: CPU user
1,624.0 (33.5%) 06:15:47 INFO - TinderboxPrint: Swap in / out
435,597,312 / 0 06:15:47 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401578496; Write bytes: 396518912; Read time: 29596; Write time: 709 06:15:47 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30903296; Write bytes: 296578048; Read time: 285; Write time: 1287 06:15:48 INFO - Running post-run listener: _upload_blobber_files 06:15:48 INFO - Blob upload gear active. 06:15:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:48 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 06:15:48 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:48 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:49 INFO - (blobuploader) - INFO - Done attempting. 06:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:50 INFO - (blobuploader) - INFO - Done attempting. 06:15:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:52 INFO - (blobuploader) - INFO - Done attempting. 06:15:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:52 INFO - Return code: 0 06:15:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5630c324f75df830e4c79c31fb71fdf1931c5a09995c3d897e8b1236d8a683b4f30ae9f526076c4d171cfd55eba872283611edc87a2a39a2453598156f015dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69fc20ceebf12a65022eef8db6e222cd796d9fa504090aa0765efd64b8d33d774d8a16fd68f92229f2ccc5afa0dc59f61b65b3d08055bed1d0932cb62156d2bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07fa0d45499cbf0ac8b42c907e4016a5fe2ad9d12c51a9d3d6ae8d90674dc0389dcce20f8af1d65ab53ae4fa1805e2147c981503110703cc27fd6f2b2139c890"} 06:15:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:52 INFO - Contents: 06:15:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5630c324f75df830e4c79c31fb71fdf1931c5a09995c3d897e8b1236d8a683b4f30ae9f526076c4d171cfd55eba872283611edc87a2a39a2453598156f015dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69fc20ceebf12a65022eef8db6e222cd796d9fa504090aa0765efd64b8d33d774d8a16fd68f92229f2ccc5afa0dc59f61b65b3d08055bed1d0932cb62156d2bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07fa0d45499cbf0ac8b42c907e4016a5fe2ad9d12c51a9d3d6ae8d90674dc0389dcce20f8af1d65ab53ae4fa1805e2147c981503110703cc27fd6f2b2139c890"} 06:15:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:52 INFO - Copying logs to upload dir... 06:15:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.401111 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-27 06:15:52.461586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:15:52.465174) ========= 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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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/Fx-Team/sha512/5630c324f75df830e4c79c31fb71fdf1931c5a09995c3d897e8b1236d8a683b4f30ae9f526076c4d171cfd55eba872283611edc87a2a39a2453598156f015dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69fc20ceebf12a65022eef8db6e222cd796d9fa504090aa0765efd64b8d33d774d8a16fd68f92229f2ccc5afa0dc59f61b65b3d08055bed1d0932cb62156d2bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07fa0d45499cbf0ac8b42c907e4016a5fe2ad9d12c51a9d3d6ae8d90674dc0389dcce20f8af1d65ab53ae4fa1805e2147c981503110703cc27fd6f2b2139c890"} build_url:https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/asEB6kfySQalJzywXPVh2w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5630c324f75df830e4c79c31fb71fdf1931c5a09995c3d897e8b1236d8a683b4f30ae9f526076c4d171cfd55eba872283611edc87a2a39a2453598156f015dcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69fc20ceebf12a65022eef8db6e222cd796d9fa504090aa0765efd64b8d33d774d8a16fd68f92229f2ccc5afa0dc59f61b65b3d08055bed1d0932cb62156d2bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07fa0d45499cbf0ac8b42c907e4016a5fe2ad9d12c51a9d3d6ae8d90674dc0389dcce20f8af1d65ab53ae4fa1805e2147c981503110703cc27fd6f2b2139c890"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:15:52.503134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:15:52.503901) ========= 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.aFjDUVhqWe/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.o8Hu24oRSw/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005052 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:15:52.556327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:15:52.557057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:15:52.557797) ========= ========= Total master_lag: 0.18 =========