builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0268 starttime: 1475148615.1 results: success (0) buildid: 20160929011819 builduid: 4651cc23b37542b097312a2dba6935d5 revision: c593d6a120714593d0c2bf3bf670182c48e24f50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:15.096831) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:15.097237) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:15.097504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:15.122163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-29 04:30:15.122425) ========= 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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-29 04:30:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-09-29 04:30:15 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103682 ========= master_lag: 2.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-29 04:30:17.515398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:17.515745) ========= 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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.038623 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:17.574939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 04:30:17.575292) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c593d6a120714593d0c2bf3bf670182c48e24f50 --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 c593d6a120714593d0c2bf3bf670182c48e24f50 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-29 04:30:17,656 truncating revision to first 12 chars 2016-09-29 04:30:17,656 Setting DEBUG logging. 2016-09-29 04:30:17,656 attempt 1/10 2016-09-29 04:30:17,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c593d6a12071?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 04:30:18,671 unpacking tar archive at: fx-team-c593d6a12071/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 04:30:18.867853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:18.868185) ========= script_repo_revision: c593d6a120714593d0c2bf3bf670182c48e24f50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:18.868583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:18.868844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 04:30:18.886767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-29 04:30:18.887079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:19 INFO - MultiFileLogger online at 20160929 04:30:19 in /builds/slave/test 04:30:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:30:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:19 INFO - {'append_to_log': False, 04:30:19 INFO - 'base_work_dir': '/builds/slave/test', 04:30:19 INFO - 'blob_upload_branch': 'Fx-Team', 04:30:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:19 INFO - 'branch': 'Fx-Team', 04:30:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:19 INFO - 'config_files': ('talos/mac_config.py',), 04:30:19 INFO - 'default_actions': ('clobber', 04:30:19 INFO - 'read-buildbot-config', 04:30:19 INFO - 'download-and-extract', 04:30:19 INFO - 'populate-webroot', 04:30:19 INFO - 'create-virtualenv', 04:30:19 INFO - 'install', 04:30:19 INFO - 'run-tests'), 04:30:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:19 INFO - 'download_minidump_stackwalk': True, 04:30:19 INFO - 'download_symbols': 'ondemand', 04:30:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:19 INFO - 'installer_path': 'installer.exe', 04:30:19 INFO - 'log_level': 'info', 04:30:19 INFO - 'log_name': 'talos', 04:30:19 INFO - 'log_to_console': True, 04:30:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:19 INFO - 'opt_config_files': (), 04:30:19 INFO - 'pip_index': False, 04:30:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:19 INFO - 'cmd': ('bash', 04:30:19 INFO - '-c', 04:30:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:19 INFO - 'enabled': True, 04:30:19 INFO - 'halt_on_failure': False, 04:30:19 INFO - 'name': 'check_screen_resolution'},), 04:30:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:19 INFO - 'cmd': ('bash', 04:30:19 INFO - '-c', 04:30:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:19 INFO - 'enabled': True, 04:30:19 INFO - 'halt_on_failure': False, 04:30:19 INFO - 'name': 'check_screen_resolution'},), 04:30:19 INFO - 'run_cmd_checks_enabled': True, 04:30:19 INFO - 'sps_profile': False, 04:30:19 INFO - 'sps_profile_interval': 0, 04:30:19 INFO - 'suite': 'dromaeojs-e10s', 04:30:19 INFO - 'system_bits': '32', 04:30:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:19 INFO - 'title': 't-yosemite-r7-0268', 04:30:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:19 INFO - 'use_talos_json': True, 04:30:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:19 INFO - 'work_dir': 'build'} 04:30:19 INFO - [mozharness: 2016-09-29 11:30:19.090316Z] Running clobber step. 04:30:19 INFO - Running pre-action listener: _resource_record_pre_action 04:30:19 INFO - Running main action method: clobber 04:30:19 INFO - rmtree: /builds/slave/test/build 04:30:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:21 INFO - Running post-action listener: _resource_record_post_action 04:30:21 INFO - [mozharness: 2016-09-29 11:30:21.153800Z] Finished clobber step (success) 04:30:21 INFO - [mozharness: 2016-09-29 11:30:21.154013Z] Running read-buildbot-config step. 04:30:21 INFO - Running pre-action listener: _resource_record_pre_action 04:30:21 INFO - Running main action method: read_buildbot_config 04:30:21 INFO - Using buildbot properties: 04:30:21 INFO - { 04:30:21 INFO - "project": "", 04:30:21 INFO - "product": "firefox", 04:30:21 INFO - "script_repo_revision": "production", 04:30:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:30:21 INFO - "repository": "", 04:30:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:30:21 INFO - "buildid": "20160929011819", 04:30:21 INFO - "pgo_build": "False", 04:30:21 INFO - "basedir": "/builds/slave/test", 04:30:21 INFO - "buildnumber": 791, 04:30:21 INFO - "slavename": "t-yosemite-r7-0268", 04:30:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:30:21 INFO - "platform": "yosemite_r7", 04:30:21 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 04:30:21 INFO - "branch": "fx-team", 04:30:21 INFO - "repo_path": "integration/fx-team", 04:30:21 INFO - "revision": "c593d6a120714593d0c2bf3bf670182c48e24f50", 04:30:21 INFO - "stage_platform": "macosx64", 04:30:21 INFO - "builduid": "4651cc23b37542b097312a2dba6935d5", 04:30:21 INFO - "slavebuilddir": "test" 04:30:21 INFO - } 04:30:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:30:21 INFO - Running post-action listener: _resource_record_post_action 04:30:21 INFO - [mozharness: 2016-09-29 11:30:21.157409Z] Finished read-buildbot-config step (success) 04:30:21 INFO - [mozharness: 2016-09-29 11:30:21.157527Z] Running download-and-extract step. 04:30:21 INFO - Running pre-action listener: _resource_record_pre_action 04:30:21 INFO - Running main action method: download_and_extract 04:30:21 INFO - mkdir: /builds/slave/test/build/tests 04:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:21 INFO - trying https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:30:21 INFO - Downloading https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/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 04:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/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 04:30:22 INFO - Downloaded 1199 bytes. 04:30:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:30:22 INFO - Using the following test package requirements: 04:30:22 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:30:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:30:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'jsshell-mac.zip'], 04:30:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:30:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:30:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:30:22 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:30:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:30:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:30:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:30:22 INFO - Expected file size: 16472779 04:30:22 INFO - Content-Encoding None 04:30:22 INFO - Content-Type application/zip 04:30:22 INFO - Http code 200 04:30:30 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 04:30:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:30:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:30 INFO - Fetch https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:30:30 INFO - Expected file size: 16472779 04:30:30 INFO - Content-Encoding None 04:30:30 INFO - Content-Type application/zip 04:30:30 INFO - Http code 200 04:30:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:30:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:30:37 INFO - Fetch https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:30:38 INFO - Expected file size: 14414067 04:30:38 INFO - Content-Encoding None 04:30:38 INFO - Content-Type application/zip 04:30:38 INFO - Http code 200 04:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:39 INFO - trying https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:30:39 INFO - Downloading https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/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 04:30:43 INFO - Downloaded 111796338 bytes. 04:30:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:30:43 INFO - mkdir: /builds/slave/test/properties 04:30:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:43 INFO - Contents: 04:30:43 INFO - build_url:https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:30:44 INFO - Running post-action listener: _resource_record_post_action 04:30:44 INFO - Running post-action listener: set_extra_try_arguments 04:30:44 INFO - [mozharness: 2016-09-29 11:30:44.365750Z] Finished download-and-extract step (success) 04:30:44 INFO - [mozharness: 2016-09-29 11:30:44.365890Z] Running populate-webroot step. 04:30:44 INFO - Running pre-action listener: _resource_record_pre_action 04:30:44 INFO - Running main action method: populate_webroot 04:30:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:44 INFO - '--tppagecycles', 04:30:44 INFO - '7'], 04:30:44 INFO - 'tests': ['tsvgm']}}, 04:30:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['damp', 'tps']}, 04:30:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'tests': ['damp', 'tps']}, 04:30:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['dromaeo_dom']}, 04:30:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['basic_compositor_video']}, 04:30:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['a11yr', 04:30:44 INFO - 'ts_paint', 04:30:44 INFO - 'tpaint', 04:30:44 INFO - 'sessionrestore', 04:30:44 INFO - 'sessionrestore_no_auto_restore', 04:30:44 INFO - 'tabpaint']}, 04:30:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['tsvgx', 04:30:44 INFO - 'tsvgr_opacity', 04:30:44 INFO - 'tart', 04:30:44 INFO - 'tscrollx', 04:30:44 INFO - 'cart']}, 04:30:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:44 INFO - 'tsvgr_opacity', 04:30:44 INFO - 'tart', 04:30:44 INFO - 'tscrollx', 04:30:44 INFO - 'cart']}, 04:30:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'talos_options': ['--disable-e10s'], 04:30:44 INFO - 'tests': ['tp5o']}, 04:30:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'tests': ['tp5o']}, 04:30:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'talos_options': ['--disable-e10s', 04:30:44 INFO - '--xperf_path', 04:30:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:44 INFO - 'tests': ['tp5n']}, 04:30:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:44 INFO - 'talos_options': ['--xperf_path', 04:30:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:44 INFO - 'tests': ['tp5n']}}, 04:30:44 INFO - 'talos.zip': {'path': '', 04:30:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:44 INFO - Running post-action listener: _resource_record_post_action 04:30:44 INFO - [mozharness: 2016-09-29 11:30:44.385835Z] Finished populate-webroot step (success) 04:30:44 INFO - [mozharness: 2016-09-29 11:30:44.385963Z] Running create-virtualenv step. 04:30:44 INFO - Running pre-action listener: _resource_record_pre_action 04:30:44 INFO - Running main action method: create_virtualenv 04:30:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:44 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 04:30:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:44 INFO - Using real prefix '/tools/python27' 04:30:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:48 INFO - Installing pip.................done. 04:30:48 INFO - Return code: 0 04:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:48 INFO - Reading from file tmpfile_stdout 04:30:48 INFO - Output received: 04:30:48 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) 04:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:48 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 04:30:48 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 04:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:48 INFO - 'HOME': '/Users/cltbld', 04:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PAGER': '/bin/cat', 04:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:48 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - 'XPC_FLAGS': '0x0', 04:30:48 INFO - 'XPC_SERVICE_NAME': '0', 04:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 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 04:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:48 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 04:30:48 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 04:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:48 INFO - 'HOME': '/Users/cltbld', 04:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PAGER': '/bin/cat', 04:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:48 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - 'XPC_FLAGS': '0x0', 04:30:48 INFO - 'XPC_SERVICE_NAME': '0', 04:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 INFO - Downloading/unpacking psutil>=3.1.1 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:51 INFO - Installing collected packages: psutil 04:30:51 INFO - Running setup.py install for psutil 04:30:51 INFO - building 'psutil._psutil_osx' extension 04:30:51 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 INFO - building 'psutil._psutil_posix' extension 04:30:52 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 04:30:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:52 INFO - ^ 04:30:52 INFO - 1 warning generated. 04:30:52 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 04:30:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:52 INFO - Successfully installed psutil 04:30:52 INFO - Cleaning up... 04:30:52 INFO - Return code: 0 04:30:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:52 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')]} 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 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')]} 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:52 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 04:30:52 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 04:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:52 INFO - 'HOME': '/Users/cltbld', 04:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:52 INFO - 'LOGNAME': 'cltbld', 04:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:52 INFO - 'MOZ_NO_REMOTE': '1', 04:30:52 INFO - 'NO_EM_RESTART': '1', 04:30:52 INFO - 'PAGER': '/bin/cat', 04:30:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:52 INFO - 'PWD': '/builds/slave/test', 04:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:52 INFO - 'SHELL': '/bin/bash', 04:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:52 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:52 INFO - 'USER': 'cltbld', 04:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:52 INFO - 'XPC_FLAGS': '0x0', 04:30:52 INFO - 'XPC_SERVICE_NAME': '0', 04:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:55 INFO - Installing collected packages: mozsystemmonitor 04:30:55 INFO - Running setup.py install for mozsystemmonitor 04:30:55 INFO - Successfully installed mozsystemmonitor 04:30:55 INFO - Cleaning up... 04:30:56 INFO - Return code: 0 04:30:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:56 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')]} 04:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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')]} 04:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:56 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 04:30:56 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 04:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:56 INFO - 'HOME': '/Users/cltbld', 04:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:56 INFO - 'LOGNAME': 'cltbld', 04:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:56 INFO - 'MOZ_NO_REMOTE': '1', 04:30:56 INFO - 'NO_EM_RESTART': '1', 04:30:56 INFO - 'PAGER': '/bin/cat', 04:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:56 INFO - 'PWD': '/builds/slave/test', 04:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:56 INFO - 'SHELL': '/bin/bash', 04:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:56 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:56 INFO - 'USER': 'cltbld', 04:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:56 INFO - 'XPC_FLAGS': '0x0', 04:30:56 INFO - 'XPC_SERVICE_NAME': '0', 04:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:56 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:59 INFO - warning: no files found matching '*.txt' 04:30:59 INFO - no previously-included directories found matching 'build' 04:30:59 INFO - no previously-included directories found matching 'dist' 04:30:59 INFO - no previously-included directories found matching '.git*' 04:30:59 INFO - Installing collected packages: jsonschema, functools32 04:30:59 INFO - Running setup.py install for functools32 04:30:59 INFO - warning: no files found matching '*.txt' 04:30:59 INFO - no previously-included directories found matching 'build' 04:30:59 INFO - no previously-included directories found matching 'dist' 04:30:59 INFO - no previously-included directories found matching '.git*' 04:30:59 INFO - Successfully installed jsonschema functools32 04:30:59 INFO - Cleaning up... 04:30:59 INFO - Return code: 0 04:30:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:59 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 04:30:59 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 04:30:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:59 INFO - 'HOME': '/Users/cltbld', 04:30:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:59 INFO - 'LOGNAME': 'cltbld', 04:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:59 INFO - 'MOZ_NO_REMOTE': '1', 04:30:59 INFO - 'NO_EM_RESTART': '1', 04:30:59 INFO - 'PAGER': '/bin/cat', 04:30:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:59 INFO - 'PWD': '/builds/slave/test', 04:30:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:59 INFO - 'SHELL': '/bin/bash', 04:30:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:59 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:59 INFO - 'USER': 'cltbld', 04:30:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:59 INFO - 'XPC_FLAGS': '0x0', 04:30:59 INFO - 'XPC_SERVICE_NAME': '0', 04:30:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:59 INFO - Cleaning up... 04:30:59 INFO - Return code: 0 04:30:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:30:59 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 04:30:59 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 04:30:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:30:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:59 INFO - 'HOME': '/Users/cltbld', 04:30:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:59 INFO - 'LOGNAME': 'cltbld', 04:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:59 INFO - 'MOZ_NO_REMOTE': '1', 04:30:59 INFO - 'NO_EM_RESTART': '1', 04:30:59 INFO - 'PAGER': '/bin/cat', 04:30:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:59 INFO - 'PWD': '/builds/slave/test', 04:30:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:59 INFO - 'SHELL': '/bin/bash', 04:30:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:30:59 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:30:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:59 INFO - 'USER': 'cltbld', 04:30:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:59 INFO - 'XPC_FLAGS': '0x0', 04:30:59 INFO - 'XPC_SERVICE_NAME': '0', 04:30:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:03 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 04:31:03 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 04:31:03 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 04:31:03 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 04:31:03 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 04:31:03 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 04:31:03 INFO - Downloading docopt-0.6.1.tar.gz 04:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:03 INFO - Running setup.py install for blobuploader 04:31:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:04 INFO - Running setup.py install for requests 04:31:04 INFO - Running setup.py install for docopt 04:31:04 INFO - Successfully installed blobuploader requests docopt 04:31:04 INFO - Cleaning up... 04:31:04 INFO - Return code: 0 04:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:04 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:31:04 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 04:31:04 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 04:31:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:31:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:04 INFO - 'HOME': '/Users/cltbld', 04:31:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:04 INFO - 'LOGNAME': 'cltbld', 04:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:04 INFO - 'MOZ_NO_REMOTE': '1', 04:31:04 INFO - 'NO_EM_RESTART': '1', 04:31:04 INFO - 'PAGER': '/bin/cat', 04:31:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:04 INFO - 'PWD': '/builds/slave/test', 04:31:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:04 INFO - 'SHELL': '/bin/bash', 04:31:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:31:04 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:31:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:04 INFO - 'USER': 'cltbld', 04:31:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:04 INFO - 'XPC_FLAGS': '0x0', 04:31:04 INFO - 'XPC_SERVICE_NAME': '0', 04:31:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-dxzKx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-KgyKJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-1JEUzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-SPrZGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-X9eGB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-pZXaRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-HLpFGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-KstYz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-FpeS7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:05 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-0S8pX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-pvk9nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-2rxugw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-gAv8mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-RfqXLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-H7uKX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-IEn7Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:06 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-znTVP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:06 INFO - Running setup.py install for manifestparser 04:31:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:06 INFO - Running setup.py install for mozcrash 04:31:07 INFO - Running setup.py install for mozdebug 04:31:07 INFO - Running setup.py install for mozdevice 04:31:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozfile 04:31:07 INFO - Running setup.py install for mozhttpd 04:31:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozinfo 04:31:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozInstall 04:31:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozleak 04:31:08 INFO - Running setup.py install for mozlog 04:31:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Running setup.py install for moznetwork 04:31:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Running setup.py install for mozprocess 04:31:08 INFO - Running setup.py install for mozprofile 04:31:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Running setup.py install for mozrunner 04:31:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Running setup.py install for mozscreenshot 04:31:09 INFO - Running setup.py install for moztest 04:31:09 INFO - Running setup.py install for mozversion 04:31:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:09 INFO - Cleaning up... 04:31:09 INFO - Return code: 0 04:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:09 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:31:09 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 04:31:09 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 04:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:09 INFO - 'HOME': '/Users/cltbld', 04:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:09 INFO - 'LOGNAME': 'cltbld', 04:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:09 INFO - 'MOZ_NO_REMOTE': '1', 04:31:09 INFO - 'NO_EM_RESTART': '1', 04:31:09 INFO - 'PAGER': '/bin/cat', 04:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:09 INFO - 'PWD': '/builds/slave/test', 04:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:09 INFO - 'SHELL': '/bin/bash', 04:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:31:09 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:09 INFO - 'USER': 'cltbld', 04:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:09 INFO - 'XPC_FLAGS': '0x0', 04:31:09 INFO - 'XPC_SERVICE_NAME': '0', 04:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-DWNKn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Su4ZDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-nkr4Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-wMGC5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-rd29qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_GBqMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-2lUDLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-p9qIKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-qKXO84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:10 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-4V6wsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-vCt4FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-S26_L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-NxOy9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-lsr0TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-9ArInK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-fjM1Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:11 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)) 04:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:11 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-IZr3RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:11 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)) 04:31:11 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)) 04:31:11 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)) 04:31:11 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)) 04:31:11 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)) 04:31:11 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)) 04:31:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:14 INFO - Downloading blessings-1.6.tar.gz 04:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:14 INFO - Installing collected packages: blessings 04:31:14 INFO - Running setup.py install for blessings 04:31:14 INFO - Successfully installed blessings 04:31:14 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:15 INFO - Reading from file tmpfile_stdout 04:31:15 INFO - Current package versions: 04:31:15 INFO - blessings == 1.6 04:31:15 INFO - blobuploader == 1.2.4 04:31:15 INFO - docopt == 0.6.1 04:31:15 INFO - functools32 == 3.2.3-2 04:31:15 INFO - jsonschema == 2.5.1 04:31:15 INFO - manifestparser == 1.1 04:31:15 INFO - mozInstall == 1.12 04:31:15 INFO - mozcrash == 0.17 04:31:15 INFO - mozdebug == 0.1 04:31:15 INFO - mozdevice == 0.48 04:31:15 INFO - mozfile == 1.2 04:31:15 INFO - mozhttpd == 0.7 04:31:15 INFO - mozinfo == 0.9 04:31:15 INFO - mozleak == 0.1 04:31:15 INFO - mozlog == 3.4 04:31:15 INFO - moznetwork == 0.27 04:31:15 INFO - mozprocess == 0.23 04:31:15 INFO - mozprofile == 0.28 04:31:15 INFO - mozrunner == 6.12 04:31:15 INFO - mozscreenshot == 0.1 04:31:15 INFO - mozsystemmonitor == 0.3 04:31:15 INFO - moztest == 0.7 04:31:15 INFO - mozversion == 1.4 04:31:15 INFO - psutil == 3.1.1 04:31:15 INFO - requests == 1.2.3 04:31:15 INFO - wsgiref == 0.1.2 04:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 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 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:31:15 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 04:31:15 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 04:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:15 INFO - 'HOME': '/Users/cltbld', 04:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PAGER': '/bin/cat', 04:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:31:15 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - 'XPC_FLAGS': '0x0', 04:31:15 INFO - 'XPC_SERVICE_NAME': '0', 04:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 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)) 04:31:15 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a75490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d3daf4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, '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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 04:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:15 INFO - 'HOME': '/Users/cltbld', 04:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PAGER': '/bin/cat', 04:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:31:15 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - 'XPC_FLAGS': '0x0', 04:31:15 INFO - 'XPC_SERVICE_NAME': '0', 04:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:15 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - Running post-action listener: _start_resource_monitoring 04:31:15 INFO - Starting resource monitoring. 04:31:15 INFO - [mozharness: 2016-09-29 11:31:15.965989Z] Finished create-virtualenv step (success) 04:31:15 INFO - [mozharness: 2016-09-29 11:31:15.967073Z] Running install step. 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: install 04:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:16 INFO - Reading from file tmpfile_stdout 04:31:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:16 INFO - Reading from file tmpfile_stdout 04:31:16 INFO - Output received: 04:31:16 INFO - Usage: mozinstall [options] installer 04:31:16 INFO - Options: 04:31:16 INFO - -h, --help show this help message and exit 04:31:16 INFO - -d DEST, --destination=DEST 04:31:16 INFO - Directory to install application into. [default: 04:31:16 INFO - "/builds/slave/test"] 04:31:16 INFO - --app=APP Application being installed. [default: firefox] 04:31:16 INFO - mkdir: /builds/slave/test/build/application 04:31:16 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'] 04:31:16 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 04:31:50 INFO - Reading from file tmpfile_stdout 04:31:50 INFO - Output received: 04:31:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:31:50 INFO - Running post-action listener: _resource_record_post_action 04:31:50 INFO - [mozharness: 2016-09-29 11:31:50.493513Z] Finished install step (success) 04:31:50 INFO - [mozharness: 2016-09-29 11:31:50.493637Z] Running run-tests step. 04:31:50 INFO - Running pre-action listener: _resource_record_pre_action 04:31:50 INFO - Running main action method: run_tests 04:31:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:50 INFO - 2016-09-29 04:31:50.506 screenresolution[1644:7798] starting screenresolution argv=screenresolution get 04:31:50 INFO - 2016-09-29 04:31:50.508 screenresolution[1644:7798] Display 0: 1600x1200x32@60 04:31:50 INFO - 2016-09-29 04:31:50.513 screenresolution[1645:7800] starting screenresolution argv=screenresolution list 04:31:50 INFO - Available Modes on Display 0 04:31:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:50 INFO - Intel Iris: 04:31:50 INFO - Chipset Model: Intel Iris 04:31:50 INFO - Type: GPU 04:31:50 INFO - Bus: Built-In 04:31:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:50 INFO - Vendor: Intel (0x8086) 04:31:50 INFO - Device ID: 0x0a2e 04:31:50 INFO - Revision ID: 0x0009 04:31:50 INFO - Displays: 04:31:50 INFO - Display: 04:31:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:50 INFO - Display Serial Number: 1600x1200 60 04:31:50 INFO - Main Display: Yes 04:31:50 INFO - Mirror: Off 04:31:50 INFO - Online: Yes 04:31:50 INFO - Rotation: Supported 04:31:50 INFO - Return code: 0 04:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:50 INFO - Python 2.7.3 04:31:50 INFO - Return code: 0 04:31:50 INFO - grabbing minidump binary from tooltool 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 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 0x108889d30>, '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 0x1086afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108881b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:50 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 04:31:50 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 04:31:50 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 04:31:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:50 INFO - Return code: 0 04:31:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:31:50 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bTvXUDnZj0/Render', 04:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:50 INFO - 'HOME': '/Users/cltbld', 04:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PAGER': '/bin/cat', 04:31:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZUnMOGU4c/Listeners', 04:31:50 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - 'XPC_FLAGS': '0x0', 04:31:50 INFO - 'XPC_SERVICE_NAME': '0', 04:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:31:51 INFO - mozversion application_buildid: 20160929011819 04:31:51 INFO - mozversion application_changeset: c593d6a120714593d0c2bf3bf670182c48e24f50 04:31:51 INFO - mozversion application_display_name: Nightly 04:31:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:51 INFO - mozversion application_name: Firefox 04:31:51 INFO - mozversion application_remotingname: firefox 04:31:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:31:51 INFO - mozversion application_vendor: Mozilla 04:31:51 INFO - mozversion application_version: 52.0a1 04:31:51 INFO - mozversion platform_buildid: 20160929011819 04:31:51 INFO - mozversion platform_changeset: c593d6a120714593d0c2bf3bf670182c48e24f50 04:31:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:31:51 INFO - mozversion platform_version: 52.0a1 04:31:51 INFO - using testdate: 1475148711 04:31:51 INFO - actual date: 1475148711 04:31:51 INFO - starting webserver on 'localhost:49280' 04:31:51 INFO - SUITE-START | Running 2 tests 04:31:51 INFO - TEST-START | dromaeo_css 04:31:51 INFO - operating with platform_type : mac_ 04:31:51 INFO - Initialising browser for dromaeo_css test... 04:31:51 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp3e3ou1/profile http://localhost:49280/getInfo.html) 04:31:53 INFO - PROCESS | 1655 | 2016-09-29 04:31:53.789 plugin-container[1657:7919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 04:31:53 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:53 INFO - PROCESS | 1655 | 2016-09-29 04:31:53.792 plugin-container[1657:7919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a07, name = 'com.apple.CFPasteboardClient' 04:31:53 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:53 INFO - PROCESS | 1655 | 2016-09-29 04:31:53.792 plugin-container[1657:7919] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:53 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 04:31:53 INFO - PROCESS | 1655 | colorDepth:24 04:31:53 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 04:31:53 INFO - PROCESS | 1655 | __metrics 04:31:53 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 04:31:54 INFO - TEST-INFO | 1655: exit 0 04:31:54 INFO - Browser initialized. 04:31:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:54 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp3e3ou1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:57 INFO - PROCESS | 1658 | 2016-09-29 04:31:57.298 plugin-container[1659:8029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8827, name = 'com.apple.tsm.portname' 04:31:57 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:57 INFO - PROCESS | 1658 | 2016-09-29 04:31:57.302 plugin-container[1659:8029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 04:31:57 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:57 INFO - PROCESS | 1658 | 2016-09-29 04:31:57.302 plugin-container[1659:8029] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:06 INFO - PROCESS | 1658 | RSS: Main: 239882240 04:32:06 INFO - PROCESS | 1658 | 04:32:56 INFO - PROCESS | 1658 | 1475148776518 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] 04:35:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 04:35:09 INFO - PROCESS | 1658 | RSS: Main: 253124608 04:35:09 INFO - PROCESS | 1658 | 04:38:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 04:38:12 INFO - PROCESS | 1658 | RSS: Main: 265469952 04:38:12 INFO - PROCESS | 1658 | 04:41:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 04:41:15 INFO - PROCESS | 1658 | RSS: Main: 270262272 04:41:15 INFO - PROCESS | 1658 | 04:44:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 04:44:17 INFO - PROCESS | 1658 | RSS: Main: 269619200 04:44:17 INFO - PROCESS | 1658 | 04:47:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 04:47:21 INFO - PROCESS | 1658 | RSS: Main: 274866176 04:47:21 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 04:50:24 INFO - PROCESS | 1658 | RSS: Main: 277581824 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | __start_tp_report 04:50:24 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 04:50:24 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 04:50:24 INFO - PROCESS | 1658 | |i|pagename|runs| 04:50:24 INFO - PROCESS | 1658 | |0;dojo.html;3285.6385797562266;3296.4066468035744;3371.949420758689;3378.223008707997;3380.7802492837977;5448.645838020526;5513.476219759122;5513.889722205554;5525.226468294442;5584.246126772884;5469.15228139638;5520.613557051008;5534.584906132036;5614.522765564931;5638.40796716344;4077.7757223352705;5045.268436076767;5069.062223488666;5123.564497017758;5181.481851814826;4947.802087916479;5169.715665638389;5186.273921650972;5187.299714538545;5198.324217851674;4533.229351010304;4987.600991920638;5142.151544995071;5187.299714538527;5195.064888320101;4826;5066.645334826564;5100.132977393815;5105.566026887682;5165.870853228662;5040.798368065273;5041.672291301091;5059.974700126476;5083.440821509668;5143.459936706629;5394.78420863169;5401.946620409022;5578.191162281447;5594.160875868612;5602.495775380195;5494.423085575997;5931.911021334683;5971.552133589955;6055.909161362583;6119.228375855631;6121.6358891611635;6127.250613123811;6139.369480960552;6152.5693201475915;6165.10605962133;5658.094704847204;5664.830055098354;5665.745041473144;5680.545556355523;5682.914756278659;6113.96943015291;6117.705611546597;6135.385782596134;6163.260408750889;6181.7527298908435;5963.850903727442;6005.129256257818;6016.639001659914;6028.095785632103;6068.4538391544975;6041.154238406627;6186.907196392058;6187.319394866561;6195.132681424604;6207.565470417027;5815.244018277682;5903.0260007099205;5906.881862362815;5991.5206783457215;5993.31076926159;5958.582899197101;5995.190649262381;6000.159977603139;6028.788992385245;6033.456988871023;4058.9040958940923;4811.687240329367;4821.108095002436;4829.468758436639;4855.077535268288;3546.8049257291095;4299.161663475592;4301.849435269751;4347.7826108694435;4381.583749543788;5458.61789674719;5607.579431542651;5642.943570564324;5713.4000929902595;5715.885682286331;6157.384261573807;6176.227971503562;6202.224721909762;6204.658743769046;6232.189815323979;5707.429257074259;5739.311282646109;5743.253377060955;5752.482276595127;5789.2763404574425;4450.688451808407;4811;5154.407243167008;5177.8187763428095;5234.057869583511;4553.408056952575;5138.332016837787;5617.157426386075;6151.96924015395;6197.721102550306;5994.460498555151;6008.669523176267;6014.609050411709;6024.216851809412;6055.091736239599;6141.877162456815;6142;6183.81448556526;6192.102145189013;6320.747170113144;4784.497627749036;5378.977994181093;5868.765249389977;6004.699765011819;6080.179175811209;6005.069214271794;6062.272527296753;6153.569250152446;6166.938330616636;6170.53720970938;5224.2947202127225;5682.374938756816;5754.6547207167705;5966.522678185648;5975.731092100779;5881.794137205177;5883.235179426647;5889.411058894077;5908.084246941731;6012.398760124128;5649.12438572022;5717.42825717425;5772.913406298825;5791.420857914175;5797.913031304618;5760.164776107525;5812.622179558315;5871.295444546511;5949.286085669574;5953.7023148843255;5738.9139162913425;5773.162891380643;5775.480206781242;5807.070868660994;5822.446867547576 04:50:24 INFO - PROCESS | 1658 | |1;ext.html;516.5764073459763;537.3846945247694;543.681946061554;571.2573654249475;573.306299377753;38895.80552097239;40323.59676403235;40606.7969660152;42975;42989.78505107478;41842;42419.78790106053;42443.78778106105;42513.787431062876;42591.14817703644;8265.83468330633;8492.575371231445;9188.632454701803;9678.854817177731;9696.757581060494;9606.087421694929;9698.563564639573;9705.514724263794;9712.22302215821;9714.562844671971;8251.257386835183;9685.69243152176;9692.709218723414;9715.028497150299;9790.167835733972;9672.661456849011;9690.12788849007;9720.951395242979;9720.95139524305;9745.415275083447;9564.378315409476;9606.66376676813;9639.42163470187;9656.855147172799;9660.178884794801;38677.613223867964;39607;39624.80187599044;39760.40359394612;39788;3324.16895776056;3440.4323286657923;3888.9027774305587;4099.282625540548;4183.3515805050265;23778.881105594362;30809.8459507701;31397.37205255905;31430.371392572022;31436;3173.587433633613;3214.357128574271;3300.372929143455;3368.1411240133607;3368.9724633986625;498559.0144098549;503675;507959;507969.46015270054;508197;56435.43564564384;56647.433525664215;56994.43005569891;57189.71405142947;57250;57194.7140264296;58608.70695646494;58915.41084589099;59149.521261968795;59314;12909.54816581415;15408.61478463025;15539.912206145462;15694.9215253923;15893.761593576106;12091.274523528617;12171.75656486883;12538;12609.873901261053;12624.17942833713;14679.41282348694;15155.469558565397;15169.848301517064;15197.6200594986;15431.61420964485;6195.473384762346;6274.811755647338;6354.364563543609;6386.361363863576;6389.776357827547;847.9406441549032;978.256525040974;1114.816055350858;1140.7889540435046;1152.913531485142;25996.35009124787;29868;30055.02681433688;30288.091357259316;30387.936422225117;1035.1873779083382;1061.1351748325244;1110.9888901110885;1149.1611123879616;1169.140681599024;14610;14726.202021615858;15364.308606112752;15500.92249538745;15716.371345146295;612260.9386953036;713390;716337;717385;718151;56440.87118257612;56666;56826;57441.71279143578;57609.71195144081;1328.754180476615;1368.7946807978683;1382.67507135823;1391.7425276323913;1392.617030316671;28406;29304.7069529302;29424.675889584592;29912.700872991863;30130.24674383158;48082.75958620325;48562.78593035202;48725.269120962505;49333.2600010993;49456.01087978292;631629;631877;636245;636275;636468;25176.244712657917;25959.351016224744;26092.608610870473;26241;26280.60579091277;45996.16015359348;47050.76474617605;47094.52905470901;47402;47559.76220118877;37691.43462848005;38886.934113040435;38890.61109388983;39009.414858776574;39739.40390894081;33970;34104.63581456813;38638.06510216517;38792.41811372888;39075.80462097671;36771.08072298107;37167.25665486729;37295.62704372922;37612.435813463366;37960;30549.6252668626;34018.14954626154;34479.827600861834;34561.827190863885;34616.65383346235;24903.50192996166;25070;25123;25527.36181595475;25725 04:50:24 INFO - PROCESS | 1658 | |2;jquery.html;356.65226404255844;360.7636997766464;375.6431390179327;384.14719323102713;400.51537639456257;14135.363908624111;19495.41513754588;20522.69215961758;20925.37223883284;21200.833954132515;19916.302929397472;20166.89916550419;20571.691424628643;20600.866952317618;20671.483212919684;5826.155207494921;5944.108383742451;6000.279966404038;6072.908906366386;6073.483753880925;5879.118132280149;5999.160117583542;6002.249718785152;6038.637681739087;6062.666553339564;5795.275590551181;5873;5966;5986.161937328778;5991.940080599182;5886.823395298148;5895.263092113486;5923.052311630162;5924.081767326028;5951.464368206882;4960.975195124038;5065.733566608348;5132.692038477666;5138.58891288696;5168.3797944246935;20986.790132098635;22424.88787556052;23510.52978940429;23713.525729485485;25483.745162548323;2177.4447515883508;2239.4065572623267;2332.7783860533223;2378.678878351435;2389;9628.374155679858;10285.845712314322;10384.01351871571;12560;14763.892708046833;1593.5060131359317;1667.808202056767;1840.9782570673271;1842.5485755989735;1897.3643829317195;96660;114610;118225.86209482627;118588.40705796501;121835.39082304621;11188.049015833583;11306.547738090385;11404;11428.657140285804;11590.188686792013;12046.819297710366;13956.232407217498;14220.937963995162;14261.857381426053;14393.856061439461;7056.682449289691;8389.832203356022;8536.189062039097;8546;8592.355573332025;8455.112213217646;8456.238938495442;8459.365547583955;8612.78468038304;8626.180512851395;4426.092651006536;4462.397576327219;4484.775761211991;4561.977190114095;4633.745144017112;1880.1915176473974;1936.3126090238045;1937.5349916020336;1938.825505704465;1939.4278687787137;842.7808769719794;901.8466860633708;904.3714618340322;913.8720579118929;940.2994768897079;15666.921665391828;19939.60120797576;20492.69260961087;21001.78998210029;21132.049057792436;948.743839163422;966.4104896013426;971.9131053918256;972.3582435592475;977.032737589781;8571.185737354941;9548.092931171528;10750.946245268724;11103.777924441465;11144.665660030212;567475;580355;594776;608925;609675;117644;120755.79244207621;126115;126492;135584.32207838897;930.930180236485;1018.2922868606396;1036.7874585709912;1084.1056128693701;1090.2422816142864;19403.8059619402;19559.04409559033;19763.110660020622;19787.40637780869;19900.90049549743;45869;50764;56404.717976409855;57899.42100579109;59163.70418147882;84464.57767711367;85165.57417212875;85605;85690;86412;7982.880256796268;8114.634841432032;8201.343892488467;8272.586370681562;8422.32621390275;12144.514219431123;12744.553940612033;12848.357582121043;13205.405756741162;13462.596122116352;11173.888261117285;11286.830697539708;11350.432478375884;11466;11619.128565357463;11066.889331106908;11112.388818615054;11166.888331116585;11213.55145794159;11384.601538946097;10852.565897364017;11090.11845853977;11495.367754773568;11560.190786645191;11699.2980421175;8017.63920623585;8053.355731541345;8100.35197184212;8202.630881610223;8251.83496330082;11074.778504430027;11234.719132021764;11422.94288528552;11498.597549085742;11530.365829879102 04:50:24 INFO - PROCESS | 1658 | |3;mootools.html;1483.9925800370993;1541.9537413877583;1756.130715295928;1851.4260579220452;1880.7272945422915;6664;6904.620245886475;8040.5979701015;8198.631061602227;8620.69827556035;6868.313168683129;8713.085126061767;8727.38908276421;8835.983861855888;8841.115888411156;2370.3481542575755;2371.1108334374608;2374.821888358376;2402.291324059398;2407.963880541793;2254.1772253127656;2262.8529145605567;2285.897134628946;2292.1175347491253;2298.230092918874;2225.310153852303;2251.7072780538506;2303.516261585061;2396.9760302397012;2408.722996855358;1999.6900480425556;2292.4612716011807;2361.5631108244856;2363.243761996162;2371.312319427364;2345.2846881701075;2347.354477518696;2348.471593891378;2351.0713268259115;2359.716833979933;8832.160944710242;8881.33389995753;8926.955365223132;8929.73210803677;8948;4174.394712766662;5294.205869119624;5320.441353657888;5323.680579165262;5334.813281535127;3452.3095380923914;3502.807345595991;3622.3841946869097;3627.4740162676526;3630.2376500934834;1039.8146113430696;1079.4980334144582;1080.1844607321423;1088.7332603512111;1100.6037826382496;11440.19918605698;11540.134489913291;11582.71043223926;11623.07015438763;11634.243774154653;4011.6991225658194;4501.504834468205;4507.684462087623;4588.38056862326;4772.785224664898;9348.924873639482;9877.950610246902;9945.30382873192;9955.701328960144;9956.900430995742;4675.667434781071;4767.475577686451;5054.848354549295;5300.469953004668;5302.284191634157;4385.451818522684;4558.111168322212;4721.126591580569;4869.1722407190155;4871.707697538159;3808.3716186829415;3851.171998020439;3912.471816304819;3921.058945852975;3947.802609869495;1280.065552146938;1296.6434230586665;1297;1302.9283389413674;1305.0668771828189;897.9416337938144;913.8035322405715;917.5870858113875;934.4400815149751;935.6771913689767;5923.703814809242;5939.376365481562;5947.910781338283;5995.790147344822;6205.968970155121;911.5032307392487;953.5232383808096;963.2390411574777;973.7711637765119;985.9704208873602;3628.310620982005;3898.6101389860787;3933.095388060762;3974.4038394241097;4018.2767101921936;10588.15294776416;10959.397233152094;10968.451577421256;10980;10983.231173817916;10510.789784204273;10521.579136834442;10809.945950270356;10841.186910981707;10937.890621093688;7698.538087714643;8153.918460815435;8283.917160828436;8309.584520773937;8322;5694.117411801178;5725.627834190765;5800.8259752207505;5835.328937172279;5882.588218824641;9790.657326993522;10095.949520252352;10157.39055656663;10175.898241017496;10237.129843963048;10334.069933706003;10372;10397.58409663605;10398;10424.218183636105;6546.083548303337;6731.899021514583;6796.966015169893;7054.329838665319;7219.241979592277;8212.917870821455;8510;8513.404061715868;8515.574221289035;8543;7389.519681220703;7425.59159246225;7472.551646901204;7521.435892308208;7619.123800762762;7304.233055529306;7329.413646908341;7394.852102958018;7487.138979017483;7489.438292128003;6966.024756534191;6997;7041.6831242595235;7043.647817609201;7048.964755176191;4937.568105249581;5036.169032109661;5037.395512538519;5157.252198431132;5200.6879587224885;5127;5204.427512973494;5222.086134926297;5266;5334.67991920486 04:50:24 INFO - PROCESS | 1658 | |4;prototype.html;246.79762594672368;266.9012465387807;298.96561895382035;310.64276082505125;314.44343511983806;4943.283223932533;5336.332958380192;5499.257600223974;5534.513256648316;5664.235328230693;5001.424836143845;5292.841214763554;5453.836384908459;5502.80740174094;5520.613557051008;3648.9600463867805;4119.548868423283;4203.5165955915;4207.095474472995;4233.491980962273;3645.034065972506;4092.8362865485346;4203.138356636898;4243.236217480852;4257.40396344512;3944.901377465572;4156.210320039198;4159.667226621878;4162.625363717265;4165.250254954107;4189.162167566484;4204.138151678899;4208.452901122865;4209.589787421218;4230.682698797572;3047.481928072211;3432.541170002764;3508.0878971467346;3649.6167902370134;3660.194757153422;5407.432219616962;5408.3228801743;5441.877667709597;5453.890922181534;5470.206820011076;4739.786709598076;4749.833755818564;4754.953910139764;4759.524047595248;4765.189917713997;5516.310461192351;5531.446855314477;5791.623544469596;5851.941480585182;5856.042698437262;3564.4177601510573;3822.388417853158;3934.5278566572197;3955.8417663293435;3970.166265084336;5066.645334826527;5166.320945692627;5887.528997680218;5989.790357337472;6255.937440625581;3390.3897298486017;3800.4299355096955;3930.508686414198;3962.791348638693;3979.870769138497;3677.282929828711;3688.5020522229156;3776.4712940188397;4041.474608300961;4052.65552428041;4442.777861106932;4622.95377046232;4742.099001189832;4749.833755818529;4760.500147484534;5359.732013399314;5755.280589926259;5913.645181289136;5956.344802071769;5978.790742323998;1348.3258370814592;1373.2241283674691;1375.3192169875977;1378.7035787305776;1380.6617378742071;713.3579778199559;763.3435245688703;769.3575864153495;797.6490344248512;808.7492877208084;4657.347971284023;4710.505396933341;4723.291506274087;4733.644976626767;4749.335093086971;4393.0994146199955;4800.487846328396;4868.245421959602;5203.401608814959;5248.265242866002;3907.4529565860803;4228.2600544905135;4422.823087076546;4755.738434386073;4821.566059054632;2205.162038425388;2365.6333268343433;2479.962800557993;2535.3534848613485;2624.6325514427995;5269.868253293622;5342.332208473941;5344.331958505187;5355.678659280456;5356.544693701079;4610.847288177955;5009.298698182258;5047.192449208109;5297.894042119136;5859.824205273849;5704.201411802351;5825.689219925567;6264.342244064308;6291.5281353898645;6331.525135614939;5487.862803429786;5929.762809487572;6137.631742095488;6165.6608886509875;6194.38056194377;4450.376947227455;5178.792848286026;5258.921116183337;5864.912026319694;5886.323072846678;5948.851278718067;6299.299189218794;6299.433051025429;6303.527235457451;6314.737052589408;3593.6765691087926;3870.4968354113785;3957.5448823385677;4079.9796001019804;4146.771927544014;5516.889662206813;6061.878762424639;6073.939260607337;6079.878402432015;6111.7249723763425;5145.382554093533;5625.587864973908;5894.377002233965;5915.290165180206;5932.377100404568;5774.711264436845;5849.561282903885;5855.979687007975;5877.35349111606;5878.94121058801;4826.131296366688;4927.28554359623;5635.816478539388;5649.740103958449;5801.535877129904;4294.785260736888;4839.758012099452;5117.565006974449;5583.855309661591;5854;5661.716914154194;5713.971430142823;5715.884842760788;5723.427657234243;5793.826185214451 04:50:24 INFO - PROCESS | 1658 | |5;yui.html;625.8216408323627;669.8559809640926;736.5875109938431;745.5191401546003;771.9112302085258;14987.10077395357;15959.601009974742;16106.194690265498;16107.677846443064;16157;14506.927465362685;14628.488002919874;14632.561023169323;14645.19451430171;14654.560363189095;642.3223499208333;696.6586372677402;737.9447390231966;821.7041864928651;843.0894633795486;834.7537476444463;845.8435189489933;859.072202021815;864.6843901975765;865.9911203447975;861.625193041026;909.7816524034217;917.7613820406709;919.2691810011057;920.2270093121776;878.275422776209;894.6779159502574;898.6495266845935;908.6819613135416;908.7728067982971;646.5861848417017;655.1090516897016;677.1839932880866;681.1247546902256;682.556338380052;14863.554093377215;14968.02707823988;15012.174330411823;15041.097534147986;15052.623684407868;14596.197209153492;14638.341274642667;14737.336819843133;14776.26118694061;14951.850481495154;11860.347680877549;12051.035917126608;12266.080043996646;12267.079969002361;12388.831954408033;3543.7165026797793;3756.69946404287;3800.068983099131;3979.820908059144;3990.980045099785;83337;123145.37537432421;123836.38081809624;123947.38026309901;132517.33741331424;11134.721631959104;11307.378094204898;11381.943090284662;11513.136514761427;11696.415179241005;23635.645465318034;23669.644955325683;23684.88157559201;23794.286171414886;23810.52378952411;7922.286994170552;8114.391420643476;8208.507489550646;8365.07984121746;8391.958040209882;4402.823887044547;4434.238578174505;4447.421835161408;4484.304932735431;4587.105514424722;3669.6513831185994;3788.791616461066;3789.829457674411;3816.198598294334;3929.587393323717;709.61326077288;720.0782997762872;730.302561054192;732.8351120997839;737.5206116024627;539.9460053994648;618.7153909201818;668.8695704337705;675.2133764164693;694.3091623834317;8241.670333186605;8989.370744047985;9807.803843923082;9833.164181044549;9856.901430985741;525.1440152551316;598.1506261109236;606.6754286456812;614.7018695932469;646.1341801985362;4420;4564.452265728068;4712.31671407644;4806.279058141306;4832.44426890905;125575;150056;151882.48117518684;153904;155050;103256;130382.39235215243;135172;137118.31440842932;141539.99999999793;79842;108833;109583;110281.44859275813;111105;8854.21050286403;9031.729048128567;9040.954795225982;9073.546322683707;9296.767580810534;58861;61741;63154;64541;65005.02492462711;86494;92114;92222.53888730513;93202.53398732963;95854.12437626882;11451.312921224753;11832.150417133607;12060.577879774166;12061.216020958609;12117.454714538044;9606.567704453457;10792.08267297257;11384.943075284571;11658.941705291758;13936.651583710489;10218.456360847487;12079.214851034654;12161.148719589544;12707.618771436872;12720.109592328448;12206.375629239756;13309.733805324033;13848.376823042785;13917.443302267797;14353.64115897111;10594;13378.42616712598;13520.797188042385;13716.588502344946;13785;9927.503624818586;10053.240682880612;11220.214584978972;11291.266067705574;11817.527298907948;8845;10689.893101069201;11458.484368203617;11552.364619945984;11576.36330001858 04:50:24 INFO - PROCESS | 1658 | __end_tp_report 04:50:24 INFO - PROCESS | 1658 | __start_cc_report 04:50:24 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,355 04:50:24 INFO - PROCESS | 1658 | __end_cc_report 04:50:24 INFO - PROCESS | 1658 | __startTimestamp1475149824284__endTimestamp 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | ------- Summary: start ------- 04:50:24 INFO - PROCESS | 1658 | Number of tests: 6 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5544.79 Median:5739.31 stddev:656.59 (11.4%) stddev-sans-first:634.23 04:50:24 INFO - PROCESS | 1658 | Values: 3285.6 3296.4 3371.9 3378.2 3380.8 5448.6 5513.5 5513.9 5525.2 5584.2 5469.2 5520.6 5534.6 5614.5 5638.4 4077.8 5045.3 5069.1 5123.6 5181.5 4947.8 5169.7 5186.3 5187.3 5198.3 4533.2 4987.6 5142.2 5187.3 5195.1 4826.0 5066.6 5100.1 5105.6 5165.9 5040.8 5041.7 5060.0 5083.4 5143.5 5394.8 5401.9 5578.2 5594.2 5602.5 5494.4 5931.9 5971.6 6055.9 6119.2 6121.6 6127.3 6139.4 6152.6 6165.1 5658.1 5664.8 5665.7 5680.5 5682.9 6114.0 6117.7 6135.4 6163.3 6181.8 5963.9 6005.1 6016.6 6028.1 6068.5 6041.2 6186.9 6187.3 6195.1 6207.6 5815.2 5903.0 5906.9 5991.5 5993.3 5958.6 5995.2 6000.2 6028.8 6033.5 4058.9 4811.7 4821.1 4829.5 4855.1 3546.8 4299.2 4301.8 4347.8 4381.6 5458.6 5607.6 5642.9 5713.4 5715.9 6157.4 6176.2 6202.2 6204.7 6232.2 5707.4 5739.3 5743.3 5752.5 5789.3 4450.7 4811.0 5154.4 5177.8 5234.1 4553.4 5138.3 5617.2 6152.0 6197.7 5994.5 6008.7 6014.6 6024.2 6055.1 6141.9 6142.0 6183.8 6192.1 6320.7 4784.5 5379.0 5868.8 6004.7 6080.2 6005.1 6062.3 6153.6 6166.9 6170.5 5224.3 5682.4 5754.7 5966.5 5975.7 5881.8 5883.2 5889.4 5908.1 6012.4 5649.1 5717.4 5772.9 5791.4 5797.9 5760.2 5812.6 5871.3 5949.3 5953.7 5738.9 5773.2 5775.5 5807.1 5822.4 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:73221.53 Median:39774.20 stddev:165505.97 (416.1%) stddev-sans-first:165880.24 04:50:24 INFO - PROCESS | 1658 | Values: 516.6 537.4 543.7 571.3 573.3 38895.8 40323.6 40606.8 42975.0 42989.8 41842.0 42419.8 42443.8 42513.8 42591.1 8265.8 8492.6 9188.6 9678.9 9696.8 9606.1 9698.6 9705.5 9712.2 9714.6 8251.3 9685.7 9692.7 9715.0 9790.2 9672.7 9690.1 9721.0 9721.0 9745.4 9564.4 9606.7 9639.4 9656.9 9660.2 38677.6 39607.0 39624.8 39760.4 39788.0 3324.2 3440.4 3888.9 4099.3 4183.4 23778.9 30809.8 31397.4 31430.4 31436.0 3173.6 3214.4 3300.4 3368.1 3369.0 498559.0 503675.0 507959.0 507969.5 508197.0 56435.4 56647.4 56994.4 57189.7 57250.0 57194.7 58608.7 58915.4 59149.5 59314.0 12909.5 15408.6 15539.9 15694.9 15893.8 12091.3 12171.8 12538.0 12609.9 12624.2 14679.4 15155.5 15169.8 15197.6 15431.6 6195.5 6274.8 6354.4 6386.4 6389.8 847.9 978.3 1114.8 1140.8 1152.9 25996.4 29868.0 30055.0 30288.1 30387.9 1035.2 1061.1 1111.0 1149.2 1169.1 14610.0 14726.2 15364.3 15500.9 15716.4 612260.9 713390.0 716337.0 717385.0 718151.0 56440.9 56666.0 56826.0 57441.7 57609.7 1328.8 1368.8 1382.7 1391.7 1392.6 28406.0 29304.7 29424.7 29912.7 30130.2 48082.8 48562.8 48725.3 49333.3 49456.0 631629.0 631877.0 636245.0 636275.0 636468.0 25176.2 25959.4 26092.6 26241.0 26280.6 45996.2 47050.8 47094.5 47402.0 47559.8 37691.4 38886.9 38890.6 39009.4 39739.4 33970.0 34104.6 38638.1 38792.4 39075.8 36771.1 37167.3 37295.6 37612.4 37960.0 30549.6 34018.1 34479.8 34561.8 34616.7 24903.5 25070.0 25123.0 25527.4 25725.0 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:34834.55 Median:23612.03 stddev:98908.46 (418.9%) stddev-sans-first:99152.05 04:50:24 INFO - PROCESS | 1658 | Values: 356.7 360.8 375.6 384.1 400.5 14135.4 19495.4 20522.7 20925.4 21200.8 19916.3 20166.9 20571.7 20600.9 20671.5 5826.2 5944.1 6000.3 6072.9 6073.5 5879.1 5999.2 6002.2 6038.6 6062.7 5795.3 5873.0 5966.0 5986.2 5991.9 5886.8 5895.3 5923.1 5924.1 5951.5 4961.0 5065.7 5132.7 5138.6 5168.4 20986.8 22424.9 23510.5 23713.5 25483.7 2177.4 2239.4 2332.8 2378.7 2389.0 9628.4 10285.8 10384.0 12560.0 14763.9 1593.5 1667.8 1841.0 1842.5 1897.4 96660.0 114610.0 118225.9 118588.4 121835.4 11188.0 11306.5 11404.0 11428.7 11590.2 12046.8 13956.2 14220.9 14261.9 14393.9 7056.7 8389.8 8536.2 8546.0 8592.4 8455.1 8456.2 8459.4 8612.8 8626.2 4426.1 4462.4 4484.8 4562.0 4633.7 1880.2 1936.3 1937.5 1938.8 1939.4 842.8 901.8 904.4 913.9 940.3 15666.9 19939.6 20492.7 21001.8 21132.0 948.7 966.4 971.9 972.4 977.0 8571.2 9548.1 10750.9 11103.8 11144.7 567475.0 580355.0 594776.0 608925.0 609675.0 117644.0 120755.8 126115.0 126492.0 135584.3 930.9 1018.3 1036.8 1084.1 1090.2 19403.8 19559.0 19763.1 19787.4 19900.9 45869.0 50764.0 56404.7 57899.4 59163.7 84464.6 85165.6 85605.0 85690.0 86412.0 7982.9 8114.6 8201.3 8272.6 8422.3 12144.5 12744.6 12848.4 13205.4 13462.6 11173.9 11286.8 11350.4 11466.0 11619.1 11066.9 11112.4 11166.9 11213.6 11384.6 10852.6 11090.1 11495.4 11560.2 11699.3 8017.6 8053.4 8100.4 8202.6 8251.8 11074.8 11234.7 11422.9 11498.6 11530.4 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5670.12 Median:4870.44 stddev:3194.60 (65.6%) stddev-sans-first:3188.07 04:50:24 INFO - PROCESS | 1658 | Values: 1484.0 1542.0 1756.1 1851.4 1880.7 6664.0 6904.6 8040.6 8198.6 8620.7 6868.3 8713.1 8727.4 8836.0 8841.1 2370.3 2371.1 2374.8 2402.3 2408.0 2254.2 2262.9 2285.9 2292.1 2298.2 2225.3 2251.7 2303.5 2397.0 2408.7 1999.7 2292.5 2361.6 2363.2 2371.3 2345.3 2347.4 2348.5 2351.1 2359.7 8832.2 8881.3 8927.0 8929.7 8948.0 4174.4 5294.2 5320.4 5323.7 5334.8 3452.3 3502.8 3622.4 3627.5 3630.2 1039.8 1079.5 1080.2 1088.7 1100.6 11440.2 11540.1 11582.7 11623.1 11634.2 4011.7 4501.5 4507.7 4588.4 4772.8 9348.9 9878.0 9945.3 9955.7 9956.9 4675.7 4767.5 5054.8 5300.5 5302.3 4385.5 4558.1 4721.1 4869.2 4871.7 3808.4 3851.2 3912.5 3921.1 3947.8 1280.1 1296.6 1297.0 1302.9 1305.1 897.9 913.8 917.6 934.4 935.7 5923.7 5939.4 5947.9 5995.8 6206.0 911.5 953.5 963.2 973.8 986.0 3628.3 3898.6 3933.1 3974.4 4018.3 10588.2 10959.4 10968.5 10980.0 10983.2 10510.8 10521.6 10809.9 10841.2 10937.9 7698.5 8153.9 8283.9 8309.6 8322.0 5694.1 5725.6 5800.8 5835.3 5882.6 9790.7 10095.9 10157.4 10175.9 10237.1 10334.1 10372.0 10397.6 10398.0 10424.2 6546.1 6731.9 6797.0 7054.3 7219.2 8212.9 8510.0 8513.4 8515.6 8543.0 7389.5 7425.6 7472.6 7521.4 7619.1 7304.2 7329.4 7394.9 7487.1 7489.4 6966.0 6997.0 7041.7 7043.6 7049.0 4937.6 5036.2 5037.4 5157.3 5200.7 5127.0 5204.4 5222.1 5266.0 5334.7 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4582.33 Median:5005.36 stddev:1454.46 (29.1%) stddev-sans-first:1421.67 04:50:24 INFO - PROCESS | 1658 | Values: 246.8 266.9 299.0 310.6 314.4 4943.3 5336.3 5499.3 5534.5 5664.2 5001.4 5292.8 5453.8 5502.8 5520.6 3649.0 4119.5 4203.5 4207.1 4233.5 3645.0 4092.8 4203.1 4243.2 4257.4 3944.9 4156.2 4159.7 4162.6 4165.3 4189.2 4204.1 4208.5 4209.6 4230.7 3047.5 3432.5 3508.1 3649.6 3660.2 5407.4 5408.3 5441.9 5453.9 5470.2 4739.8 4749.8 4755.0 4759.5 4765.2 5516.3 5531.4 5791.6 5851.9 5856.0 3564.4 3822.4 3934.5 3955.8 3970.2 5066.6 5166.3 5887.5 5989.8 6255.9 3390.4 3800.4 3930.5 3962.8 3979.9 3677.3 3688.5 3776.5 4041.5 4052.7 4442.8 4623.0 4742.1 4749.8 4760.5 5359.7 5755.3 5913.6 5956.3 5978.8 1348.3 1373.2 1375.3 1378.7 1380.7 713.4 763.3 769.4 797.6 808.7 4657.3 4710.5 4723.3 4733.6 4749.3 4393.1 4800.5 4868.2 5203.4 5248.3 3907.5 4228.3 4422.8 4755.7 4821.6 2205.2 2365.6 2480.0 2535.4 2624.6 5269.9 5342.3 5344.3 5355.7 5356.5 4610.8 5009.3 5047.2 5297.9 5859.8 5704.2 5825.7 6264.3 6291.5 6331.5 5487.9 5929.8 6137.6 6165.7 6194.4 4450.4 5178.8 5258.9 5864.9 5886.3 5948.9 6299.3 6299.4 6303.5 6314.7 3593.7 3870.5 3957.5 4080.0 4146.8 5516.9 6061.9 6073.9 6079.9 6111.7 5145.4 5625.6 5894.4 5915.3 5932.4 5774.7 5849.6 5856.0 5877.4 5878.9 4826.1 4927.3 5635.8 5649.7 5801.5 4294.8 4839.8 5117.6 5583.9 5854.0 5661.7 5714.0 5715.9 5723.4 5793.8 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24830.08 Median:3808.13 stddev:39925.72 (1048.4%) stddev-sans-first:39996.36 04:50:24 INFO - PROCESS | 1658 | Values: 625.8 669.9 736.6 745.5 771.9 14987.1 15959.6 16106.2 16107.7 16157.0 14506.9 14628.5 14632.6 14645.2 14654.6 642.3 696.7 737.9 821.7 843.1 834.8 845.8 859.1 864.7 866.0 861.6 909.8 917.8 919.3 920.2 878.3 894.7 898.6 908.7 908.8 646.6 655.1 677.2 681.1 682.6 14863.6 14968.0 15012.2 15041.1 15052.6 14596.2 14638.3 14737.3 14776.3 14951.9 11860.3 12051.0 12266.1 12267.1 12388.8 3543.7 3756.7 3800.1 3979.8 3991.0 83337.0 123145.4 123836.4 123947.4 132517.3 11134.7 11307.4 11381.9 11513.1 11696.4 23635.6 23669.6 23684.9 23794.3 23810.5 7922.3 8114.4 8208.5 8365.1 8392.0 4402.8 4434.2 4447.4 4484.3 4587.1 3669.7 3788.8 3789.8 3816.2 3929.6 709.6 720.1 730.3 732.8 737.5 539.9 618.7 668.9 675.2 694.3 8241.7 8989.4 9807.8 9833.2 9856.9 525.1 598.2 606.7 614.7 646.1 4420.0 4564.5 4712.3 4806.3 4832.4 125575.0 150056.0 151882.5 153904.0 155050.0 103256.0 130382.4 135172.0 137118.3 141540.0 79842.0 108833.0 109583.0 110281.4 111105.0 8854.2 9031.7 9041.0 9073.5 9296.8 58861.0 61741.0 63154.0 64541.0 65005.0 86494.0 92114.0 92222.5 93202.5 95854.1 11451.3 11832.2 12060.6 12061.2 12117.5 9606.6 10792.1 11384.9 11658.9 13936.7 10218.5 12079.2 12161.1 12707.6 12720.1 12206.4 13309.7 13848.4 13917.4 14353.6 10594.0 13378.4 13520.8 13716.6 13785.0 9927.5 10053.2 11220.2 11291.3 11817.5 8845.0 10689.9 11458.5 11552.4 11576.4 04:50:24 INFO - PROCESS | 1658 | -------- Summary: end -------- 04:50:24 INFO - PROCESS | 1658 | 04:50:24 INFO - TEST-INFO | 1658: exit 0 04:50:24 INFO - TEST-OK | dromaeo_css | took 1113786ms 04:50:24 INFO - TEST-START | kraken 04:50:24 INFO - operating with platform_type : mac_ 04:50:24 INFO - Initialising browser for kraken test... 04:50:24 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpChZ9Ku/profile http://localhost:49280/getInfo.html) 04:50:27 INFO - PROCESS | 1667 | 2016-09-29 04:50:27.533 plugin-container[1668:10326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x881b, name = 'com.apple.tsm.portname' 04:50:27 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:27 INFO - PROCESS | 1667 | 2016-09-29 04:50:27.536 plugin-container[1668:10326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 04:50:27 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:27 INFO - PROCESS | 1667 | 2016-09-29 04:50:27.536 plugin-container[1668:10326] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:27 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 04:50:27 INFO - PROCESS | 1667 | colorDepth:24 04:50:27 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 04:50:27 INFO - PROCESS | 1667 | __metrics 04:50:27 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 04:50:28 INFO - TEST-INFO | 1667: exit 0 04:50:28 INFO - Browser initialized. 04:50:28 INFO - Running cycle 1/1 for kraken test... 04:50:28 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpChZ9Ku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:30 INFO - PROCESS | 1669 | 2016-09-29 04:50:30.752 plugin-container[1670:10438] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x862f, name = 'com.apple.tsm.portname' 04:50:30 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:30 INFO - PROCESS | 1669 | 2016-09-29 04:50:30.754 plugin-container[1670:10438] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 04:50:30 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:30 INFO - PROCESS | 1669 | 2016-09-29 04:50:30.754 plugin-container[1670:10438] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:40 INFO - PROCESS | 1669 | RSS: Main: 240193536 04:50:40 INFO - PROCESS | 1669 | 04:50:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:43 INFO - PROCESS | 1669 | RSS: Main: 253702144 04:50:43 INFO - PROCESS | 1669 | 04:50:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 04:50:47 INFO - PROCESS | 1669 | RSS: Main: 261165056 04:50:47 INFO - PROCESS | 1669 | 04:50:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 04:50:51 INFO - PROCESS | 1669 | RSS: Main: 261844992 04:50:51 INFO - PROCESS | 1669 | 04:50:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 04:50:53 INFO - PROCESS | 1669 | RSS: Main: 263335936 04:50:53 INFO - PROCESS | 1669 | 04:50:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:56 INFO - PROCESS | 1669 | RSS: Main: 264802304 04:50:56 INFO - PROCESS | 1669 | 04:50:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:00 INFO - PROCESS | 1669 | RSS: Main: 265695232 04:51:00 INFO - PROCESS | 1669 | 04:51:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:04 INFO - PROCESS | 1669 | RSS: Main: 265805824 04:51:04 INFO - PROCESS | 1669 | 04:51:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 04:51:07 INFO - PROCESS | 1669 | RSS: Main: 266186752 04:51:07 INFO - PROCESS | 1669 | 04:51:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:10 INFO - PROCESS | 1669 | RSS: Main: 265871360 04:51:10 INFO - PROCESS | 1669 | 04:51:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:12 INFO - PROCESS | 1669 | RSS: Main: 265863168 04:51:12 INFO - PROCESS | 1669 | 04:51:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:15 INFO - PROCESS | 1669 | RSS: Main: 265936896 04:51:15 INFO - PROCESS | 1669 | 04:51:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:19 INFO - PROCESS | 1669 | RSS: Main: 266231808 04:51:19 INFO - PROCESS | 1669 | 04:51:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:22 INFO - PROCESS | 1669 | RSS: Main: 266072064 04:51:22 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 04:51:24 INFO - PROCESS | 1669 | RSS: Main: 267563008 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | __start_tp_report 04:51:24 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 04:51:24 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 04:51:24 INFO - PROCESS | 1669 | |i|pagename|runs| 04:51:24 INFO - PROCESS | 1669 | |0;ai-astar;115;116;116;118;119;119;125;115;119;117 04:51:24 INFO - PROCESS | 1669 | |1;audio-beat-detection;141;114;111;149;113;113;117;96;151;99 04:51:24 INFO - PROCESS | 1669 | |2;audio-dft;193;268;271;227;195;235;275;202;196;199 04:51:24 INFO - PROCESS | 1669 | |3;audio-fft;81;59;61;98;86;50;67;81;106;84 04:51:24 INFO - PROCESS | 1669 | |4;audio-oscillator;89;73;86;76;62;101;123;102;103;85 04:51:24 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;77;96;120;111;131;138;89;83;132 04:51:24 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;95;95;96;108;131;103;115;111;134 04:51:24 INFO - PROCESS | 1669 | |7;imaging-desaturate;149;121;104;153;138;90;101;150;123;94 04:51:24 INFO - PROCESS | 1669 | |8;json-parse-financial;57;58;57;62;67;85;87;91;88;58 04:51:24 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;69;94;68;75;109;62;85;64;64;90 04:51:24 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;98;111;107;82;88;88;85;85;95 04:51:24 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;137;140;140;137;135;142;137;140;175;142 04:51:24 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;173;181;174;177;173;174;168;174;170;173 04:51:24 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;68;61;77;61;64;86;90;92;94 04:51:24 INFO - PROCESS | 1669 | __end_tp_report 04:51:24 INFO - PROCESS | 1669 | __start_cc_report 04:51:24 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,925 04:51:24 INFO - PROCESS | 1669 | __end_cc_report 04:51:24 INFO - PROCESS | 1669 | __startTimestamp1475149884901__endTimestamp 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | ------- Summary: start ------- 04:51:24 INFO - PROCESS | 1669 | Number of tests: 14 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:117.90 Median:118.50 stddev:2.96 (2.5%) stddev-sans-first:2.95 04:51:24 INFO - PROCESS | 1669 | Values: 115.0 116.0 116.0 118.0 119.0 119.0 125.0 115.0 119.0 117.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:145.00 stddev:19.67 (13.6%) stddev-sans-first:19.40 04:51:24 INFO - PROCESS | 1669 | Values: 141.0 114.0 111.0 149.0 113.0 113.0 117.0 96.0 151.0 99.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:226.10 Median:231.00 stddev:34.20 (14.8%) stddev-sans-first:34.11 04:51:24 INFO - PROCESS | 1669 | Values: 193.0 268.0 271.0 227.0 195.0 235.0 275.0 202.0 196.0 199.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:77.30 Median:81.00 stddev:17.80 (22.0%) stddev-sans-first:18.83 04:51:24 INFO - PROCESS | 1669 | Values: 81.0 59.0 61.0 98.0 86.0 50.0 67.0 81.0 106.0 84.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:74.50 stddev:17.75 (23.8%) stddev-sans-first:18.82 04:51:24 INFO - PROCESS | 1669 | Values: 89.0 73.0 86.0 76.0 62.0 101.0 123.0 102.0 103.0 85.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:106.50 Median:80.00 stddev:22.67 (28.3%) stddev-sans-first:23.04 04:51:24 INFO - PROCESS | 1669 | Values: 88.0 77.0 96.0 120.0 111.0 131.0 138.0 89.0 83.0 132.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:114.00 stddev:14.78 (13.0%) stddev-sans-first:14.75 04:51:24 INFO - PROCESS | 1669 | Values: 94.0 95.0 95.0 96.0 108.0 131.0 103.0 115.0 111.0 134.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:122.30 Median:149.50 stddev:24.28 (16.2%) stddev-sans-first:23.75 04:51:24 INFO - PROCESS | 1669 | Values: 149.0 121.0 104.0 153.0 138.0 90.0 101.0 150.0 123.0 94.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:76.00 stddev:14.79 (19.5%) stddev-sans-first:14.79 04:51:24 INFO - PROCESS | 1669 | Values: 57.0 58.0 57.0 62.0 67.0 85.0 87.0 91.0 88.0 58.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:72.00 stddev:15.80 (22.0%) stddev-sans-first:16.42 04:51:24 INFO - PROCESS | 1669 | Values: 69.0 94.0 68.0 75.0 109.0 62.0 85.0 64.0 64.0 90.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:87.00 stddev:9.97 (11.5%) stddev-sans-first:10.29 04:51:24 INFO - PROCESS | 1669 | Values: 86.0 98.0 111.0 107.0 82.0 88.0 88.0 85.0 85.0 95.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:11.65 (8.3%) stddev-sans-first:12.19 04:51:24 INFO - PROCESS | 1669 | Values: 137.0 140.0 140.0 137.0 135.0 142.0 137.0 140.0 175.0 142.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:3.53 (2.0%) stddev-sans-first:3.73 04:51:24 INFO - PROCESS | 1669 | Values: 173.0 181.0 174.0 177.0 173.0 174.0 168.0 174.0 170.0 173.0 04:51:24 INFO - PROCESS | 1669 | 04:51:24 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:81.50 stddev:13.33 (16.4%) stddev-sans-first:13.81 04:51:24 INFO - PROCESS | 1669 | Values: 68.0 68.0 61.0 77.0 61.0 64.0 86.0 90.0 92.0 94.0 04:51:24 INFO - PROCESS | 1669 | -------- Summary: end -------- 04:51:24 INFO - PROCESS | 1669 | 04:51:25 INFO - TEST-INFO | 1669: exit 0 04:51:25 INFO - TEST-OK | kraken | took 60844ms 04:51:25 INFO - SUITE-END | took 1174s 04:51:26 INFO - Completed test suite (00:19:34) 04:51:26 INFO - javascript benchmark 04:51:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7299.694907337215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.6385797562266, 3296.4066468035744, 3371.949420758689, 3378.223008707997, 3380.7802492837977, 5448.645838020526, 5513.476219759122, 5513.889722205554, 5525.226468294442, 5584.246126772884, 5469.15228139638, 5520.613557051008, 5534.584906132036, 5614.522765564931, 5638.40796716344, 4077.7757223352705, 5045.268436076767, 5069.062223488666, 5123.564497017758, 5181.481851814826, 4947.802087916479, 5169.715665638389, 5186.273921650972, 5187.299714538545, 5198.324217851674, 4533.229351010304, 4987.600991920638, 5142.151544995071, 5187.299714538527, 5195.064888320101, 4826.0, 5066.645334826564, 5100.132977393815, 5105.566026887682, 5165.870853228662, 5040.798368065273, 5041.672291301091, 5059.974700126476, 5083.440821509668, 5143.459936706629, 5394.78420863169, 5401.946620409022, 5578.191162281447, 5594.160875868612, 5602.495775380195, 5494.423085575997, 5931.911021334683, 5971.552133589955, 6055.909161362583, 6119.228375855631, 6121.6358891611635, 6127.250613123811, 6139.369480960552, 6152.5693201475915, 6165.10605962133, 5658.094704847204, 5664.830055098354, 5665.745041473144, 5680.545556355523, 5682.914756278659, 6113.96943015291, 6117.705611546597, 6135.385782596134, 6163.260408750889, 6181.7527298908435, 5963.850903727442, 6005.129256257818, 6016.639001659914, 6028.095785632103, 6068.4538391544975, 6041.154238406627, 6186.907196392058, 6187.319394866561, 6195.132681424604, 6207.565470417027, 5815.244018277682, 5903.0260007099205, 5906.881862362815, 5991.5206783457215, 5993.31076926159, 5958.582899197101, 5995.190649262381, 6000.159977603139, 6028.788992385245, 6033.456988871023, 4058.9040958940923, 4811.687240329367, 4821.108095002436, 4829.468758436639, 4855.077535268288, 3546.8049257291095, 4299.161663475592, 4301.849435269751, 4347.7826108694435, 4381.583749543788, 5458.61789674719, 5607.579431542651, 5642.943570564324, 5713.4000929902595, 5715.885682286331, 6157.384261573807, 6176.227971503562, 6202.224721909762, 6204.658743769046, 6232.189815323979, 5707.429257074259, 5739.311282646109, 5743.253377060955, 5752.482276595127, 5789.2763404574425, 4450.688451808407, 4811.0, 5154.407243167008, 5177.8187763428095, 5234.057869583511, 4553.408056952575, 5138.332016837787, 5617.157426386075, 6151.96924015395, 6197.721102550306, 5994.460498555151, 6008.669523176267, 6014.609050411709, 6024.216851809412, 6055.091736239599, 6141.877162456815, 6142.0, 6183.81448556526, 6192.102145189013, 6320.747170113144, 4784.497627749036, 5378.977994181093, 5868.765249389977, 6004.699765011819, 6080.179175811209, 6005.069214271794, 6062.272527296753, 6153.569250152446, 6166.938330616636, 6170.53720970938, 5224.2947202127225, 5682.374938756816, 5754.6547207167705, 5966.522678185648, 5975.731092100779, 5881.794137205177, 5883.235179426647, 5889.411058894077, 5908.084246941731, 6012.398760124128, 5649.12438572022, 5717.42825717425, 5772.913406298825, 5791.420857914175, 5797.913031304618, 5760.164776107525, 5812.622179558315, 5871.295444546511, 5949.286085669574, 5953.7023148843255, 5738.9139162913425, 5773.162891380643, 5775.480206781242, 5807.070868660994, 5822.446867547576], "value": 5503.92235076475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.5764073459763, 537.3846945247694, 543.681946061554, 571.2573654249475, 573.306299377753, 38895.80552097239, 40323.59676403235, 40606.7969660152, 42975.0, 42989.78505107478, 41842.0, 42419.78790106053, 42443.78778106105, 42513.787431062876, 42591.14817703644, 8265.83468330633, 8492.575371231445, 9188.632454701803, 9678.854817177731, 9696.757581060494, 9606.087421694929, 9698.563564639573, 9705.514724263794, 9712.22302215821, 9714.562844671971, 8251.257386835183, 9685.69243152176, 9692.709218723414, 9715.028497150299, 9790.167835733972, 9672.661456849011, 9690.12788849007, 9720.951395242979, 9720.95139524305, 9745.415275083447, 9564.378315409476, 9606.66376676813, 9639.42163470187, 9656.855147172799, 9660.178884794801, 38677.613223867964, 39607.0, 39624.80187599044, 39760.40359394612, 39788.0, 3324.16895776056, 3440.4323286657923, 3888.9027774305587, 4099.282625540548, 4183.3515805050265, 23778.881105594362, 30809.8459507701, 31397.37205255905, 31430.371392572022, 31436.0, 3173.587433633613, 3214.357128574271, 3300.372929143455, 3368.1411240133607, 3368.9724633986625, 498559.0144098549, 503675.0, 507959.0, 507969.46015270054, 508197.0, 56435.43564564384, 56647.433525664215, 56994.43005569891, 57189.71405142947, 57250.0, 57194.7140264296, 58608.70695646494, 58915.41084589099, 59149.521261968795, 59314.0, 12909.54816581415, 15408.61478463025, 15539.912206145462, 15694.9215253923, 15893.761593576106, 12091.274523528617, 12171.75656486883, 12538.0, 12609.873901261053, 12624.17942833713, 14679.41282348694, 15155.469558565397, 15169.848301517064, 15197.6200594986, 15431.61420964485, 6195.473384762346, 6274.811755647338, 6354.364563543609, 6386.361363863576, 6389.776357827547, 847.9406441549032, 978.256525040974, 1114.816055350858, 1140.7889540435046, 1152.913531485142, 25996.35009124787, 29868.0, 30055.02681433688, 30288.091357259316, 30387.936422225117, 1035.1873779083382, 1061.1351748325244, 1110.9888901110885, 1149.1611123879616, 1169.140681599024, 14610.0, 14726.202021615858, 15364.308606112752, 15500.92249538745, 15716.371345146295, 612260.9386953036, 713390.0, 716337.0, 717385.0, 718151.0, 56440.87118257612, 56666.0, 56826.0, 57441.71279143578, 57609.71195144081, 1328.754180476615, 1368.7946807978683, 1382.67507135823, 1391.7425276323913, 1392.617030316671, 28406.0, 29304.7069529302, 29424.675889584592, 29912.700872991863, 30130.24674383158, 48082.75958620325, 48562.78593035202, 48725.269120962505, 49333.2600010993, 49456.01087978292, 631629.0, 631877.0, 636245.0, 636275.0, 636468.0, 25176.244712657917, 25959.351016224744, 26092.608610870473, 26241.0, 26280.60579091277, 45996.16015359348, 47050.76474617605, 47094.52905470901, 47402.0, 47559.76220118877, 37691.43462848005, 38886.934113040435, 38890.61109388983, 39009.414858776574, 39739.40390894081, 33970.0, 34104.63581456813, 38638.06510216517, 38792.41811372888, 39075.80462097671, 36771.08072298107, 37167.25665486729, 37295.62704372922, 37612.435813463366, 37960.0, 30549.6252668626, 34018.14954626154, 34479.827600861834, 34561.827190863885, 34616.65383346235, 24903.50192996166, 25070.0, 25123.0, 25527.36181595475, 25725.0], "value": 19785.501381864924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.65226404255844, 360.7636997766464, 375.6431390179327, 384.14719323102713, 400.51537639456257, 14135.363908624111, 19495.41513754588, 20522.69215961758, 20925.37223883284, 21200.833954132515, 19916.302929397472, 20166.89916550419, 20571.691424628643, 20600.866952317618, 20671.483212919684, 5826.155207494921, 5944.108383742451, 6000.279966404038, 6072.908906366386, 6073.483753880925, 5879.118132280149, 5999.160117583542, 6002.249718785152, 6038.637681739087, 6062.666553339564, 5795.275590551181, 5873.0, 5966.0, 5986.161937328778, 5991.940080599182, 5886.823395298148, 5895.263092113486, 5923.052311630162, 5924.081767326028, 5951.464368206882, 4960.975195124038, 5065.733566608348, 5132.692038477666, 5138.58891288696, 5168.3797944246935, 20986.790132098635, 22424.88787556052, 23510.52978940429, 23713.525729485485, 25483.745162548323, 2177.4447515883508, 2239.4065572623267, 2332.7783860533223, 2378.678878351435, 2389.0, 9628.374155679858, 10285.845712314322, 10384.01351871571, 12560.0, 14763.892708046833, 1593.5060131359317, 1667.808202056767, 1840.9782570673271, 1842.5485755989735, 1897.3643829317195, 96660.0, 114610.0, 118225.86209482627, 118588.40705796501, 121835.39082304621, 11188.049015833583, 11306.547738090385, 11404.0, 11428.657140285804, 11590.188686792013, 12046.819297710366, 13956.232407217498, 14220.937963995162, 14261.857381426053, 14393.856061439461, 7056.682449289691, 8389.832203356022, 8536.189062039097, 8546.0, 8592.355573332025, 8455.112213217646, 8456.238938495442, 8459.365547583955, 8612.78468038304, 8626.180512851395, 4426.092651006536, 4462.397576327219, 4484.775761211991, 4561.977190114095, 4633.745144017112, 1880.1915176473974, 1936.3126090238045, 1937.5349916020336, 1938.825505704465, 1939.4278687787137, 842.7808769719794, 901.8466860633708, 904.3714618340322, 913.8720579118929, 940.2994768897079, 15666.921665391828, 19939.60120797576, 20492.69260961087, 21001.78998210029, 21132.049057792436, 948.743839163422, 966.4104896013426, 971.9131053918256, 972.3582435592475, 977.032737589781, 8571.185737354941, 9548.092931171528, 10750.946245268724, 11103.777924441465, 11144.665660030212, 567475.0, 580355.0, 594776.0, 608925.0, 609675.0, 117644.0, 120755.79244207621, 126115.0, 126492.0, 135584.32207838897, 930.930180236485, 1018.2922868606396, 1036.7874585709912, 1084.1056128693701, 1090.2422816142864, 19403.8059619402, 19559.04409559033, 19763.110660020622, 19787.40637780869, 19900.90049549743, 45869.0, 50764.0, 56404.717976409855, 57899.42100579109, 59163.70418147882, 84464.57767711367, 85165.57417212875, 85605.0, 85690.0, 86412.0, 7982.880256796268, 8114.634841432032, 8201.343892488467, 8272.586370681562, 8422.32621390275, 12144.514219431123, 12744.553940612033, 12848.357582121043, 13205.405756741162, 13462.596122116352, 11173.888261117285, 11286.830697539708, 11350.432478375884, 11466.0, 11619.128565357463, 11066.889331106908, 11112.388818615054, 11166.888331116585, 11213.55145794159, 11384.601538946097, 10852.565897364017, 11090.11845853977, 11495.367754773568, 11560.190786645191, 11699.2980421175, 8017.63920623585, 8053.355731541345, 8100.35197184212, 8202.630881610223, 8251.83496330082, 11074.778504430027, 11234.719132021764, 11422.94288528552, 11498.597549085742, 11530.365829879102], "value": 9553.639033555615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.9925800370993, 1541.9537413877583, 1756.130715295928, 1851.4260579220452, 1880.7272945422915, 6664.0, 6904.620245886475, 8040.5979701015, 8198.631061602227, 8620.69827556035, 6868.313168683129, 8713.085126061767, 8727.38908276421, 8835.983861855888, 8841.115888411156, 2370.3481542575755, 2371.1108334374608, 2374.821888358376, 2402.291324059398, 2407.963880541793, 2254.1772253127656, 2262.8529145605567, 2285.897134628946, 2292.1175347491253, 2298.230092918874, 2225.310153852303, 2251.7072780538506, 2303.516261585061, 2396.9760302397012, 2408.722996855358, 1999.6900480425556, 2292.4612716011807, 2361.5631108244856, 2363.243761996162, 2371.312319427364, 2345.2846881701075, 2347.354477518696, 2348.471593891378, 2351.0713268259115, 2359.716833979933, 8832.160944710242, 8881.33389995753, 8926.955365223132, 8929.73210803677, 8948.0, 4174.394712766662, 5294.205869119624, 5320.441353657888, 5323.680579165262, 5334.813281535127, 3452.3095380923914, 3502.807345595991, 3622.3841946869097, 3627.4740162676526, 3630.2376500934834, 1039.8146113430696, 1079.4980334144582, 1080.1844607321423, 1088.7332603512111, 1100.6037826382496, 11440.19918605698, 11540.134489913291, 11582.71043223926, 11623.07015438763, 11634.243774154653, 4011.6991225658194, 4501.504834468205, 4507.684462087623, 4588.38056862326, 4772.785224664898, 9348.924873639482, 9877.950610246902, 9945.30382873192, 9955.701328960144, 9956.900430995742, 4675.667434781071, 4767.475577686451, 5054.848354549295, 5300.469953004668, 5302.284191634157, 4385.451818522684, 4558.111168322212, 4721.126591580569, 4869.1722407190155, 4871.707697538159, 3808.3716186829415, 3851.171998020439, 3912.471816304819, 3921.058945852975, 3947.802609869495, 1280.065552146938, 1296.6434230586665, 1297.0, 1302.9283389413674, 1305.0668771828189, 897.9416337938144, 913.8035322405715, 917.5870858113875, 934.4400815149751, 935.6771913689767, 5923.703814809242, 5939.376365481562, 5947.910781338283, 5995.790147344822, 6205.968970155121, 911.5032307392487, 953.5232383808096, 963.2390411574777, 973.7711637765119, 985.9704208873602, 3628.310620982005, 3898.6101389860787, 3933.095388060762, 3974.4038394241097, 4018.2767101921936, 10588.15294776416, 10959.397233152094, 10968.451577421256, 10980.0, 10983.231173817916, 10510.789784204273, 10521.579136834442, 10809.945950270356, 10841.186910981707, 10937.890621093688, 7698.538087714643, 8153.918460815435, 8283.917160828436, 8309.584520773937, 8322.0, 5694.117411801178, 5725.627834190765, 5800.8259752207505, 5835.328937172279, 5882.588218824641, 9790.657326993522, 10095.949520252352, 10157.39055656663, 10175.898241017496, 10237.129843963048, 10334.069933706003, 10372.0, 10397.58409663605, 10398.0, 10424.218183636105, 6546.083548303337, 6731.899021514583, 6796.966015169893, 7054.329838665319, 7219.241979592277, 8212.917870821455, 8510.0, 8513.404061715868, 8515.574221289035, 8543.0, 7389.519681220703, 7425.59159246225, 7472.551646901204, 7521.435892308208, 7619.123800762762, 7304.233055529306, 7329.413646908341, 7394.852102958018, 7487.138979017483, 7489.438292128003, 6966.024756534191, 6997.0, 7041.6831242595235, 7043.647817609201, 7048.964755176191, 4937.568105249581, 5036.169032109661, 5037.395512538519, 5157.252198431132, 5200.6879587224885, 5127.0, 5204.427512973494, 5222.086134926297, 5266.0, 5334.67991920486], "value": 4566.423538401009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.79762594672368, 266.9012465387807, 298.96561895382035, 310.64276082505125, 314.44343511983806, 4943.283223932533, 5336.332958380192, 5499.257600223974, 5534.513256648316, 5664.235328230693, 5001.424836143845, 5292.841214763554, 5453.836384908459, 5502.80740174094, 5520.613557051008, 3648.9600463867805, 4119.548868423283, 4203.5165955915, 4207.095474472995, 4233.491980962273, 3645.034065972506, 4092.8362865485346, 4203.138356636898, 4243.236217480852, 4257.40396344512, 3944.901377465572, 4156.210320039198, 4159.667226621878, 4162.625363717265, 4165.250254954107, 4189.162167566484, 4204.138151678899, 4208.452901122865, 4209.589787421218, 4230.682698797572, 3047.481928072211, 3432.541170002764, 3508.0878971467346, 3649.6167902370134, 3660.194757153422, 5407.432219616962, 5408.3228801743, 5441.877667709597, 5453.890922181534, 5470.206820011076, 4739.786709598076, 4749.833755818564, 4754.953910139764, 4759.524047595248, 4765.189917713997, 5516.310461192351, 5531.446855314477, 5791.623544469596, 5851.941480585182, 5856.042698437262, 3564.4177601510573, 3822.388417853158, 3934.5278566572197, 3955.8417663293435, 3970.166265084336, 5066.645334826527, 5166.320945692627, 5887.528997680218, 5989.790357337472, 6255.937440625581, 3390.3897298486017, 3800.4299355096955, 3930.508686414198, 3962.791348638693, 3979.870769138497, 3677.282929828711, 3688.5020522229156, 3776.4712940188397, 4041.474608300961, 4052.65552428041, 4442.777861106932, 4622.95377046232, 4742.099001189832, 4749.833755818529, 4760.500147484534, 5359.732013399314, 5755.280589926259, 5913.645181289136, 5956.344802071769, 5978.790742323998, 1348.3258370814592, 1373.2241283674691, 1375.3192169875977, 1378.7035787305776, 1380.6617378742071, 713.3579778199559, 763.3435245688703, 769.3575864153495, 797.6490344248512, 808.7492877208084, 4657.347971284023, 4710.505396933341, 4723.291506274087, 4733.644976626767, 4749.335093086971, 4393.0994146199955, 4800.487846328396, 4868.245421959602, 5203.401608814959, 5248.265242866002, 3907.4529565860803, 4228.2600544905135, 4422.823087076546, 4755.738434386073, 4821.566059054632, 2205.162038425388, 2365.6333268343433, 2479.962800557993, 2535.3534848613485, 2624.6325514427995, 5269.868253293622, 5342.332208473941, 5344.331958505187, 5355.678659280456, 5356.544693701079, 4610.847288177955, 5009.298698182258, 5047.192449208109, 5297.894042119136, 5859.824205273849, 5704.201411802351, 5825.689219925567, 6264.342244064308, 6291.5281353898645, 6331.525135614939, 5487.862803429786, 5929.762809487572, 6137.631742095488, 6165.6608886509875, 6194.38056194377, 4450.376947227455, 5178.792848286026, 5258.921116183337, 5864.912026319694, 5886.323072846678, 5948.851278718067, 6299.299189218794, 6299.433051025429, 6303.527235457451, 6314.737052589408, 3593.6765691087926, 3870.4968354113785, 3957.5448823385677, 4079.9796001019804, 4146.771927544014, 5516.889662206813, 6061.878762424639, 6073.939260607337, 6079.878402432015, 6111.7249723763425, 5145.382554093533, 5625.587864973908, 5894.377002233965, 5915.290165180206, 5932.377100404568, 5774.711264436845, 5849.561282903885, 5855.979687007975, 5877.35349111606, 5878.94121058801, 4826.131296366688, 4927.28554359623, 5635.816478539388, 5649.740103958449, 5801.535877129904, 4294.785260736888, 4839.758012099452, 5117.565006974449, 5583.855309661591, 5854.0, 5661.716914154194, 5713.971430142823, 5715.884842760788, 5723.427657234243, 5793.826185214451], "value": 4100.7468767739065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.8216408323627, 669.8559809640926, 736.5875109938431, 745.5191401546003, 771.9112302085258, 14987.10077395357, 15959.601009974742, 16106.194690265498, 16107.677846443064, 16157.0, 14506.927465362685, 14628.488002919874, 14632.561023169323, 14645.19451430171, 14654.560363189095, 642.3223499208333, 696.6586372677402, 737.9447390231966, 821.7041864928651, 843.0894633795486, 834.7537476444463, 845.8435189489933, 859.072202021815, 864.6843901975765, 865.9911203447975, 861.625193041026, 909.7816524034217, 917.7613820406709, 919.2691810011057, 920.2270093121776, 878.275422776209, 894.6779159502574, 898.6495266845935, 908.6819613135416, 908.7728067982971, 646.5861848417017, 655.1090516897016, 677.1839932880866, 681.1247546902256, 682.556338380052, 14863.554093377215, 14968.02707823988, 15012.174330411823, 15041.097534147986, 15052.623684407868, 14596.197209153492, 14638.341274642667, 14737.336819843133, 14776.26118694061, 14951.850481495154, 11860.347680877549, 12051.035917126608, 12266.080043996646, 12267.079969002361, 12388.831954408033, 3543.7165026797793, 3756.69946404287, 3800.068983099131, 3979.820908059144, 3990.980045099785, 83337.0, 123145.37537432421, 123836.38081809624, 123947.38026309901, 132517.33741331424, 11134.721631959104, 11307.378094204898, 11381.943090284662, 11513.136514761427, 11696.415179241005, 23635.645465318034, 23669.644955325683, 23684.88157559201, 23794.286171414886, 23810.52378952411, 7922.286994170552, 8114.391420643476, 8208.507489550646, 8365.07984121746, 8391.958040209882, 4402.823887044547, 4434.238578174505, 4447.421835161408, 4484.304932735431, 4587.105514424722, 3669.6513831185994, 3788.791616461066, 3789.829457674411, 3816.198598294334, 3929.587393323717, 709.61326077288, 720.0782997762872, 730.302561054192, 732.8351120997839, 737.5206116024627, 539.9460053994648, 618.7153909201818, 668.8695704337705, 675.2133764164693, 694.3091623834317, 8241.670333186605, 8989.370744047985, 9807.803843923082, 9833.164181044549, 9856.901430985741, 525.1440152551316, 598.1506261109236, 606.6754286456812, 614.7018695932469, 646.1341801985362, 4420.0, 4564.452265728068, 4712.31671407644, 4806.279058141306, 4832.44426890905, 125575.0, 150056.0, 151882.48117518684, 153904.0, 155050.0, 103256.0, 130382.39235215243, 135172.0, 137118.31440842932, 141539.99999999793, 79842.0, 108833.0, 109583.0, 110281.44859275813, 111105.0, 8854.21050286403, 9031.729048128567, 9040.954795225982, 9073.546322683707, 9296.767580810534, 58861.0, 61741.0, 63154.0, 64541.0, 65005.02492462711, 86494.0, 92114.0, 92222.53888730513, 93202.53398732963, 95854.12437626882, 11451.312921224753, 11832.150417133607, 12060.577879774166, 12061.216020958609, 12117.454714538044, 9606.567704453457, 10792.08267297257, 11384.943075284571, 11658.941705291758, 13936.651583710489, 10218.456360847487, 12079.214851034654, 12161.148719589544, 12707.618771436872, 12720.109592328448, 12206.375629239756, 13309.733805324033, 13848.376823042785, 13917.443302267797, 14353.64115897111, 10594.0, 13378.42616712598, 13520.797188042385, 13716.588502344946, 13785.0, 9927.503624818586, 10053.240682880612, 11220.214584978972, 11291.266067705574, 11817.527298907948, 8845.0, 10689.893101069201, 11458.484368203617, 11552.364619945984, 11576.36330001858], "value": 7765.235678468857, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 118.0, 119.0, 119.0, 125.0, 115.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 114.0, 111.0, 149.0, 113.0, 113.0, 117.0, 96.0, 151.0, 99.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 268.0, 271.0, 227.0, 195.0, 235.0, 275.0, 202.0, 196.0, 199.0], "value": 226.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 61.0, 98.0, 86.0, 50.0, 67.0, 81.0, 106.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 86.0, 76.0, 62.0, 101.0, 123.0, 102.0, 103.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 77.0, 96.0, 120.0, 111.0, 131.0, 138.0, 89.0, 83.0, 132.0], "value": 106.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 108.0, 131.0, 103.0, 115.0, 111.0, 134.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 104.0, 153.0, 138.0, 90.0, 101.0, 150.0, 123.0, 94.0], "value": 122.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 62.0, 67.0, 85.0, 87.0, 91.0, 88.0, 58.0], "value": 71.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 94.0, 68.0, 75.0, 109.0, 62.0, 85.0, 64.0, 64.0, 90.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 98.0, 111.0, 107.0, 82.0, 88.0, 88.0, 85.0, 85.0, 95.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 140.0, 137.0, 135.0, 142.0, 137.0, 140.0, 175.0, 142.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 174.0, 177.0, 173.0, 174.0, 168.0, 174.0, 170.0, 173.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 61.0, 77.0, 61.0, 64.0, 86.0, 90.0, 92.0, 94.0], "value": 76.1, "unit": "score"}]}]} 04:51:26 INFO - Return code: 0 04:51:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:26 ERROR - # TBPL SUCCESS # 04:51:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:26 INFO - 2016-09-29 04:51:26.212 screenresolution[1674:10825] starting screenresolution argv=screenresolution get 04:51:26 INFO - 2016-09-29 04:51:26.215 screenresolution[1674:10825] Display 0: 1600x1200x32@60 04:51:26 INFO - 2016-09-29 04:51:26.221 screenresolution[1675:10828] starting screenresolution argv=screenresolution list 04:51:26 INFO - Available Modes on Display 0 04:51:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:26 INFO - Intel Iris: 04:51:26 INFO - Chipset Model: Intel Iris 04:51:26 INFO - Type: GPU 04:51:26 INFO - Bus: Built-In 04:51:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:26 INFO - Vendor: Intel (0x8086) 04:51:26 INFO - Device ID: 0x0a2e 04:51:26 INFO - Revision ID: 0x0009 04:51:26 INFO - Displays: 04:51:26 INFO - Display: 04:51:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:26 INFO - Display Serial Number: 1600x1200 60 04:51:26 INFO - Main Display: Yes 04:51:26 INFO - Mirror: Off 04:51:26 INFO - Online: Yes 04:51:26 INFO - Rotation: Supported 04:51:26 INFO - Return code: 0 04:51:26 INFO - Running post-action listener: _resource_record_post_action 04:51:26 INFO - [mozharness: 2016-09-29 11:51:26.459723Z] Finished run-tests step (success) 04:51:26 INFO - Running post-run listener: _resource_record_post_run 04:51:26 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37841408; Write bytes: 711991808; Read time: 252; Write time: 2031 04:51:26 INFO - TinderboxPrint: CPU usage
54.5% 04:51:26 INFO - TinderboxPrint: I/O read bytes / time
37,841,408 / 252 04:51:26 INFO - TinderboxPrint: I/O write bytes / time
711,991,808 / 2,031 04:51:26 INFO - TinderboxPrint: CPU idle
2,203.4 (45.5%) 04:51:26 INFO - TinderboxPrint: CPU system
979.0 (20.2%) 04:51:26 INFO - TinderboxPrint: CPU user
1,659.3 (34.3%) 04:51:26 INFO - TinderboxPrint: Swap in / out
445,120,512 / 0 04:51:26 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 404518912; Write bytes: 392611840; Read time: 29653; Write time: 786 04:51:26 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30626304; Write bytes: 300423680; Read time: 185; Write time: 1202 04:51:26 INFO - Running post-run listener: _upload_blobber_files 04:51:26 INFO - Blob upload gear active. 04:51:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:26 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 04:51:26 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'] 04:51:26 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 04:51:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:28 INFO - (blobuploader) - INFO - Done attempting. 04:51:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:30 INFO - (blobuploader) - INFO - Done attempting. 04:51:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:32 INFO - (blobuploader) - INFO - Done attempting. 04:51:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:32 INFO - Return code: 0 04:51:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6021a7dcfd628fae181cc4ab1c2270e53408d9ea809e56261077d26a95289f1e994eb41bc1e31b32b1f2e672d23b0b18ebfb27e647fb5ab49918207b5e7a1aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4b548737a2d926644e7907544ee359f0d0096a0e6fb6e332efeb622f4f822b87e602e00b87d9b501139a83c03e6aac47c5803b5acf19f1e1edf3a1234f2ebee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6629ebfee85687f177669f4819493d832193cd122a78c7494825e56b9b0b54f50dbdb1ab9f8779b09a0c41c4b6e36348a1822dac149ec8c419f3aefbb14f9e7f"} 04:51:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:32 INFO - Contents: 04:51:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6021a7dcfd628fae181cc4ab1c2270e53408d9ea809e56261077d26a95289f1e994eb41bc1e31b32b1f2e672d23b0b18ebfb27e647fb5ab49918207b5e7a1aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4b548737a2d926644e7907544ee359f0d0096a0e6fb6e332efeb622f4f822b87e602e00b87d9b501139a83c03e6aac47c5803b5acf19f1e1edf3a1234f2ebee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6629ebfee85687f177669f4819493d832193cd122a78c7494825e56b9b0b54f50dbdb1ab9f8779b09a0c41c4b6e36348a1822dac149ec8c419f3aefbb14f9e7f"} 04:51:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:32 INFO - Copying logs to upload dir... 04:51:32 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.800470 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-29 04:51:32.728043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 04:51:32.731414) ========= 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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6021a7dcfd628fae181cc4ab1c2270e53408d9ea809e56261077d26a95289f1e994eb41bc1e31b32b1f2e672d23b0b18ebfb27e647fb5ab49918207b5e7a1aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4b548737a2d926644e7907544ee359f0d0096a0e6fb6e332efeb622f4f822b87e602e00b87d9b501139a83c03e6aac47c5803b5acf19f1e1edf3a1234f2ebee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6629ebfee85687f177669f4819493d832193cd122a78c7494825e56b9b0b54f50dbdb1ab9f8779b09a0c41c4b6e36348a1822dac149ec8c419f3aefbb14f9e7f"} build_url:https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/LAXBxNslSE-QDfqVz1EE1w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6021a7dcfd628fae181cc4ab1c2270e53408d9ea809e56261077d26a95289f1e994eb41bc1e31b32b1f2e672d23b0b18ebfb27e647fb5ab49918207b5e7a1aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4b548737a2d926644e7907544ee359f0d0096a0e6fb6e332efeb622f4f822b87e602e00b87d9b501139a83c03e6aac47c5803b5acf19f1e1edf3a1234f2ebee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6629ebfee85687f177669f4819493d832193cd122a78c7494825e56b9b0b54f50dbdb1ab9f8779b09a0c41c4b6e36348a1822dac149ec8c419f3aefbb14f9e7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 04:51:32.763515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 04:51:32.763840) ========= 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.bTvXUDnZj0/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.tZUnMOGU4c/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 04:51:32.813249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 04:51:32.813661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 04:51:32.814206) ========= ========= Total master_lag: 2.44 =========