builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0024 starttime: 1474725383.19 results: success (0) buildid: 20160924060436 builduid: 0ba61fdcca3647e0b11f393f39eeaabe revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.189591) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.190073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.190383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.289744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.290099) ========= 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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-24 06:56:23-- 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% 170M=0s 2016-09-24 06:56:23 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.615976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.930561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.931023) ========= 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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.028310 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.980441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:23.980798) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-24 06:56:24,052 truncating revision to first 12 chars 2016-09-24 06:56:24,052 Setting DEBUG logging. 2016-09-24 06:56:24,052 attempt 1/10 2016-09-24 06:56:24,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29beaebdfacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-24 06:56:24,692 unpacking tar archive at: mozilla-central-29beaebdfacc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:24.941887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:24.942377) ========= script_repo_revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:24.942906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:24.943289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 06:56:24.963611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-24 06:56:24.964006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:56:25 INFO - MultiFileLogger online at 20160924 06:56:25 in /builds/slave/test 06:56:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:56:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:56:25 INFO - {'append_to_log': False, 06:56:25 INFO - 'base_work_dir': '/builds/slave/test', 06:56:25 INFO - 'blob_upload_branch': 'Firefox', 06:56:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:56:25 INFO - 'branch': 'Firefox', 06:56:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:56:25 INFO - 'config_files': ('talos/mac_config.py',), 06:56:25 INFO - 'default_actions': ('clobber', 06:56:25 INFO - 'read-buildbot-config', 06:56:25 INFO - 'download-and-extract', 06:56:25 INFO - 'populate-webroot', 06:56:25 INFO - 'create-virtualenv', 06:56:25 INFO - 'install', 06:56:25 INFO - 'run-tests'), 06:56:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:56:25 INFO - 'download_minidump_stackwalk': True, 06:56:25 INFO - 'download_symbols': 'ondemand', 06:56:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:56:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:56:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:56:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:56:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:56:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:56:25 INFO - 'installer_path': 'installer.exe', 06:56:25 INFO - 'log_level': 'info', 06:56:25 INFO - 'log_name': 'talos', 06:56:25 INFO - 'log_to_console': True, 06:56:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:56:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:56:25 INFO - 'opt_config_files': (), 06:56:25 INFO - 'pip_index': False, 06:56:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:56:25 INFO - 'cmd': ('bash', 06:56:25 INFO - '-c', 06:56:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:56:25 INFO - 'enabled': True, 06:56:25 INFO - 'halt_on_failure': False, 06:56:25 INFO - 'name': 'check_screen_resolution'},), 06:56:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:56:25 INFO - 'cmd': ('bash', 06:56:25 INFO - '-c', 06:56:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:56:25 INFO - 'enabled': True, 06:56:25 INFO - 'halt_on_failure': False, 06:56:25 INFO - 'name': 'check_screen_resolution'},), 06:56:25 INFO - 'run_cmd_checks_enabled': True, 06:56:25 INFO - 'sps_profile': False, 06:56:25 INFO - 'sps_profile_interval': 0, 06:56:25 INFO - 'suite': 'dromaeojs-e10s', 06:56:25 INFO - 'system_bits': '32', 06:56:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:56:25 INFO - 'title': 't-yosemite-r7-0024', 06:56:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:56:25 INFO - 'use_talos_json': True, 06:56:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:56:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:56:25 INFO - 'work_dir': 'build'} 06:56:25 INFO - [mozharness: 2016-09-24 13:56:25.156616Z] Running clobber step. 06:56:25 INFO - Running pre-action listener: _resource_record_pre_action 06:56:25 INFO - Running main action method: clobber 06:56:25 INFO - rmtree: /builds/slave/test/build 06:56:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:56:27 INFO - Running post-action listener: _resource_record_post_action 06:56:27 INFO - [mozharness: 2016-09-24 13:56:27.427725Z] Finished clobber step (success) 06:56:27 INFO - [mozharness: 2016-09-24 13:56:27.427946Z] Running read-buildbot-config step. 06:56:27 INFO - Running pre-action listener: _resource_record_pre_action 06:56:27 INFO - Running main action method: read_buildbot_config 06:56:27 INFO - Using buildbot properties: 06:56:27 INFO - { 06:56:27 INFO - "project": "", 06:56:27 INFO - "product": "firefox", 06:56:27 INFO - "script_repo_revision": "production", 06:56:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:56:27 INFO - "repository": "", 06:56:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:56:27 INFO - "buildid": "20160924060436", 06:56:27 INFO - "pgo_build": "False", 06:56:27 INFO - "basedir": "/builds/slave/test", 06:56:27 INFO - "buildnumber": 32, 06:56:27 INFO - "slavename": "t-yosemite-r7-0024", 06:56:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:56:27 INFO - "platform": "yosemite_r7", 06:56:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:56:27 INFO - "branch": "mozilla-central", 06:56:27 INFO - "repo_path": "mozilla-central", 06:56:27 INFO - "revision": "29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49", 06:56:27 INFO - "stage_platform": "macosx64", 06:56:27 INFO - "builduid": "0ba61fdcca3647e0b11f393f39eeaabe", 06:56:27 INFO - "slavebuilddir": "test" 06:56:27 INFO - } 06:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:56:27 INFO - Running post-action listener: _resource_record_post_action 06:56:27 INFO - [mozharness: 2016-09-24 13:56:27.433616Z] Finished read-buildbot-config step (success) 06:56:27 INFO - [mozharness: 2016-09-24 13:56:27.433825Z] Running download-and-extract step. 06:56:27 INFO - Running pre-action listener: _resource_record_pre_action 06:56:27 INFO - Running main action method: download_and_extract 06:56:27 INFO - mkdir: /builds/slave/test/build/tests 06:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:27 INFO - trying https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:56:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/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 06:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/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 06:56:28 INFO - Downloaded 1199 bytes. 06:56:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:56:28 INFO - Using the following test package requirements: 06:56:28 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:56:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:56:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:56:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'jsshell-mac.zip'], 06:56:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:56:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:56:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:56:28 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:56:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:56:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:56:28 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:56:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:56:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:56:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:56:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:56:29 INFO - Expected file size: 16438786 06:56:36 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 06:56:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:56:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:56:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:56:37 INFO - Expected file size: 16438786 06:56:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:56:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:56:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:56:44 INFO - Expected file size: 14414059 06:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:45 INFO - trying https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/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 06:56:48 INFO - Downloaded 111568584 bytes. 06:56:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:56:48 INFO - mkdir: /builds/slave/test/properties 06:56:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:56:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:56:48 INFO - Contents: 06:56:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:56:49 INFO - Running post-action listener: _resource_record_post_action 06:56:49 INFO - Running post-action listener: set_extra_try_arguments 06:56:49 INFO - [mozharness: 2016-09-24 13:56:49.563858Z] Finished download-and-extract step (success) 06:56:49 INFO - [mozharness: 2016-09-24 13:56:49.563980Z] Running populate-webroot step. 06:56:49 INFO - Running pre-action listener: _resource_record_pre_action 06:56:49 INFO - Running main action method: populate_webroot 06:56:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:56:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:56:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:56:49 INFO - '--tppagecycles', 06:56:49 INFO - '7'], 06:56:49 INFO - 'tests': ['tsvgm']}}, 06:56:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:56:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:56:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:56:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:56:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['damp', 'tps']}, 06:56:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'tests': ['damp', 'tps']}, 06:56:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['dromaeo_dom']}, 06:56:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:56:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['basic_compositor_video']}, 06:56:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:56:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['a11yr', 06:56:49 INFO - 'ts_paint', 06:56:49 INFO - 'tpaint', 06:56:49 INFO - 'sessionrestore', 06:56:49 INFO - 'sessionrestore_no_auto_restore', 06:56:49 INFO - 'tabpaint']}, 06:56:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['tsvgx', 06:56:49 INFO - 'tsvgr_opacity', 06:56:49 INFO - 'tart', 06:56:49 INFO - 'tscrollx', 06:56:49 INFO - 'cart']}, 06:56:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:56:49 INFO - 'tsvgr_opacity', 06:56:49 INFO - 'tart', 06:56:49 INFO - 'tscrollx', 06:56:49 INFO - 'cart']}, 06:56:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'talos_options': ['--disable-e10s'], 06:56:49 INFO - 'tests': ['tp5o']}, 06:56:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'tests': ['tp5o']}, 06:56:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'talos_options': ['--disable-e10s', 06:56:49 INFO - '--xperf_path', 06:56:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:49 INFO - 'tests': ['tp5n']}, 06:56:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:49 INFO - 'talos_options': ['--xperf_path', 06:56:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:49 INFO - 'tests': ['tp5n']}}, 06:56:49 INFO - 'talos.zip': {'path': '', 06:56:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:56:49 INFO - Running post-action listener: _resource_record_post_action 06:56:49 INFO - [mozharness: 2016-09-24 13:56:49.582845Z] Finished populate-webroot step (success) 06:56:49 INFO - [mozharness: 2016-09-24 13:56:49.582973Z] Running create-virtualenv step. 06:56:49 INFO - Running pre-action listener: _resource_record_pre_action 06:56:49 INFO - Running main action method: create_virtualenv 06:56:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:56:49 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 06:56:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:56:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:56:49 INFO - Using real prefix '/tools/python27' 06:56:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:56:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:56:53 INFO - Installing pip.................done. 06:56:53 INFO - Return code: 0 06:56:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:53 INFO - 'HOME': '/Users/cltbld', 06:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:53 INFO - 'LOGNAME': 'cltbld', 06:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:53 INFO - 'MOZ_NO_REMOTE': '1', 06:56:53 INFO - 'NO_EM_RESTART': '1', 06:56:53 INFO - 'PAGER': '/bin/cat', 06:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:53 INFO - 'PWD': '/builds/slave/test', 06:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:53 INFO - 'SHELL': '/bin/bash', 06:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:56:53 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:53 INFO - 'USER': 'cltbld', 06:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:53 INFO - 'XPC_FLAGS': '0x0', 06:56:53 INFO - 'XPC_SERVICE_NAME': '0', 06:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:53 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 06:56:53 INFO - Cleaning up... 06:56:53 INFO - Return code: 0 06:56:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:53 INFO - 'HOME': '/Users/cltbld', 06:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:53 INFO - 'LOGNAME': 'cltbld', 06:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:53 INFO - 'MOZ_NO_REMOTE': '1', 06:56:53 INFO - 'NO_EM_RESTART': '1', 06:56:53 INFO - 'PAGER': '/bin/cat', 06:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:53 INFO - 'PWD': '/builds/slave/test', 06:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:53 INFO - 'SHELL': '/bin/bash', 06:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:56:53 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:53 INFO - 'USER': 'cltbld', 06:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:53 INFO - 'XPC_FLAGS': '0x0', 06:56:53 INFO - 'XPC_SERVICE_NAME': '0', 06:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:53 INFO - Downloading/unpacking psutil>=3.1.1 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:56:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:57 INFO - Installing collected packages: psutil 06:56:57 INFO - Running setup.py install for psutil 06:56:57 INFO - building 'psutil._psutil_osx' extension 06:56:57 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 06:56:58 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 06:56:58 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 06:56:58 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 06:56:58 INFO - building 'psutil._psutil_posix' extension 06:56:58 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 06:56:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:56:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:56:58 INFO - ^ 06:56:58 INFO - 1 warning generated. 06:56:58 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 06:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:58 INFO - Successfully installed psutil 06:56:58 INFO - Cleaning up... 06:56:58 INFO - Return code: 0 06:56:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:56:58 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')]} 06:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:58 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')]} 06:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:58 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:56:58 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 06:56:58 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 06:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:58 INFO - 'HOME': '/Users/cltbld', 06:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:58 INFO - 'LOGNAME': 'cltbld', 06:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:58 INFO - 'MOZ_NO_REMOTE': '1', 06:56:58 INFO - 'NO_EM_RESTART': '1', 06:56:58 INFO - 'PAGER': '/bin/cat', 06:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:58 INFO - 'PWD': '/builds/slave/test', 06:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:58 INFO - 'SHELL': '/bin/bash', 06:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:56:58 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:58 INFO - 'USER': 'cltbld', 06:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:58 INFO - 'XPC_FLAGS': '0x0', 06:56:58 INFO - 'XPC_SERVICE_NAME': '0', 06:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:56:59 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 06:56:59 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 06:56:59 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 06:56:59 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 06:56:59 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 06:56:59 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 06:57:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:57:01 INFO - Installing collected packages: mozsystemmonitor 06:57:01 INFO - Running setup.py install for mozsystemmonitor 06:57:01 INFO - Successfully installed mozsystemmonitor 06:57:01 INFO - Cleaning up... 06:57:01 INFO - Return code: 0 06:57:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:57:01 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')]} 06:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:01 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')]} 06:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:01 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:01 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 06:57:01 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 06:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:01 INFO - 'HOME': '/Users/cltbld', 06:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:01 INFO - 'LOGNAME': 'cltbld', 06:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:01 INFO - 'MOZ_NO_REMOTE': '1', 06:57:01 INFO - 'NO_EM_RESTART': '1', 06:57:01 INFO - 'PAGER': '/bin/cat', 06:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:01 INFO - 'PWD': '/builds/slave/test', 06:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:01 INFO - 'SHELL': '/bin/bash', 06:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:01 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:01 INFO - 'USER': 'cltbld', 06:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:01 INFO - 'XPC_FLAGS': '0x0', 06:57:01 INFO - 'XPC_SERVICE_NAME': '0', 06:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:57:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:57:05 INFO - warning: no files found matching '*.txt' 06:57:05 INFO - no previously-included directories found matching 'build' 06:57:05 INFO - no previously-included directories found matching 'dist' 06:57:05 INFO - no previously-included directories found matching '.git*' 06:57:05 INFO - Installing collected packages: jsonschema, functools32 06:57:05 INFO - Running setup.py install for functools32 06:57:05 INFO - warning: no files found matching '*.txt' 06:57:05 INFO - no previously-included directories found matching 'build' 06:57:05 INFO - no previously-included directories found matching 'dist' 06:57:05 INFO - no previously-included directories found matching '.git*' 06:57:05 INFO - Successfully installed jsonschema functools32 06:57:05 INFO - Cleaning up... 06:57:05 INFO - Return code: 0 06:57:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:57:05 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')]} 06:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:05 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')]} 06:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:05 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:05 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 06:57:05 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 06:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:05 INFO - 'HOME': '/Users/cltbld', 06:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:05 INFO - 'LOGNAME': 'cltbld', 06:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:05 INFO - 'MOZ_NO_REMOTE': '1', 06:57:05 INFO - 'NO_EM_RESTART': '1', 06:57:05 INFO - 'PAGER': '/bin/cat', 06:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:05 INFO - 'PWD': '/builds/slave/test', 06:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:05 INFO - 'SHELL': '/bin/bash', 06:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:05 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:05 INFO - 'USER': 'cltbld', 06:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:05 INFO - 'XPC_FLAGS': '0x0', 06:57:05 INFO - 'XPC_SERVICE_NAME': '0', 06:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:57:05 INFO - Cleaning up... 06:57:05 INFO - Return code: 0 06:57:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:05 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')]} 06:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:05 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')]} 06:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:05 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:05 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 06:57:05 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 06:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:05 INFO - 'HOME': '/Users/cltbld', 06:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:05 INFO - 'LOGNAME': 'cltbld', 06:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:05 INFO - 'MOZ_NO_REMOTE': '1', 06:57:05 INFO - 'NO_EM_RESTART': '1', 06:57:05 INFO - 'PAGER': '/bin/cat', 06:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:05 INFO - 'PWD': '/builds/slave/test', 06:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:05 INFO - 'SHELL': '/bin/bash', 06:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:05 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:05 INFO - 'USER': 'cltbld', 06:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:05 INFO - 'XPC_FLAGS': '0x0', 06:57:05 INFO - 'XPC_SERVICE_NAME': '0', 06:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:05 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 06:57:05 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 06:57:05 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 06:57:05 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 06:57:05 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 06:57:05 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 06:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:09 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 06:57:09 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 06:57:09 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 06:57:09 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 06:57:09 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 06:57:09 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 06:57:09 INFO - Downloading docopt-0.6.1.tar.gz 06:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:09 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:09 INFO - Running setup.py install for blobuploader 06:57:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:09 INFO - Running setup.py install for requests 06:57:10 INFO - Running setup.py install for docopt 06:57:10 INFO - Successfully installed blobuploader requests docopt 06:57:10 INFO - Cleaning up... 06:57:10 INFO - Return code: 0 06:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:10 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:10 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 06:57:10 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 06:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:10 INFO - 'HOME': '/Users/cltbld', 06:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:10 INFO - 'LOGNAME': 'cltbld', 06:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:10 INFO - 'MOZ_NO_REMOTE': '1', 06:57:10 INFO - 'NO_EM_RESTART': '1', 06:57:10 INFO - 'PAGER': '/bin/cat', 06:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:10 INFO - 'PWD': '/builds/slave/test', 06:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:10 INFO - 'SHELL': '/bin/bash', 06:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:10 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:10 INFO - 'USER': 'cltbld', 06:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:10 INFO - 'XPC_FLAGS': '0x0', 06:57:10 INFO - 'XPC_SERVICE_NAME': '0', 06:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-UOGoku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-6SweJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Tc1LEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Z_FOTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-GKNkcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BEasK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-G1_RJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-awhZaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-i8d5iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SzIkrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-FOBP7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yFiIDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SYpju9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-4Rrx5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-spD3lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-UpZLcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Tp5qzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:12 INFO - Running setup.py install for manifestparser 06:57:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:12 INFO - Running setup.py install for mozcrash 06:57:12 INFO - Running setup.py install for mozdebug 06:57:13 INFO - Running setup.py install for mozdevice 06:57:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Running setup.py install for mozfile 06:57:13 INFO - Running setup.py install for mozhttpd 06:57:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Running setup.py install for mozinfo 06:57:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Running setup.py install for mozInstall 06:57:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:13 INFO - Running setup.py install for mozleak 06:57:13 INFO - Running setup.py install for mozlog 06:57:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Running setup.py install for moznetwork 06:57:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Running setup.py install for mozprocess 06:57:14 INFO - Running setup.py install for mozprofile 06:57:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Running setup.py install for mozrunner 06:57:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:14 INFO - Running setup.py install for mozscreenshot 06:57:14 INFO - Running setup.py install for moztest 06:57:15 INFO - Running setup.py install for mozversion 06:57:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:15 INFO - Cleaning up... 06:57:15 INFO - Return code: 0 06:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:15 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:15 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 06:57:15 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 06:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:15 INFO - 'HOME': '/Users/cltbld', 06:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:15 INFO - 'LOGNAME': 'cltbld', 06:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:15 INFO - 'MOZ_NO_REMOTE': '1', 06:57:15 INFO - 'NO_EM_RESTART': '1', 06:57:15 INFO - 'PAGER': '/bin/cat', 06:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:15 INFO - 'PWD': '/builds/slave/test', 06:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:15 INFO - 'SHELL': '/bin/bash', 06:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:15 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:15 INFO - 'USER': 'cltbld', 06:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:15 INFO - 'XPC_FLAGS': '0x0', 06:57:15 INFO - 'XPC_SERVICE_NAME': '0', 06:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cWKk2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-X4ur6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-VboRYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-2RmE2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:15 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)) 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Zn1yrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-WfTHey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-tmXpyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NZ_64r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yuqZ1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-M8ibZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-j9oJvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-a3O59c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-4_E8ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:16 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)) 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-R8PCTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:17 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)) 06:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-OEy8sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:17 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)) 06:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XEJChm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:17 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)) 06:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-K0ix3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:17 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)) 06:57:17 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)) 06:57:17 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)) 06:57:17 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)) 06:57:17 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)) 06:57:17 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)) 06:57:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:17 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 06:57:17 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 06:57:17 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 06:57:17 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 06:57:17 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 06:57:17 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 06:57:19 INFO - Downloading blessings-1.6.tar.gz 06:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:19 INFO - Installing collected packages: blessings 06:57:19 INFO - Running setup.py install for blessings 06:57:20 INFO - Successfully installed blessings 06:57:20 INFO - Cleaning up... 06:57:20 INFO - Return code: 0 06:57:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:20 INFO - Reading from file tmpfile_stdout 06:57:20 INFO - Current package versions: 06:57:20 INFO - blessings == 1.6 06:57:20 INFO - blobuploader == 1.2.4 06:57:20 INFO - docopt == 0.6.1 06:57:20 INFO - functools32 == 3.2.3-2 06:57:20 INFO - jsonschema == 2.5.1 06:57:20 INFO - manifestparser == 1.1 06:57:20 INFO - mozInstall == 1.12 06:57:20 INFO - mozcrash == 0.17 06:57:20 INFO - mozdebug == 0.1 06:57:20 INFO - mozdevice == 0.48 06:57:20 INFO - mozfile == 1.2 06:57:20 INFO - mozhttpd == 0.7 06:57:20 INFO - mozinfo == 0.9 06:57:20 INFO - mozleak == 0.1 06:57:20 INFO - mozlog == 3.4 06:57:20 INFO - moznetwork == 0.27 06:57:20 INFO - mozprocess == 0.23 06:57:20 INFO - mozprofile == 0.28 06:57:20 INFO - mozrunner == 6.12 06:57:20 INFO - mozscreenshot == 0.1 06:57:20 INFO - mozsystemmonitor == 0.3 06:57:20 INFO - moztest == 0.7 06:57:20 INFO - mozversion == 1.4 06:57:20 INFO - psutil == 3.1.1 06:57:20 INFO - requests == 1.2.3 06:57:20 INFO - wsgiref == 0.1.2 06:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:20 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 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:20 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 06:57:20 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 06:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:20 INFO - 'HOME': '/Users/cltbld', 06:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:20 INFO - 'LOGNAME': 'cltbld', 06:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:20 INFO - 'MOZ_NO_REMOTE': '1', 06:57:20 INFO - 'NO_EM_RESTART': '1', 06:57:20 INFO - 'PAGER': '/bin/cat', 06:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:20 INFO - 'PWD': '/builds/slave/test', 06:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:20 INFO - 'SHELL': '/bin/bash', 06:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:20 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:20 INFO - 'USER': 'cltbld', 06:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:20 INFO - 'XPC_FLAGS': '0x0', 06:57:20 INFO - 'XPC_SERVICE_NAME': '0', 06:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 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)) 06:57:20 INFO - Cleaning up... 06:57:20 INFO - Return code: 0 06:57:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10119f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101115570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f941ac9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, '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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 06:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:20 INFO - 'HOME': '/Users/cltbld', 06:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:20 INFO - 'LOGNAME': 'cltbld', 06:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:20 INFO - 'MOZ_NO_REMOTE': '1', 06:57:20 INFO - 'NO_EM_RESTART': '1', 06:57:20 INFO - 'PAGER': '/bin/cat', 06:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:20 INFO - 'PWD': '/builds/slave/test', 06:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:20 INFO - 'SHELL': '/bin/bash', 06:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:20 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:20 INFO - 'USER': 'cltbld', 06:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:20 INFO - 'XPC_FLAGS': '0x0', 06:57:20 INFO - 'XPC_SERVICE_NAME': '0', 06:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:57:20 INFO - Cleaning up... 06:57:20 INFO - Return code: 0 06:57:20 INFO - Running post-action listener: _resource_record_post_action 06:57:20 INFO - Running post-action listener: _start_resource_monitoring 06:57:20 INFO - Starting resource monitoring. 06:57:20 INFO - [mozharness: 2016-09-24 13:57:20.972454Z] Finished create-virtualenv step (success) 06:57:20 INFO - [mozharness: 2016-09-24 13:57:20.973442Z] Running install step. 06:57:20 INFO - Running pre-action listener: _resource_record_pre_action 06:57:20 INFO - Running main action method: install 06:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:21 INFO - Reading from file tmpfile_stdout 06:57:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:57:21 INFO - Reading from file tmpfile_stdout 06:57:21 INFO - Output received: 06:57:21 INFO - Usage: mozinstall [options] installer 06:57:21 INFO - Options: 06:57:21 INFO - -h, --help show this help message and exit 06:57:21 INFO - -d DEST, --destination=DEST 06:57:21 INFO - Directory to install application into. [default: 06:57:21 INFO - "/builds/slave/test"] 06:57:21 INFO - --app=APP Application being installed. [default: firefox] 06:57:21 INFO - mkdir: /builds/slave/test/build/application 06:57:21 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'] 06:57:21 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 06:57:55 INFO - Reading from file tmpfile_stdout 06:57:55 INFO - Output received: 06:57:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:57:55 INFO - Running post-action listener: _resource_record_post_action 06:57:55 INFO - [mozharness: 2016-09-24 13:57:55.726132Z] Finished install step (success) 06:57:55 INFO - [mozharness: 2016-09-24 13:57:55.726262Z] Running run-tests step. 06:57:55 INFO - Running pre-action listener: _resource_record_pre_action 06:57:55 INFO - Running main action method: run_tests 06:57:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:55 INFO - 2016-09-24 06:57:55.740 screenresolution[1643:8154] starting screenresolution argv=screenresolution get 06:57:55 INFO - 2016-09-24 06:57:55.743 screenresolution[1643:8154] Display 0: 1600x1200x32@60 06:57:55 INFO - 2016-09-24 06:57:55.749 screenresolution[1644:8156] starting screenresolution argv=screenresolution list 06:57:55 INFO - Available Modes on Display 0 06:57:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:55 INFO - Intel Iris: 06:57:55 INFO - Chipset Model: Intel Iris 06:57:55 INFO - Type: GPU 06:57:55 INFO - Bus: Built-In 06:57:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:55 INFO - Vendor: Intel (0x8086) 06:57:55 INFO - Device ID: 0x0a2e 06:57:55 INFO - Revision ID: 0x0009 06:57:55 INFO - Displays: 06:57:55 INFO - Display: 06:57:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:55 INFO - Display Serial Number: 1600x1200 60 06:57:55 INFO - Main Display: Yes 06:57:55 INFO - Mirror: Off 06:57:55 INFO - Online: Yes 06:57:55 INFO - Rotation: Supported 06:57:55 INFO - Return code: 0 06:57:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:57:55 INFO - Python 2.7.3 06:57:55 INFO - Return code: 0 06:57:55 INFO - grabbing minidump binary from tooltool 06:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb3d30>, '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 0x100dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fabb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:57:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:57:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:57:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:57:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:56 INFO - Return code: 0 06:57:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:57:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:57:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:57:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:57:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 06:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --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 06:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDJjq7Akhv/Render', 06:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:56 INFO - 'HOME': '/Users/cltbld', 06:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:56 INFO - 'LOGNAME': 'cltbld', 06:57:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:57:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:56 INFO - 'MOZ_NO_REMOTE': '1', 06:57:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:57:56 INFO - 'NO_EM_RESTART': '1', 06:57:56 INFO - 'PAGER': '/bin/cat', 06:57:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:56 INFO - 'PWD': '/builds/slave/test', 06:57:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:56 INFO - 'SHELL': '/bin/bash', 06:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFGo5UtZ7b/Listeners', 06:57:56 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 06:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:56 INFO - 'USER': 'cltbld', 06:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:56 INFO - 'XPC_FLAGS': '0x0', 06:57:56 INFO - 'XPC_SERVICE_NAME': '0', 06:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 06:57:56 INFO - mozversion application_buildid: 20160924060436 06:57:56 INFO - mozversion application_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 06:57:56 INFO - mozversion application_display_name: Nightly 06:57:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:56 INFO - mozversion application_name: Firefox 06:57:56 INFO - mozversion application_remotingname: firefox 06:57:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:57:56 INFO - mozversion application_vendor: Mozilla 06:57:56 INFO - mozversion application_version: 52.0a1 06:57:56 INFO - mozversion platform_buildid: 20160924060436 06:57:56 INFO - mozversion platform_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 06:57:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:57:56 INFO - mozversion platform_version: 52.0a1 06:57:56 INFO - using testdate: 1474725476 06:57:56 INFO - actual date: 1474725476 06:57:56 INFO - starting webserver on 'localhost:49277' 06:57:56 INFO - SUITE-START | Running 2 tests 06:57:56 INFO - TEST-START | dromaeo_css 06:57:56 INFO - operating with platform_type : mac_ 06:57:56 INFO - Initialising browser for dromaeo_css test... 06:57:56 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpbBtkaq/profile http://localhost:49277/getInfo.html) 06:57:59 INFO - PROCESS | 1654 | 2016-09-24 06:57:59.169 plugin-container[1656:8323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4853, name = 'com.apple.tsm.portname' 06:57:59 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:59 INFO - PROCESS | 1654 | 2016-09-24 06:57:59.172 plugin-container[1656:8323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 06:57:59 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:59 INFO - PROCESS | 1654 | 2016-09-24 06:57:59.172 plugin-container[1656:8323] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:57:59 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 06:57:59 INFO - PROCESS | 1654 | colorDepth:24 06:57:59 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 06:57:59 INFO - PROCESS | 1654 | __metrics 06:57:59 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:57:59 INFO - TEST-INFO | 1654: exit 0 06:57:59 INFO - Browser initialized. 06:57:59 INFO - Running cycle 1/1 for dromaeo_css test... 06:57:59 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpbBtkaq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:02 INFO - PROCESS | 1658 | 2016-09-24 06:58:02.460 plugin-container[1659:8443] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4613, name = 'com.apple.tsm.portname' 06:58:02 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:58:02 INFO - PROCESS | 1658 | 2016-09-24 06:58:02.463 plugin-container[1659:8443] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 06:58:02 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:58:02 INFO - PROCESS | 1658 | 2016-09-24 06:58:02.463 plugin-container[1659:8443] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:58:12 INFO - PROCESS | 1658 | RSS: Main: 239185920 06:58:12 INFO - PROCESS | 1658 | 06:59:01 INFO - PROCESS | 1658 | 1474725541819 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] 07:01:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 07:01:15 INFO - PROCESS | 1658 | RSS: Main: 252878848 07:01:15 INFO - PROCESS | 1658 | 07:04:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 07:04:18 INFO - PROCESS | 1658 | RSS: Main: 265248768 07:04:18 INFO - PROCESS | 1658 | 07:07:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 07:07:20 INFO - PROCESS | 1658 | RSS: Main: 269991936 07:07:20 INFO - PROCESS | 1658 | 07:10:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 07:10:23 INFO - PROCESS | 1658 | RSS: Main: 269459456 07:10:23 INFO - PROCESS | 1658 | 07:13:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 07:13:26 INFO - PROCESS | 1658 | RSS: Main: 274685952 07:13:26 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 07:16:29 INFO - PROCESS | 1658 | RSS: Main: 277454848 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | __start_tp_report 07:16:29 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 07:16:29 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 07:16:29 INFO - PROCESS | 1658 | |i|pagename|runs| 07:16:29 INFO - PROCESS | 1658 | |0;dojo.html;2890.2918784897697;3410.8294585270714;3428.8799892003785;3432.467967465044;3466.774659647123;5728.484436400723;5738.3974682658345;5785.623934444268;5798.623089499185;5805.187273781674;5622.100463925773;5735;5775.306963164426;5817.505512031483;5820.563457740675;4041.8383264669524;4243.618074373298;5302.522772950434;5315.202719592054;5356.892862142755;5279.313689220396;5344.706041167754;5366.973165134188;5379.892402151954;5380.892382152355;4373.278409062501;5307.601929855257;5346;5360.731963401834;5455.427180146087;5347.919781203265;5365.651232669864;5371.785128594852;5373.75818088183;5373.785048598091;5008.5993120550265;5266.631335806495;5336.706481143536;5343;5358.303420555303;5672.914906276409;5758.712064396764;5794.855128621818;5797.391273916221;5835.270591176103;6288.968555157241;6309.495240380805;6311.842203944892;6331.271903731038;6333.87332253357;6224.377562243784;6261.557992382975;6278.183836101323;6282.2461304643275;6318.873622527523;5583.162525621189;5601.411851755588;5818;5837.211976383176;5842.649441033552;6256.217972753406;6261.436470717657;6316.557840951181;6340.936590634127;6342.8414289642205;4831.4202295724735;6201.387639213837;6241.438270555672;6257.374262573706;6268.592541484789;6153.538484613672;6222.377762223741;6257.217847769029;6284.622922624566;6300.1494798202575;4664.603508701798;6226.470749986302;6263.655498947511;6264.498840092781;6298.181236439325;6075.33171351151;6106.005662907935;6176.752929882844;6269.216347956505;6271.96864015677;4932.136876046678;4954.133026720309;4965.528274813887;5012.147934851084;5028.019536190408;4397.384366188736;4456.554344565518;4471.754053527022;4479.552044795494;4512.007358381151;5469.480399362054;5751.8562035949435;5796.478316951495;5849.912251316234;5984.760609575568;6228.190335256479;6264.749410023639;6273.404026617555;6281.685915704196;6320.841978950563;5902.8819423611285;5913.379095194942;5943.940560594338;5958.880822383528;5959.67221802805;5325.627206095536;5385.219143224211;5451.509364157245;5457.2359869618285;5465.836024919259;6261.311255761862;6268.059791031382;6294.968525157528;6311.274203466568;6312.779052733133;6296.590721603081;6301.495880329471;6307.7476900925285;6312;6316.747330106744;6293.622382657055;6337.65142917144;6368.42684158428;6393.680315984089;6410.326915673787;4463.241248987615;6105.186826067751;6130.969345153246;6254.937450625435;6256.7810126645345;5180.197069454241;5400.972995134999;6115.027386288435;6270.372962703693;6326.335734747785;5065.898682026413;5102.668326558762;6212.347703491249;6230.096635987847;6231.065340198825;4918.631102667386;6043.184170136975;6180.289266734203;6225.564210505221;6242.968785156045;5371.194320851903;5937.673427961331;6012.579119461596;6024.90962635552;6140.473573783631;6215.627062376272;6241.063840423973;6246.1255424239735;6261.436470717657;6261.530385221035;6079.240094988127;6089.817305480843;6102.938970610237;6112.572119951561;6127.080937859357 07:16:29 INFO - PROCESS | 1658 | |1;ext.html;463.76348062488125;488.6262009562685;488.77516342482454;533.6371267538075;547.6330858324922;31830.68169318306;42116;42205.366919496155;44193.77903110488;44357.33463998043;43403.56596434035;43865.61343865612;43940.340894886605;43972;44018.33972490415;8258.504489730636;9748.366356186843;9946.950265248664;9967.651132210374;9972.750681232954;9765.560549775277;9766.121049105579;9781.021897810198;9814.950925245364;9873.605055797796;9815.607375704963;9881.35771174875;9915.157211637019;9919.107280344768;9930.304878658497;9812.607495700164;9845.360051596695;9854.90145098547;9868.161206297473;9869.654562090293;9700.708978730649;9783.168430683401;9788.804223915553;9789.265805064577;9801;40593.797031014954;41082.79458602718;41413.171736565404;41483.377749333784;41601.791991040154;3312.734981201498;3335.3662804067394;3357.8488967996254;3426.9485957710654;3432.1591210153424;31021.379572408652;31384.21539461509;31864.840675796706;32522.512162317584;32564.18589535257;2727.754502094821;3224.580804495424;3225.161458020908;3337.2324365395853;3351.111955331839;457026;461722;462345;463052;463427.9999999966;47288.763556182;60408;60484.09273860895;60530;60651.09023364653;28462.43075138527;34179.65820341815;34838.30323393569;35831.82084089563;36226.094347640996;16033.599160021093;16387.508374748777;16586;16586.170691465377;16594.419195328104;12604.928581070712;12659.810102848465;12718.236905785498;12721.745565088646;12746.553870614483;16543.503694888932;19256.422307330802;19550.804491955183;19817.504562386057;19837.40487785369;7787.883181752279;7812.492188007761;7835.608219588998;7895.131535531087;7938.364930805522;866.7789713623112;944.9196818270386;963.5037955452947;974.1914211204684;1041.317936751429;21871.890640546695;26117.73882261153;26131.693415329537;28197.43605127886;30533.541996870066;1050.7898420315967;1126.594426006637;1163.0985985860857;1197.820326950947;1215;14785.96498245134;15543.290238073803;15836.920815396079;15846.76229856553;16187.433439829549;680956;685942;686080;686841;688099;57403;57942.710286448295;58351.708241458524;58564.7071764647;58694.7065264671;1321.5903070048123;1348.1506650809927;1364.1474078700812;1369.6165073779557;1370.2737549098993;25630.02734576144;28372.85813570919;30089.247768805955;30166.619402280056;30263;51211;51640.967180655425;51684.22473662973;51767.741161293954;51795.96408071893;579189;580107;580287;581107;581650;26324.341891452867;26691.733082668925;27070;27158;27207.91168353244;47035.05929881315;47229;47555.76222118867;48618;48764.75617622031;38937.805310973265;39386.2122757549;39502.01244968784;39738.801305993285;40809.79595102005;39021.2195756089;39063.80468097641;39924.401133982436;40350.798246008584;40767;29163;38322.65870694512;38324.6167538321;38463.84608461751;38713.80643096879;31597.84201079072;34306;34887.953361399195;34915.60337586468;35054.29891402209;25622.615660765478;25800.967961281338;25897.352566185997;26231.606525901745;26796 07:16:29 INFO - PROCESS | 1658 | |2;jquery.html;348.2947032259674;369.61929212910695;379.9848006079758;385.44495925866767;399.73217943977534;19252.17192387451;20308;20550.89724551379;20794.960251987417;20978.790212097876;20008.29970951017;20253.696194557095;20454.69317960228;20628.17487300506;20693.793062069373;5036.4208116066575;5914.88170236595;6085.2961170872;6130.724117414727;6178.938210617904;4657.673962822604;5018.7992480300745;5760.366359700451;5904.940950590482;6117.877642447148;4890.73100979446;5127.564157046637;5890.410958904118;5994.34062253154;6019.337872833985;5871.354151043424;5878.353381128072;5888.116782482619;5963.463288304073;5969.522438204955;5070.138076526962;5143.794248230066;5185.325907632021;5211.374635043781;5211.791528338862;24703.505929881303;24998.875005625036;25573.360665983313;25605.847736851887;25634.615480767803;2277.3851060213815;2280.6579013147993;2350.5416443793465;2397.976020239793;2444.364465239033;15427.691446171013;15623.765643515357;15901.602459938478;16005;16486.093264870426;1878.7557617509774;1937.5737337785665;1939.6120775844888;1948.6882098864114;1981.4055783265107;112571;117936.41031794871;117981;118929.99999999914;120770.7922920777;8753.60608772594;9379;10397.84403233952;10472.842907356397;10840.945795270973;11192.944035279772;13352.265625390697;13585.796213056614;13596.796048059286;13626.727465450636;8367.58162091905;8442.957785211034;8506.234438900528;8583.785405364792;8677.609507572048;8655.740327790176;8667.306615470747;8671.046184919654;8829.028806831244;8868.423552469068;5614.214010038598;6538.640374779433;6605.867882642417;6606.933930660728;6651.966740166268;1583.89127610673;1839.0345068838699;1861.702127659568;1865.990670046641;1866.1229222265513;886.6497733395273;925.7407925780792;969.1810420195065;1007.5919252702668;1019.4902548725637;16086.713062954936;18051.458456246335;20268.08793604262;20702.275420360515;21995.90020499001;934.528063328015;952.4190243951184;961.2646325560952;969.1277849934974;1039.3140527251978;11016.339019658846;11531.596394126165;11811.586594469152;11820.940895295469;11850.881491184979;481204;511947;576940;577460;591697.0415147983;87444;105019;110155.89844101456;111407;118396;974.0503009565758;975.6292608808608;1005.6982905128432;1005.9798804023878;1007.7984403119259;19557.924314162858;20238.797612024282;20252.925162619256;20255.898720506302;20278;53759.73120134374;54104;54661;55137.1729424067;55334.72332638472;77875.83186252098;78053.60973195097;78118;78805;79685;6826.146731658543;7165.677544510405;7220.711171553079;7273;7373.446991475554;9568.808623827623;12748.61754147377;12755.93622031884;13067.869321306665;13203.735925281248;10953.45232738344;10963.945180274048;11251.943740281245;11314.03830674402;11328.980391764451;9130.360874738704;9579.85041794989;9639.71080867575;10966.342019478856;11201.32792032448;11135.220534562503;11394.886051139714;11401.828972565583;11518.884811152117;11683.948444640024;7176;7206.495545311778;7325.304096110861;7387.593682347308;7451.44114191427;10612.363258204532;11099.833502497308;11168.274062185932;11332.773344533229;11476.885231147582 07:16:29 INFO - PROCESS | 1658 | |3;mootools.html;1534.1868809530947;1565.428618554228;1800.1269384348589;1856.0441372693058;1888.4806678163495;7658.770236892895;8022.839543209132;8256.50460972342;8515.91484085159;9122.726318210447;8486.830263394728;8812.250958668521;8825.02924678285;8967.955160224206;8970.013298537157;2389.4623709665316;2423.3820375804144;2425.4785221177444;2430.5260474207535;2439.694763301634;2398.448356877919;2418.5283869645336;2435.8173137014705;2438.622013587888;2442.096424323003;2395.6047252203452;2410.0721222329444;2420.3102115896972;2422.7577242275806;2424.054618698709;2384.833061685683;2389.23544465771;2394.545036443079;2395.8921848516857;2403.4592216751266;2379.976200237993;2384.1893756122827;2391.868447235401;2399.652050452692;2403.327068420845;7794.844103117905;8684.565771711452;8930.86603700945;8955.014948355676;9037.909620903773;5286.180642000496;5400.027994960906;5439.5104440600535;5449.100898351767;5453.509184173404;3545.166885781839;3674.9448758268645;3723.957291958229;3735.62643735627;3751.174741556853;1060.204846365226;1099.0328510910347;1102.608573956242;1104.276698762312;1115.5928086248541;10118.696439106765;11033.951774581483;11761.705957351049;11847;11865.169438139334;4484.148011877733;4719.764011799465;4786.425628924481;4812.157872372391;4841.1285968526;9932.354396964174;9961.900380996241;9996.550155243032;10028.448435336126;10035.69892903214;5343.6526625769975;5344.171653393731;5372.91940620891;5378.731063446812;5390.4879036491475;4091.9386209206887;4379.5182529921685;4538.614217791459;4717;4842.878928026757;3856.59505751892;3873.341531939577;3942.1327307992196;3987.441758153861;3998.5601583825755;1282.910196286251;1294.6245588779336;1295.7667619828333;1302.1666133674455;1310.0502135951358;778.8948491953627;780.4146889832625;840.8612578924532;887.3389324952951;910.1899309614448;5736.196932429463;5971.940280597139;5993.441705156691;6074.299196225064;6102.237220347457;957.3107362698846;962.6967505235829;966.2511553546058;991.8264303746815;1018.6434747838198;3972.503437070366;3974.125692347679;3983.2232714620372;4054.3715724062818;4056.4320995060716;10552.103071238877;10916;10936.12510999134;10969.506372213269;10994.065504432054;8963.193312601898;9004.684836030707;10740.30188037775;10799.622013229498;10928.617498387519;6992.405645520086;7901.762947111596;8031.9960004999375;8248.257656810916;8277.54473503951;5204.687718736888;5488.286522752017;5681.488666020078;5804.738786754522;5840;9890.653827116017;9984.850227246743;10069.496525173565;10073.798524029626;10083.949580252052;9864.161546268648;10032.949835250776;10127.949360253151;10248.795024099327;10273;6511.413972742476;6694.263631000684;6965.303469652994;7133.536320139175;7829.569373684502;7050.823729406806;8160.387970902088;8310.54292013945;8405.789855253668;8461.069282379056;7412.258774122544;7555.659995300115;7558.848823023399;7614.352780013761;7615.010048693634;7279.490435669452;7367.115946086289;7461.962690186514;7527.021487206628;7549.245075492407;6913;7054.753083642048;7064.964675176591;7069.505134640526;7071.43428525727;4976.32819569368;4992.126377883928;5106.923396149135;5157.123289040947;5165.457626949266;5070.518300761421;5073.441921388718;5162.8193013245855;5187.481251874782;5254.31861804219 07:16:29 INFO - PROCESS | 1658 | |4;prototype.html;298.96113505244324;303.18896950657;306.2634364353729;314.053129813612;315.41962788469243;5061.9622977289655;5231.346081739783;5364.900195459931;5439.5585169929955;5468;4410.382546443492;5144.228365745131;5290.444503327153;5331.480528049497;5345.113638635142;3492.3364560733507;3822.44574536692;4059.2693315203323;4108.342665173573;4121.649659778923;3576.3727503985624;3961.564227934925;4109.4246805447265;4122.793860306988;4135.172965406916;3594.245208506217;3822.8853134406013;4053.898652533681;4088.3867419886956;4124.52567954686;4068.125353049079;4093.304138296482;4095.24238015968;4106.240345536085;4119.7940102994735;3013.8794448222043;3549.112721819545;3586.246888153491;3604.8197590120653;3626.909327266813;4405.603495685404;4619.445666520039;4805.279208118775;5038.924416133761;5171.948280517185;3858.9228215435533;3918.431827385013;4702.741349225791;4724.551167639069;4736.052789442126;4617.2381557043045;5602.81490218815;5636.859078523029;5669.971650141764;5679.744411501492;3294.5058241263764;3308.8511017004294;3717.1228529592654;3983.546005707925;4033.596640335972;4664.623935938872;5216.556592689626;5859.794907178229;6006.5495087868585;6027.9095813562835;4049.493813273341;4099.959000410017;4104.712670113123;4109.91780164401;4120.793960301973;3800.600936901641;4003.07852230925;4130.483689538808;4149.792510374529;4180.393842892763;4489.528599497071;4718.834840780556;4759.547842954914;4791.981051937257;4804.25534042224;5240.68555886648;5766.913496297559;5767.942320576824;5784.334801497797;5786.482879947236;1115.8828323026128;1180.4746887635092;1374.752544541992;1389.715108402775;1399.825021872266;943.9952800235955;955.574769227687;975.1467465967279;978.7472035794195;979.774651830083;4857.878553036202;5282.286891269706;5327.360716713942;5370.543503802142;5371.529096615601;5272.815451459181;5336.532453575221;5766.913496297559;5815.04051831443;5839.766409343579;4544.363789069533;5112.6001209195465;5278.208268759717;5327.200919862052;5330.706811125426;2990.743887567227;3069.2020074780717;3127.5308703694172;3136.5765621640785;3144.135362775209;5145.716985565829;6028.788992385334;6132.877342453126;6147.264467312003;6184.81445556625;5498.422665620133;5789.247397838339;6087.8478038048515;6118.388161183935;6124.755009799558;6083.8174854754425;6104.725287362079;6135.693215339215;6171.876562468815;6188.938110618927;4789.592884604708;5658.575606829587;5794.82615521535;5889.440503152194;5919.970400147971;4830.637702172421;4836.709797412166;5863.560232982458;5886.175935369138;5887.234659494238;4825.914169312017;6111.572189946839;6125.264968203844;6134.533988296598;6135.447809697149;3599.532060832075;3744.6255374463426;3860.1278379986247;3893.532776066777;3945.9408108877815;4960.883801144713;5633.746481408264;5866.472017518444;5898.970505147447;5912.487192943068;4816.975915120402;5120.641555091108;5358.0355536002335;5690.743916523849;5808.419158084158;5041.941192349647;5076.441591425014;5780.855478613068;5808.128780682931;5813.680247586423;4753.9049219016115;5418.864528386822;5428.267183930119;5580.832575022756;5631.746571404215;4841.273808928689;4977.651564390458;5745.845308009497;5780.959427303126;5796.333421656564;4657.69724967876;5255.63210575256;5569.220309156803;5655.462731040545;5656.6706823897175 07:16:29 INFO - PROCESS | 1658 | |5;yui.html;712.8503014366983;768.953862768234;798;802.1668407995917;810.3719617296596;15519.84480155198;16143.43497977571;16148.192590370492;16237.944533605307;16271;14404.279786010684;14547.345369458373;14563.271836408163;14569;14590.635234119125;664.5182242873926;695.1206723494784;817.6443247187462;845.4124383553433;860.8923884514436;841.6759547574197;859.7807559072428;875.4353442029887;875.4397185801092;878.4904755241944;912.1835956818677;925.0425809287389;925.6898938855492;927.0081013315755;934.1639232886563;904.267543289934;915.199200699388;916.7662246127228;919.7378747057123;923.4966943016038;559.3036669346649;680.6358598149966;685.0204207982583;685.1127789512593;686.3171144711044;14404.351804168733;14831.851681483264;14838.480653177086;14845.331960061716;14861.851381486264;14387.424503019867;14406.135631862122;14429.422823087063;14435.35040923161;14595.635109122251;10921.672349829518;11423.143264255214;11688.240264382788;11696.18126731129;11987.34069626179;3262.5432439458496;3824.0631045394057;3835.9808200959096;3840.423936409533;3957.8021098944937;127838.36080819536;128862;130763.34618326847;132820;134462;10325.48372581368;10431.582736690447;10583.31208471447;10753.46232688378;10809.67570972872;16912.32350705958;20522.38432847017;20735.481612959797;20785;20812.895935520224;7754.7673569793;7831.451798374173;7891.842163156704;7953.483023603448;7993.480423772437;4396.472423309159;4399.450688374706;4460.018795864905;4463.709858859163;4553.2942393929;3385.610654774732;3479.860805567749;3510.052285882797;3511.2626348466597;3522.5772907251294;629.4869681209799;632.7121159872247;661.7882277671099;666.8796422011068;669.1234482827512;577.4398833131855;599.1791245993018;642.6208536963214;675.7702381190419;693.1093544794915;9396.154346108746;9493.952530237304;9592.376495527767;9823.656172033945;9938.900610993798;516.4267662894184;562.9746661400247;610.4963405190647;625.1154616218;651.5211319680031;4613.331066995267;4732.432108146975;4748.857534273978;4790.496997815179;4809.879753006203;100511.49744251232;101129.49435252776;116396;119095;171620;110278;111466.44266778776;142485;143061;144279;107617;115802.26296605558;117584;117606;123347.76652233362;7443.3673137781725;7822.256885595859;9103.726888193365;9156.359054866096;9228.87327443125;56149.03478378237;56621;61190.69404652948;63618;66393;55289.72355138198;61448;62644.06033909404;64335.71328573496;71933.640331798;12812.359382030674;12899.548515801902;13207.27359995171;13217.669558261121;13753.38109785042;11772.352520611448;13620.591382258548;14342.784858226927;14507;14687.92656036713;13498.392572334073;13649.089127522353;13722.039457237897;13816.723665526833;14130.733520889984;13398.464061437433;13593.524226652415;13703.862961370258;13860.861391386361;14057.22685252321;13437.664058398619;13638.386272617954;13673.111247768864;13964.092333998664;14024.719505610035;11271.04196143337;11284.492197851281;11334;11470.483828227916;11585.957263846294;7872.56700881457;9859.950700246452;11353.659390218307;11676.649700508999;11690.532378704756 07:16:29 INFO - PROCESS | 1658 | __end_tp_report 07:16:29 INFO - PROCESS | 1658 | __start_cc_report 07:16:29 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,361 07:16:29 INFO - PROCESS | 1658 | __end_cc_report 07:16:29 INFO - PROCESS | 1658 | __startTimestamp1474726589347__endTimestamp 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | ------- Summary: start ------- 07:16:29 INFO - PROCESS | 1658 | Number of tests: 6 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5727.60 Median:5958.88 stddev:693.19 (11.6%) stddev-sans-first:658.61 07:16:29 INFO - PROCESS | 1658 | Values: 2890.3 3410.8 3428.9 3432.5 3466.8 5728.5 5738.4 5785.6 5798.6 5805.2 5622.1 5735.0 5775.3 5817.5 5820.6 4041.8 4243.6 5302.5 5315.2 5356.9 5279.3 5344.7 5367.0 5379.9 5380.9 4373.3 5307.6 5346.0 5360.7 5455.4 5347.9 5365.7 5371.8 5373.8 5373.8 5008.6 5266.6 5336.7 5343.0 5358.3 5672.9 5758.7 5794.9 5797.4 5835.3 6289.0 6309.5 6311.8 6331.3 6333.9 6224.4 6261.6 6278.2 6282.2 6318.9 5583.2 5601.4 5818.0 5837.2 5842.6 6256.2 6261.4 6316.6 6340.9 6342.8 4831.4 6201.4 6241.4 6257.4 6268.6 6153.5 6222.4 6257.2 6284.6 6300.1 4664.6 6226.5 6263.7 6264.5 6298.2 6075.3 6106.0 6176.8 6269.2 6272.0 4932.1 4954.1 4965.5 5012.1 5028.0 4397.4 4456.6 4471.8 4479.6 4512.0 5469.5 5751.9 5796.5 5849.9 5984.8 6228.2 6264.7 6273.4 6281.7 6320.8 5902.9 5913.4 5943.9 5958.9 5959.7 5325.6 5385.2 5451.5 5457.2 5465.8 6261.3 6268.1 6295.0 6311.3 6312.8 6296.6 6301.5 6307.7 6312.0 6316.7 6293.6 6337.7 6368.4 6393.7 6410.3 4463.2 6105.2 6131.0 6254.9 6256.8 5180.2 5401.0 6115.0 6270.4 6326.3 5065.9 5102.7 6212.3 6230.1 6231.1 4918.6 6043.2 6180.3 6225.6 6243.0 5371.2 5937.7 6012.6 6024.9 6140.5 6215.6 6241.1 6246.1 6261.4 6261.5 6079.2 6089.8 6102.9 6112.6 6127.1 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:70127.82 Median:40680.40 stddev:156103.53 (383.7%) stddev-sans-first:156453.81 07:16:29 INFO - PROCESS | 1658 | Values: 463.8 488.6 488.8 533.6 547.6 31830.7 42116.0 42205.4 44193.8 44357.3 43403.6 43865.6 43940.3 43972.0 44018.3 8258.5 9748.4 9947.0 9967.7 9972.8 9765.6 9766.1 9781.0 9815.0 9873.6 9815.6 9881.4 9915.2 9919.1 9930.3 9812.6 9845.4 9854.9 9868.2 9869.7 9700.7 9783.2 9788.8 9789.3 9801.0 40593.8 41082.8 41413.2 41483.4 41601.8 3312.7 3335.4 3357.8 3426.9 3432.2 31021.4 31384.2 31864.8 32522.5 32564.2 2727.8 3224.6 3225.2 3337.2 3351.1 457026.0 461722.0 462345.0 463052.0 463428.0 47288.8 60408.0 60484.1 60530.0 60651.1 28462.4 34179.7 34838.3 35831.8 36226.1 16033.6 16387.5 16586.0 16586.2 16594.4 12604.9 12659.8 12718.2 12721.7 12746.6 16543.5 19256.4 19550.8 19817.5 19837.4 7787.9 7812.5 7835.6 7895.1 7938.4 866.8 944.9 963.5 974.2 1041.3 21871.9 26117.7 26131.7 28197.4 30533.5 1050.8 1126.6 1163.1 1197.8 1215.0 14786.0 15543.3 15836.9 15846.8 16187.4 680956.0 685942.0 686080.0 686841.0 688099.0 57403.0 57942.7 58351.7 58564.7 58694.7 1321.6 1348.2 1364.1 1369.6 1370.3 25630.0 28372.9 30089.2 30166.6 30263.0 51211.0 51641.0 51684.2 51767.7 51796.0 579189.0 580107.0 580287.0 581107.0 581650.0 26324.3 26691.7 27070.0 27158.0 27207.9 47035.1 47229.0 47555.8 48618.0 48764.8 38937.8 39386.2 39502.0 39738.8 40809.8 39021.2 39063.8 39924.4 40350.8 40767.0 29163.0 38322.7 38324.6 38463.8 38713.8 31597.8 34306.0 34888.0 34915.6 35054.3 25622.6 25801.0 25897.4 26231.6 26796.0 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33136.00 Median:25286.12 stddev:91686.10 (362.6%) stddev-sans-first:91910.25 07:16:29 INFO - PROCESS | 1658 | Values: 348.3 369.6 380.0 385.4 399.7 19252.2 20308.0 20550.9 20795.0 20978.8 20008.3 20253.7 20454.7 20628.2 20693.8 5036.4 5914.9 6085.3 6130.7 6178.9 4657.7 5018.8 5760.4 5904.9 6117.9 4890.7 5127.6 5890.4 5994.3 6019.3 5871.4 5878.4 5888.1 5963.5 5969.5 5070.1 5143.8 5185.3 5211.4 5211.8 24703.5 24998.9 25573.4 25605.8 25634.6 2277.4 2280.7 2350.5 2398.0 2444.4 15427.7 15623.8 15901.6 16005.0 16486.1 1878.8 1937.6 1939.6 1948.7 1981.4 112571.0 117936.4 117981.0 118930.0 120770.8 8753.6 9379.0 10397.8 10472.8 10840.9 11192.9 13352.3 13585.8 13596.8 13626.7 8367.6 8443.0 8506.2 8583.8 8677.6 8655.7 8667.3 8671.0 8829.0 8868.4 5614.2 6538.6 6605.9 6606.9 6652.0 1583.9 1839.0 1861.7 1866.0 1866.1 886.6 925.7 969.2 1007.6 1019.5 16086.7 18051.5 20268.1 20702.3 21995.9 934.5 952.4 961.3 969.1 1039.3 11016.3 11531.6 11811.6 11820.9 11850.9 481204.0 511947.0 576940.0 577460.0 591697.0 87444.0 105019.0 110155.9 111407.0 118396.0 974.1 975.6 1005.7 1006.0 1007.8 19557.9 20238.8 20252.9 20255.9 20278.0 53759.7 54104.0 54661.0 55137.2 55334.7 77875.8 78053.6 78118.0 78805.0 79685.0 6826.1 7165.7 7220.7 7273.0 7373.4 9568.8 12748.6 12755.9 13067.9 13203.7 10953.5 10963.9 11251.9 11314.0 11329.0 9130.4 9579.9 9639.7 10966.3 11201.3 11135.2 11394.9 11401.8 11518.9 11683.9 7176.0 7206.5 7325.3 7387.6 7451.4 10612.4 11099.8 11168.3 11332.8 11476.9 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5685.33 Median:5071.98 stddev:3138.00 (61.9%) stddev-sans-first:3131.29 07:16:29 INFO - PROCESS | 1658 | Values: 1534.2 1565.4 1800.1 1856.0 1888.5 7658.8 8022.8 8256.5 8515.9 9122.7 8486.8 8812.3 8825.0 8968.0 8970.0 2389.5 2423.4 2425.5 2430.5 2439.7 2398.4 2418.5 2435.8 2438.6 2442.1 2395.6 2410.1 2420.3 2422.8 2424.1 2384.8 2389.2 2394.5 2395.9 2403.5 2380.0 2384.2 2391.9 2399.7 2403.3 7794.8 8684.6 8930.9 8955.0 9037.9 5286.2 5400.0 5439.5 5449.1 5453.5 3545.2 3674.9 3724.0 3735.6 3751.2 1060.2 1099.0 1102.6 1104.3 1115.6 10118.7 11034.0 11761.7 11847.0 11865.2 4484.1 4719.8 4786.4 4812.2 4841.1 9932.4 9961.9 9996.6 10028.4 10035.7 5343.7 5344.2 5372.9 5378.7 5390.5 4091.9 4379.5 4538.6 4717.0 4842.9 3856.6 3873.3 3942.1 3987.4 3998.6 1282.9 1294.6 1295.8 1302.2 1310.1 778.9 780.4 840.9 887.3 910.2 5736.2 5971.9 5993.4 6074.3 6102.2 957.3 962.7 966.3 991.8 1018.6 3972.5 3974.1 3983.2 4054.4 4056.4 10552.1 10916.0 10936.1 10969.5 10994.1 8963.2 9004.7 10740.3 10799.6 10928.6 6992.4 7901.8 8032.0 8248.3 8277.5 5204.7 5488.3 5681.5 5804.7 5840.0 9890.7 9984.9 10069.5 10073.8 10083.9 9864.2 10032.9 10127.9 10248.8 10273.0 6511.4 6694.3 6965.3 7133.5 7829.6 7050.8 8160.4 8310.5 8405.8 8461.1 7412.3 7555.7 7558.8 7614.4 7615.0 7279.5 7367.1 7462.0 7527.0 7549.2 6913.0 7054.8 7065.0 7069.5 7071.4 4976.3 4992.1 5106.9 5157.1 5165.5 5070.5 5073.4 5162.8 5187.5 5254.3 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4590.30 Median:5069.20 stddev:1416.12 (27.9%) stddev-sans-first:1382.97 07:16:29 INFO - PROCESS | 1658 | Values: 299.0 303.2 306.3 314.1 315.4 5062.0 5231.3 5364.9 5439.6 5468.0 4410.4 5144.2 5290.4 5331.5 5345.1 3492.3 3822.4 4059.3 4108.3 4121.6 3576.4 3961.6 4109.4 4122.8 4135.2 3594.2 3822.9 4053.9 4088.4 4124.5 4068.1 4093.3 4095.2 4106.2 4119.8 3013.9 3549.1 3586.2 3604.8 3626.9 4405.6 4619.4 4805.3 5038.9 5171.9 3858.9 3918.4 4702.7 4724.6 4736.1 4617.2 5602.8 5636.9 5670.0 5679.7 3294.5 3308.9 3717.1 3983.5 4033.6 4664.6 5216.6 5859.8 6006.5 6027.9 4049.5 4100.0 4104.7 4109.9 4120.8 3800.6 4003.1 4130.5 4149.8 4180.4 4489.5 4718.8 4759.5 4792.0 4804.3 5240.7 5766.9 5767.9 5784.3 5786.5 1115.9 1180.5 1374.8 1389.7 1399.8 944.0 955.6 975.1 978.7 979.8 4857.9 5282.3 5327.4 5370.5 5371.5 5272.8 5336.5 5766.9 5815.0 5839.8 4544.4 5112.6 5278.2 5327.2 5330.7 2990.7 3069.2 3127.5 3136.6 3144.1 5145.7 6028.8 6132.9 6147.3 6184.8 5498.4 5789.2 6087.8 6118.4 6124.8 6083.8 6104.7 6135.7 6171.9 6188.9 4789.6 5658.6 5794.8 5889.4 5920.0 4830.6 4836.7 5863.6 5886.2 5887.2 4825.9 6111.6 6125.3 6134.5 6135.4 3599.5 3744.6 3860.1 3893.5 3945.9 4960.9 5633.7 5866.5 5899.0 5912.5 4817.0 5120.6 5358.0 5690.7 5808.4 5041.9 5076.4 5780.9 5808.1 5813.7 4753.9 5418.9 5428.3 5580.8 5631.7 4841.3 4977.7 5745.8 5781.0 5796.3 4657.7 5255.6 5569.2 5655.5 5656.7 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24016.66 Median:3494.96 stddev:38637.02 (1105.5%) stddev-sans-first:38705.78 07:16:29 INFO - PROCESS | 1658 | Values: 712.9 769.0 798.0 802.2 810.4 15519.8 16143.4 16148.2 16237.9 16271.0 14404.3 14547.3 14563.3 14569.0 14590.6 664.5 695.1 817.6 845.4 860.9 841.7 859.8 875.4 875.4 878.5 912.2 925.0 925.7 927.0 934.2 904.3 915.2 916.8 919.7 923.5 559.3 680.6 685.0 685.1 686.3 14404.4 14831.9 14838.5 14845.3 14861.9 14387.4 14406.1 14429.4 14435.4 14595.6 10921.7 11423.1 11688.2 11696.2 11987.3 3262.5 3824.1 3836.0 3840.4 3957.8 127838.4 128862.0 130763.3 132820.0 134462.0 10325.5 10431.6 10583.3 10753.5 10809.7 16912.3 20522.4 20735.5 20785.0 20812.9 7754.8 7831.5 7891.8 7953.5 7993.5 4396.5 4399.5 4460.0 4463.7 4553.3 3385.6 3479.9 3510.1 3511.3 3522.6 629.5 632.7 661.8 666.9 669.1 577.4 599.2 642.6 675.8 693.1 9396.2 9494.0 9592.4 9823.7 9938.9 516.4 563.0 610.5 625.1 651.5 4613.3 4732.4 4748.9 4790.5 4809.9 100511.5 101129.5 116396.0 119095.0 171620.0 110278.0 111466.4 142485.0 143061.0 144279.0 107617.0 115802.3 117584.0 117606.0 123347.8 7443.4 7822.3 9103.7 9156.4 9228.9 56149.0 56621.0 61190.7 63618.0 66393.0 55289.7 61448.0 62644.1 64335.7 71933.6 12812.4 12899.5 13207.3 13217.7 13753.4 11772.4 13620.6 14342.8 14507.0 14687.9 13498.4 13649.1 13722.0 13816.7 14130.7 13398.5 13593.5 13703.9 13860.9 14057.2 13437.7 13638.4 13673.1 13964.1 14024.7 11271.0 11284.5 11334.0 11470.5 11586.0 7872.6 9860.0 11353.7 11676.6 11690.5 07:16:29 INFO - PROCESS | 1658 | -------- Summary: end -------- 07:16:29 INFO - PROCESS | 1658 | 07:16:29 INFO - TEST-INFO | 1658: exit 0 07:16:30 INFO - TEST-OK | dromaeo_css | took 1113680ms 07:16:30 INFO - TEST-START | kraken 07:16:30 INFO - operating with platform_type : mac_ 07:16:30 INFO - Initialising browser for kraken test... 07:16:30 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpel5YqV/profile http://localhost:49277/getInfo.html) 07:16:32 INFO - PROCESS | 1665 | 2016-09-24 07:16:32.647 plugin-container[1666:10575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a23, name = 'com.apple.tsm.portname' 07:16:32 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:16:32 INFO - PROCESS | 1665 | 2016-09-24 07:16:32.650 plugin-container[1666:10575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 07:16:32 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:16:32 INFO - PROCESS | 1665 | 2016-09-24 07:16:32.650 plugin-container[1666:10575] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:16:32 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 07:16:32 INFO - PROCESS | 1665 | colorDepth:24 07:16:32 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 07:16:32 INFO - PROCESS | 1665 | __metrics 07:16:32 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:16:33 INFO - TEST-INFO | 1665: exit 0 07:16:33 INFO - Browser initialized. 07:16:33 INFO - Running cycle 1/1 for kraken test... 07:16:33 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpel5YqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:35 INFO - PROCESS | 1667 | 2016-09-24 07:16:35.928 plugin-container[1668:10683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.tsm.portname' 07:16:35 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:16:35 INFO - PROCESS | 1667 | 2016-09-24 07:16:35.931 plugin-container[1668:10683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 07:16:35 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:16:35 INFO - PROCESS | 1667 | 2016-09-24 07:16:35.931 plugin-container[1668:10683] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:16:45 INFO - PROCESS | 1667 | RSS: Main: 239587328 07:16:45 INFO - PROCESS | 1667 | 07:16:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:49 INFO - PROCESS | 1667 | RSS: Main: 253374464 07:16:49 INFO - PROCESS | 1667 | 07:16:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 07:16:52 INFO - PROCESS | 1667 | RSS: Main: 261734400 07:16:52 INFO - PROCESS | 1667 | 07:16:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 07:16:56 INFO - PROCESS | 1667 | RSS: Main: 262053888 07:16:56 INFO - PROCESS | 1667 | 07:16:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 07:16:59 INFO - PROCESS | 1667 | RSS: Main: 263147520 07:16:59 INFO - PROCESS | 1667 | 07:17:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:01 INFO - PROCESS | 1667 | RSS: Main: 263217152 07:17:01 INFO - PROCESS | 1667 | 07:17:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:05 INFO - PROCESS | 1667 | RSS: Main: 264036352 07:17:05 INFO - PROCESS | 1667 | 07:17:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:09 INFO - PROCESS | 1667 | RSS: Main: 265293824 07:17:09 INFO - PROCESS | 1667 | 07:17:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 07:17:13 INFO - PROCESS | 1667 | RSS: Main: 265547776 07:17:13 INFO - PROCESS | 1667 | 07:17:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:15 INFO - PROCESS | 1667 | RSS: Main: 265310208 07:17:15 INFO - PROCESS | 1667 | 07:17:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:17 INFO - PROCESS | 1667 | RSS: Main: 265261056 07:17:17 INFO - PROCESS | 1667 | 07:17:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:20 INFO - PROCESS | 1667 | RSS: Main: 265326592 07:17:20 INFO - PROCESS | 1667 | 07:17:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:24 INFO - PROCESS | 1667 | RSS: Main: 265703424 07:17:24 INFO - PROCESS | 1667 | 07:17:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:27 INFO - PROCESS | 1667 | RSS: Main: 265543680 07:17:27 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 07:17:29 INFO - PROCESS | 1667 | RSS: Main: 266850304 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | __start_tp_report 07:17:29 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 07:17:29 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 07:17:29 INFO - PROCESS | 1667 | |i|pagename|runs| 07:17:29 INFO - PROCESS | 1667 | |0;ai-astar;115;115;114;114;117;116;114;115;114;127 07:17:29 INFO - PROCESS | 1667 | |1;audio-beat-detection;147;129;125;146;133;109;108;110;161;140 07:17:29 INFO - PROCESS | 1667 | |2;audio-dft;189;211;246;299;198;199;194;209;226;251 07:17:29 INFO - PROCESS | 1667 | |3;audio-fft;82;58;60;81;52;73;52;72;67;72 07:17:29 INFO - PROCESS | 1667 | |4;audio-oscillator;92;73;87;63;61;95;124;71;71;88 07:17:29 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;88;100;88;85;133;131;89;102;88;86 07:17:29 INFO - PROCESS | 1667 | |6;imaging-darkroom;156;96;97;135;110;153;113;109;155;126 07:17:29 INFO - PROCESS | 1667 | |7;imaging-desaturate;146;147;140;92;143;150;76;149;144;128 07:17:29 INFO - PROCESS | 1667 | |8;json-parse-financial;58;58;57;57;59;58;59;58;58;56 07:17:29 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;69;71;64;74;98;111;103;97;68;69 07:17:29 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;91;101;80;95;113;108;110;87;89;88 07:17:29 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;136;140;139;137;140;139;141;141;187;164 07:17:29 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;203;242;188;175;171;174;176;173;175;176 07:17:29 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;69;68;70;72;66;69;69;68;69 07:17:29 INFO - PROCESS | 1667 | __end_tp_report 07:17:29 INFO - PROCESS | 1667 | __start_cc_report 07:17:29 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,912 07:17:29 INFO - PROCESS | 1667 | __end_cc_report 07:17:29 INFO - PROCESS | 1667 | __startTimestamp1474726649933__endTimestamp 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | ------- Summary: start ------- 07:17:29 INFO - PROCESS | 1667 | Number of tests: 14 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:116.10 Median:115.00 stddev:3.96 (3.4%) stddev-sans-first:4.18 07:17:29 INFO - PROCESS | 1667 | Values: 115.0 115.0 114.0 114.0 117.0 116.0 114.0 115.0 114.0 127.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:136.50 stddev:18.13 (13.3%) stddev-sans-first:18.26 07:17:29 INFO - PROCESS | 1667 | Values: 147.0 129.0 125.0 146.0 133.0 109.0 108.0 110.0 161.0 140.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:222.20 Median:218.50 stddev:34.37 (15.7%) stddev-sans-first:34.29 07:17:29 INFO - PROCESS | 1667 | Values: 189.0 211.0 246.0 299.0 198.0 199.0 194.0 209.0 226.0 251.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:66.90 Median:72.00 stddev:10.99 (15.3%) stddev-sans-first:10.21 07:17:29 INFO - PROCESS | 1667 | Values: 82.0 58.0 60.0 81.0 52.0 73.0 52.0 72.0 67.0 72.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:80.00 stddev:18.90 (23.6%) stddev-sans-first:19.74 07:17:29 INFO - PROCESS | 1667 | Values: 92.0 73.0 87.0 63.0 61.0 95.0 124.0 71.0 71.0 88.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:87.00 stddev:18.31 (21.0%) stddev-sans-first:18.99 07:17:29 INFO - PROCESS | 1667 | Values: 88.0 100.0 88.0 85.0 133.0 131.0 89.0 102.0 88.0 86.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:125.00 Median:154.00 stddev:23.56 (15.3%) stddev-sans-first:22.16 07:17:29 INFO - PROCESS | 1667 | Values: 156.0 96.0 97.0 135.0 110.0 153.0 113.0 109.0 155.0 126.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:131.50 Median:148.00 stddev:26.06 (17.6%) stddev-sans-first:27.11 07:17:29 INFO - PROCESS | 1667 | Values: 146.0 147.0 140.0 92.0 143.0 150.0 76.0 149.0 144.0 128.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 07:17:29 INFO - PROCESS | 1667 | Values: 58.0 58.0 57.0 57.0 59.0 58.0 59.0 58.0 58.0 56.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:82.40 Median:70.00 stddev:17.65 (25.2%) stddev-sans-first:18.04 07:17:29 INFO - PROCESS | 1667 | Values: 69.0 71.0 64.0 74.0 98.0 111.0 103.0 97.0 68.0 69.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:87.50 stddev:11.20 (12.8%) stddev-sans-first:11.72 07:17:29 INFO - PROCESS | 1667 | Values: 91.0 101.0 80.0 95.0 113.0 108.0 110.0 87.0 89.0 88.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:140.50 stddev:16.34 (11.6%) stddev-sans-first:16.90 07:17:29 INFO - PROCESS | 1667 | Values: 136.0 140.0 139.0 137.0 140.0 139.0 141.0 141.0 187.0 164.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.30 Median:176.00 stddev:22.12 (12.6%) stddev-sans-first:22.52 07:17:29 INFO - PROCESS | 1667 | Values: 203.0 242.0 188.0 175.0 171.0 174.0 176.0 173.0 175.0 176.0 07:17:29 INFO - PROCESS | 1667 | 07:17:29 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.62 07:17:29 INFO - PROCESS | 1667 | Values: 67.0 69.0 68.0 70.0 72.0 66.0 69.0 69.0 68.0 69.0 07:17:29 INFO - PROCESS | 1667 | -------- Summary: end -------- 07:17:29 INFO - PROCESS | 1667 | 07:17:30 INFO - TEST-INFO | 1667: exit 0 07:17:30 INFO - TEST-OK | kraken | took 60765ms 07:17:30 INFO - SUITE-END | took 1174s 07:17:31 INFO - Completed test suite (00:19:34) 07:17:31 INFO - javascript benchmark 07:17:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.034307322922, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2890.2918784897697, 3410.8294585270714, 3428.8799892003785, 3432.467967465044, 3466.774659647123, 5728.484436400723, 5738.3974682658345, 5785.623934444268, 5798.623089499185, 5805.187273781674, 5622.100463925773, 5735.0, 5775.306963164426, 5817.505512031483, 5820.563457740675, 4041.8383264669524, 4243.618074373298, 5302.522772950434, 5315.202719592054, 5356.892862142755, 5279.313689220396, 5344.706041167754, 5366.973165134188, 5379.892402151954, 5380.892382152355, 4373.278409062501, 5307.601929855257, 5346.0, 5360.731963401834, 5455.427180146087, 5347.919781203265, 5365.651232669864, 5371.785128594852, 5373.75818088183, 5373.785048598091, 5008.5993120550265, 5266.631335806495, 5336.706481143536, 5343.0, 5358.303420555303, 5672.914906276409, 5758.712064396764, 5794.855128621818, 5797.391273916221, 5835.270591176103, 6288.968555157241, 6309.495240380805, 6311.842203944892, 6331.271903731038, 6333.87332253357, 6224.377562243784, 6261.557992382975, 6278.183836101323, 6282.2461304643275, 6318.873622527523, 5583.162525621189, 5601.411851755588, 5818.0, 5837.211976383176, 5842.649441033552, 6256.217972753406, 6261.436470717657, 6316.557840951181, 6340.936590634127, 6342.8414289642205, 4831.4202295724735, 6201.387639213837, 6241.438270555672, 6257.374262573706, 6268.592541484789, 6153.538484613672, 6222.377762223741, 6257.217847769029, 6284.622922624566, 6300.1494798202575, 4664.603508701798, 6226.470749986302, 6263.655498947511, 6264.498840092781, 6298.181236439325, 6075.33171351151, 6106.005662907935, 6176.752929882844, 6269.216347956505, 6271.96864015677, 4932.136876046678, 4954.133026720309, 4965.528274813887, 5012.147934851084, 5028.019536190408, 4397.384366188736, 4456.554344565518, 4471.754053527022, 4479.552044795494, 4512.007358381151, 5469.480399362054, 5751.8562035949435, 5796.478316951495, 5849.912251316234, 5984.760609575568, 6228.190335256479, 6264.749410023639, 6273.404026617555, 6281.685915704196, 6320.841978950563, 5902.8819423611285, 5913.379095194942, 5943.940560594338, 5958.880822383528, 5959.67221802805, 5325.627206095536, 5385.219143224211, 5451.509364157245, 5457.2359869618285, 5465.836024919259, 6261.311255761862, 6268.059791031382, 6294.968525157528, 6311.274203466568, 6312.779052733133, 6296.590721603081, 6301.495880329471, 6307.7476900925285, 6312.0, 6316.747330106744, 6293.622382657055, 6337.65142917144, 6368.42684158428, 6393.680315984089, 6410.326915673787, 4463.241248987615, 6105.186826067751, 6130.969345153246, 6254.937450625435, 6256.7810126645345, 5180.197069454241, 5400.972995134999, 6115.027386288435, 6270.372962703693, 6326.335734747785, 5065.898682026413, 5102.668326558762, 6212.347703491249, 6230.096635987847, 6231.065340198825, 4918.631102667386, 6043.184170136975, 6180.289266734203, 6225.564210505221, 6242.968785156045, 5371.194320851903, 5937.673427961331, 6012.579119461596, 6024.90962635552, 6140.473573783631, 6215.627062376272, 6241.063840423973, 6246.1255424239735, 6261.436470717657, 6261.530385221035, 6079.240094988127, 6089.817305480843, 6102.938970610237, 6112.572119951561, 6127.080937859357], "value": 5686.211986463403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.76348062488125, 488.6262009562685, 488.77516342482454, 533.6371267538075, 547.6330858324922, 31830.68169318306, 42116.0, 42205.366919496155, 44193.77903110488, 44357.33463998043, 43403.56596434035, 43865.61343865612, 43940.340894886605, 43972.0, 44018.33972490415, 8258.504489730636, 9748.366356186843, 9946.950265248664, 9967.651132210374, 9972.750681232954, 9765.560549775277, 9766.121049105579, 9781.021897810198, 9814.950925245364, 9873.605055797796, 9815.607375704963, 9881.35771174875, 9915.157211637019, 9919.107280344768, 9930.304878658497, 9812.607495700164, 9845.360051596695, 9854.90145098547, 9868.161206297473, 9869.654562090293, 9700.708978730649, 9783.168430683401, 9788.804223915553, 9789.265805064577, 9801.0, 40593.797031014954, 41082.79458602718, 41413.171736565404, 41483.377749333784, 41601.791991040154, 3312.734981201498, 3335.3662804067394, 3357.8488967996254, 3426.9485957710654, 3432.1591210153424, 31021.379572408652, 31384.21539461509, 31864.840675796706, 32522.512162317584, 32564.18589535257, 2727.754502094821, 3224.580804495424, 3225.161458020908, 3337.2324365395853, 3351.111955331839, 457026.0, 461722.0, 462345.0, 463052.0, 463427.9999999966, 47288.763556182, 60408.0, 60484.09273860895, 60530.0, 60651.09023364653, 28462.43075138527, 34179.65820341815, 34838.30323393569, 35831.82084089563, 36226.094347640996, 16033.599160021093, 16387.508374748777, 16586.0, 16586.170691465377, 16594.419195328104, 12604.928581070712, 12659.810102848465, 12718.236905785498, 12721.745565088646, 12746.553870614483, 16543.503694888932, 19256.422307330802, 19550.804491955183, 19817.504562386057, 19837.40487785369, 7787.883181752279, 7812.492188007761, 7835.608219588998, 7895.131535531087, 7938.364930805522, 866.7789713623112, 944.9196818270386, 963.5037955452947, 974.1914211204684, 1041.317936751429, 21871.890640546695, 26117.73882261153, 26131.693415329537, 28197.43605127886, 30533.541996870066, 1050.7898420315967, 1126.594426006637, 1163.0985985860857, 1197.820326950947, 1215.0, 14785.96498245134, 15543.290238073803, 15836.920815396079, 15846.76229856553, 16187.433439829549, 680956.0, 685942.0, 686080.0, 686841.0, 688099.0, 57403.0, 57942.710286448295, 58351.708241458524, 58564.7071764647, 58694.7065264671, 1321.5903070048123, 1348.1506650809927, 1364.1474078700812, 1369.6165073779557, 1370.2737549098993, 25630.02734576144, 28372.85813570919, 30089.247768805955, 30166.619402280056, 30263.0, 51211.0, 51640.967180655425, 51684.22473662973, 51767.741161293954, 51795.96408071893, 579189.0, 580107.0, 580287.0, 581107.0, 581650.0, 26324.341891452867, 26691.733082668925, 27070.0, 27158.0, 27207.91168353244, 47035.05929881315, 47229.0, 47555.76222118867, 48618.0, 48764.75617622031, 38937.805310973265, 39386.2122757549, 39502.01244968784, 39738.801305993285, 40809.79595102005, 39021.2195756089, 39063.80468097641, 39924.401133982436, 40350.798246008584, 40767.0, 29163.0, 38322.65870694512, 38324.6167538321, 38463.84608461751, 38713.80643096879, 31597.84201079072, 34306.0, 34887.953361399195, 34915.60337586468, 35054.29891402209, 25622.615660765478, 25800.967961281338, 25897.352566185997, 26231.606525901745, 26796.0], "value": 19776.007200664884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2947032259674, 369.61929212910695, 379.9848006079758, 385.44495925866767, 399.73217943977534, 19252.17192387451, 20308.0, 20550.89724551379, 20794.960251987417, 20978.790212097876, 20008.29970951017, 20253.696194557095, 20454.69317960228, 20628.17487300506, 20693.793062069373, 5036.4208116066575, 5914.88170236595, 6085.2961170872, 6130.724117414727, 6178.938210617904, 4657.673962822604, 5018.7992480300745, 5760.366359700451, 5904.940950590482, 6117.877642447148, 4890.73100979446, 5127.564157046637, 5890.410958904118, 5994.34062253154, 6019.337872833985, 5871.354151043424, 5878.353381128072, 5888.116782482619, 5963.463288304073, 5969.522438204955, 5070.138076526962, 5143.794248230066, 5185.325907632021, 5211.374635043781, 5211.791528338862, 24703.505929881303, 24998.875005625036, 25573.360665983313, 25605.847736851887, 25634.615480767803, 2277.3851060213815, 2280.6579013147993, 2350.5416443793465, 2397.976020239793, 2444.364465239033, 15427.691446171013, 15623.765643515357, 15901.602459938478, 16005.0, 16486.093264870426, 1878.7557617509774, 1937.5737337785665, 1939.6120775844888, 1948.6882098864114, 1981.4055783265107, 112571.0, 117936.41031794871, 117981.0, 118929.99999999914, 120770.7922920777, 8753.60608772594, 9379.0, 10397.84403233952, 10472.842907356397, 10840.945795270973, 11192.944035279772, 13352.265625390697, 13585.796213056614, 13596.796048059286, 13626.727465450636, 8367.58162091905, 8442.957785211034, 8506.234438900528, 8583.785405364792, 8677.609507572048, 8655.740327790176, 8667.306615470747, 8671.046184919654, 8829.028806831244, 8868.423552469068, 5614.214010038598, 6538.640374779433, 6605.867882642417, 6606.933930660728, 6651.966740166268, 1583.89127610673, 1839.0345068838699, 1861.702127659568, 1865.990670046641, 1866.1229222265513, 886.6497733395273, 925.7407925780792, 969.1810420195065, 1007.5919252702668, 1019.4902548725637, 16086.713062954936, 18051.458456246335, 20268.08793604262, 20702.275420360515, 21995.90020499001, 934.528063328015, 952.4190243951184, 961.2646325560952, 969.1277849934974, 1039.3140527251978, 11016.339019658846, 11531.596394126165, 11811.586594469152, 11820.940895295469, 11850.881491184979, 481204.0, 511947.0, 576940.0, 577460.0, 591697.0415147983, 87444.0, 105019.0, 110155.89844101456, 111407.0, 118396.0, 974.0503009565758, 975.6292608808608, 1005.6982905128432, 1005.9798804023878, 1007.7984403119259, 19557.924314162858, 20238.797612024282, 20252.925162619256, 20255.898720506302, 20278.0, 53759.73120134374, 54104.0, 54661.0, 55137.1729424067, 55334.72332638472, 77875.83186252098, 78053.60973195097, 78118.0, 78805.0, 79685.0, 6826.146731658543, 7165.677544510405, 7220.711171553079, 7273.0, 7373.446991475554, 9568.808623827623, 12748.61754147377, 12755.93622031884, 13067.869321306665, 13203.735925281248, 10953.45232738344, 10963.945180274048, 11251.943740281245, 11314.03830674402, 11328.980391764451, 9130.360874738704, 9579.85041794989, 9639.71080867575, 10966.342019478856, 11201.32792032448, 11135.220534562503, 11394.886051139714, 11401.828972565583, 11518.884811152117, 11683.948444640024, 7176.0, 7206.495545311778, 7325.304096110861, 7387.593682347308, 7451.44114191427, 10612.363258204532, 11099.833502497308, 11168.274062185932, 11332.773344533229, 11476.885231147582], "value": 9566.711231976458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.1868809530947, 1565.428618554228, 1800.1269384348589, 1856.0441372693058, 1888.4806678163495, 7658.770236892895, 8022.839543209132, 8256.50460972342, 8515.91484085159, 9122.726318210447, 8486.830263394728, 8812.250958668521, 8825.02924678285, 8967.955160224206, 8970.013298537157, 2389.4623709665316, 2423.3820375804144, 2425.4785221177444, 2430.5260474207535, 2439.694763301634, 2398.448356877919, 2418.5283869645336, 2435.8173137014705, 2438.622013587888, 2442.096424323003, 2395.6047252203452, 2410.0721222329444, 2420.3102115896972, 2422.7577242275806, 2424.054618698709, 2384.833061685683, 2389.23544465771, 2394.545036443079, 2395.8921848516857, 2403.4592216751266, 2379.976200237993, 2384.1893756122827, 2391.868447235401, 2399.652050452692, 2403.327068420845, 7794.844103117905, 8684.565771711452, 8930.86603700945, 8955.014948355676, 9037.909620903773, 5286.180642000496, 5400.027994960906, 5439.5104440600535, 5449.100898351767, 5453.509184173404, 3545.166885781839, 3674.9448758268645, 3723.957291958229, 3735.62643735627, 3751.174741556853, 1060.204846365226, 1099.0328510910347, 1102.608573956242, 1104.276698762312, 1115.5928086248541, 10118.696439106765, 11033.951774581483, 11761.705957351049, 11847.0, 11865.169438139334, 4484.148011877733, 4719.764011799465, 4786.425628924481, 4812.157872372391, 4841.1285968526, 9932.354396964174, 9961.900380996241, 9996.550155243032, 10028.448435336126, 10035.69892903214, 5343.6526625769975, 5344.171653393731, 5372.91940620891, 5378.731063446812, 5390.4879036491475, 4091.9386209206887, 4379.5182529921685, 4538.614217791459, 4717.0, 4842.878928026757, 3856.59505751892, 3873.341531939577, 3942.1327307992196, 3987.441758153861, 3998.5601583825755, 1282.910196286251, 1294.6245588779336, 1295.7667619828333, 1302.1666133674455, 1310.0502135951358, 778.8948491953627, 780.4146889832625, 840.8612578924532, 887.3389324952951, 910.1899309614448, 5736.196932429463, 5971.940280597139, 5993.441705156691, 6074.299196225064, 6102.237220347457, 957.3107362698846, 962.6967505235829, 966.2511553546058, 991.8264303746815, 1018.6434747838198, 3972.503437070366, 3974.125692347679, 3983.2232714620372, 4054.3715724062818, 4056.4320995060716, 10552.103071238877, 10916.0, 10936.12510999134, 10969.506372213269, 10994.065504432054, 8963.193312601898, 9004.684836030707, 10740.30188037775, 10799.622013229498, 10928.617498387519, 6992.405645520086, 7901.762947111596, 8031.9960004999375, 8248.257656810916, 8277.54473503951, 5204.687718736888, 5488.286522752017, 5681.488666020078, 5804.738786754522, 5840.0, 9890.653827116017, 9984.850227246743, 10069.496525173565, 10073.798524029626, 10083.949580252052, 9864.161546268648, 10032.949835250776, 10127.949360253151, 10248.795024099327, 10273.0, 6511.413972742476, 6694.263631000684, 6965.303469652994, 7133.536320139175, 7829.569373684502, 7050.823729406806, 8160.387970902088, 8310.54292013945, 8405.789855253668, 8461.069282379056, 7412.258774122544, 7555.659995300115, 7558.848823023399, 7614.352780013761, 7615.010048693634, 7279.490435669452, 7367.115946086289, 7461.962690186514, 7527.021487206628, 7549.245075492407, 6913.0, 7054.753083642048, 7064.964675176591, 7069.505134640526, 7071.43428525727, 4976.32819569368, 4992.126377883928, 5106.923396149135, 5157.123289040947, 5165.457626949266, 5070.518300761421, 5073.441921388718, 5162.8193013245855, 5187.481251874782, 5254.31861804219], "value": 4601.900374470127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.96113505244324, 303.18896950657, 306.2634364353729, 314.053129813612, 315.41962788469243, 5061.9622977289655, 5231.346081739783, 5364.900195459931, 5439.5585169929955, 5468.0, 4410.382546443492, 5144.228365745131, 5290.444503327153, 5331.480528049497, 5345.113638635142, 3492.3364560733507, 3822.44574536692, 4059.2693315203323, 4108.342665173573, 4121.649659778923, 3576.3727503985624, 3961.564227934925, 4109.4246805447265, 4122.793860306988, 4135.172965406916, 3594.245208506217, 3822.8853134406013, 4053.898652533681, 4088.3867419886956, 4124.52567954686, 4068.125353049079, 4093.304138296482, 4095.24238015968, 4106.240345536085, 4119.7940102994735, 3013.8794448222043, 3549.112721819545, 3586.246888153491, 3604.8197590120653, 3626.909327266813, 4405.603495685404, 4619.445666520039, 4805.279208118775, 5038.924416133761, 5171.948280517185, 3858.9228215435533, 3918.431827385013, 4702.741349225791, 4724.551167639069, 4736.052789442126, 4617.2381557043045, 5602.81490218815, 5636.859078523029, 5669.971650141764, 5679.744411501492, 3294.5058241263764, 3308.8511017004294, 3717.1228529592654, 3983.546005707925, 4033.596640335972, 4664.623935938872, 5216.556592689626, 5859.794907178229, 6006.5495087868585, 6027.9095813562835, 4049.493813273341, 4099.959000410017, 4104.712670113123, 4109.91780164401, 4120.793960301973, 3800.600936901641, 4003.07852230925, 4130.483689538808, 4149.792510374529, 4180.393842892763, 4489.528599497071, 4718.834840780556, 4759.547842954914, 4791.981051937257, 4804.25534042224, 5240.68555886648, 5766.913496297559, 5767.942320576824, 5784.334801497797, 5786.482879947236, 1115.8828323026128, 1180.4746887635092, 1374.752544541992, 1389.715108402775, 1399.825021872266, 943.9952800235955, 955.574769227687, 975.1467465967279, 978.7472035794195, 979.774651830083, 4857.878553036202, 5282.286891269706, 5327.360716713942, 5370.543503802142, 5371.529096615601, 5272.815451459181, 5336.532453575221, 5766.913496297559, 5815.04051831443, 5839.766409343579, 4544.363789069533, 5112.6001209195465, 5278.208268759717, 5327.200919862052, 5330.706811125426, 2990.743887567227, 3069.2020074780717, 3127.5308703694172, 3136.5765621640785, 3144.135362775209, 5145.716985565829, 6028.788992385334, 6132.877342453126, 6147.264467312003, 6184.81445556625, 5498.422665620133, 5789.247397838339, 6087.8478038048515, 6118.388161183935, 6124.755009799558, 6083.8174854754425, 6104.725287362079, 6135.693215339215, 6171.876562468815, 6188.938110618927, 4789.592884604708, 5658.575606829587, 5794.82615521535, 5889.440503152194, 5919.970400147971, 4830.637702172421, 4836.709797412166, 5863.560232982458, 5886.175935369138, 5887.234659494238, 4825.914169312017, 6111.572189946839, 6125.264968203844, 6134.533988296598, 6135.447809697149, 3599.532060832075, 3744.6255374463426, 3860.1278379986247, 3893.532776066777, 3945.9408108877815, 4960.883801144713, 5633.746481408264, 5866.472017518444, 5898.970505147447, 5912.487192943068, 4816.975915120402, 5120.641555091108, 5358.0355536002335, 5690.743916523849, 5808.419158084158, 5041.941192349647, 5076.441591425014, 5780.855478613068, 5808.128780682931, 5813.680247586423, 4753.9049219016115, 5418.864528386822, 5428.267183930119, 5580.832575022756, 5631.746571404215, 4841.273808928689, 4977.651564390458, 5745.845308009497, 5780.959427303126, 5796.333421656564, 4657.69724967876, 5255.63210575256, 5569.220309156803, 5655.462731040545, 5656.6706823897175], "value": 4144.5861367541265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.8503014366983, 768.953862768234, 798.0, 802.1668407995917, 810.3719617296596, 15519.84480155198, 16143.43497977571, 16148.192590370492, 16237.944533605307, 16271.0, 14404.279786010684, 14547.345369458373, 14563.271836408163, 14569.0, 14590.635234119125, 664.5182242873926, 695.1206723494784, 817.6443247187462, 845.4124383553433, 860.8923884514436, 841.6759547574197, 859.7807559072428, 875.4353442029887, 875.4397185801092, 878.4904755241944, 912.1835956818677, 925.0425809287389, 925.6898938855492, 927.0081013315755, 934.1639232886563, 904.267543289934, 915.199200699388, 916.7662246127228, 919.7378747057123, 923.4966943016038, 559.3036669346649, 680.6358598149966, 685.0204207982583, 685.1127789512593, 686.3171144711044, 14404.351804168733, 14831.851681483264, 14838.480653177086, 14845.331960061716, 14861.851381486264, 14387.424503019867, 14406.135631862122, 14429.422823087063, 14435.35040923161, 14595.635109122251, 10921.672349829518, 11423.143264255214, 11688.240264382788, 11696.18126731129, 11987.34069626179, 3262.5432439458496, 3824.0631045394057, 3835.9808200959096, 3840.423936409533, 3957.8021098944937, 127838.36080819536, 128862.0, 130763.34618326847, 132820.0, 134462.0, 10325.48372581368, 10431.582736690447, 10583.31208471447, 10753.46232688378, 10809.67570972872, 16912.32350705958, 20522.38432847017, 20735.481612959797, 20785.0, 20812.895935520224, 7754.7673569793, 7831.451798374173, 7891.842163156704, 7953.483023603448, 7993.480423772437, 4396.472423309159, 4399.450688374706, 4460.018795864905, 4463.709858859163, 4553.2942393929, 3385.610654774732, 3479.860805567749, 3510.052285882797, 3511.2626348466597, 3522.5772907251294, 629.4869681209799, 632.7121159872247, 661.7882277671099, 666.8796422011068, 669.1234482827512, 577.4398833131855, 599.1791245993018, 642.6208536963214, 675.7702381190419, 693.1093544794915, 9396.154346108746, 9493.952530237304, 9592.376495527767, 9823.656172033945, 9938.900610993798, 516.4267662894184, 562.9746661400247, 610.4963405190647, 625.1154616218, 651.5211319680031, 4613.331066995267, 4732.432108146975, 4748.857534273978, 4790.496997815179, 4809.879753006203, 100511.49744251232, 101129.49435252776, 116396.0, 119095.0, 171620.0, 110278.0, 111466.44266778776, 142485.0, 143061.0, 144279.0, 107617.0, 115802.26296605558, 117584.0, 117606.0, 123347.76652233362, 7443.3673137781725, 7822.256885595859, 9103.726888193365, 9156.359054866096, 9228.87327443125, 56149.03478378237, 56621.0, 61190.69404652948, 63618.0, 66393.0, 55289.72355138198, 61448.0, 62644.06033909404, 64335.71328573496, 71933.640331798, 12812.359382030674, 12899.548515801902, 13207.27359995171, 13217.669558261121, 13753.38109785042, 11772.352520611448, 13620.591382258548, 14342.784858226927, 14507.0, 14687.92656036713, 13498.392572334073, 13649.089127522353, 13722.039457237897, 13816.723665526833, 14130.733520889984, 13398.464061437433, 13593.524226652415, 13703.862961370258, 13860.861391386361, 14057.22685252321, 13437.664058398619, 13638.386272617954, 13673.111247768864, 13964.092333998664, 14024.719505610035, 11271.04196143337, 11284.492197851281, 11334.0, 11470.483828227916, 11585.957263846294, 7872.56700881457, 9859.950700246452, 11353.659390218307, 11676.649700508999, 11690.532378704756], "value": 7702.149801884078, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1610.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 117.0, 116.0, 114.0, 115.0, 114.0, 127.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 125.0, 146.0, 133.0, 109.0, 108.0, 110.0, 161.0, 140.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 211.0, 246.0, 299.0, 198.0, 199.0, 194.0, 209.0, 226.0, 251.0], "value": 222.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 81.0, 52.0, 73.0, 52.0, 72.0, 67.0, 72.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 87.0, 63.0, 61.0, 95.0, 124.0, 71.0, 71.0, 88.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 100.0, 88.0, 85.0, 133.0, 131.0, 89.0, 102.0, 88.0, 86.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 96.0, 97.0, 135.0, 110.0, 153.0, 113.0, 109.0, 155.0, 126.0], "value": 125.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 140.0, 92.0, 143.0, 150.0, 76.0, 149.0, 144.0, 128.0], "value": 131.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 59.0, 58.0, 59.0, 58.0, 58.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 64.0, 74.0, 98.0, 111.0, 103.0, 97.0, 68.0, 69.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 101.0, 80.0, 95.0, 113.0, 108.0, 110.0, 87.0, 89.0, 88.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 139.0, 137.0, 140.0, 139.0, 141.0, 141.0, 187.0, 164.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 242.0, 188.0, 175.0, 171.0, 174.0, 176.0, 173.0, 175.0, 176.0], "value": 185.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 70.0, 72.0, 66.0, 69.0, 69.0, 68.0, 69.0], "value": 68.7, "unit": "score"}]}]} 07:17:31 INFO - Return code: 0 07:17:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:17:31 ERROR - # TBPL SUCCESS # 07:17:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:17:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:17:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:17:31 INFO - 2016-09-24 07:17:31.265 screenresolution[1672:11062] starting screenresolution argv=screenresolution get 07:17:31 INFO - 2016-09-24 07:17:31.267 screenresolution[1672:11062] Display 0: 1600x1200x32@60 07:17:31 INFO - 2016-09-24 07:17:31.273 screenresolution[1673:11065] starting screenresolution argv=screenresolution list 07:17:31 INFO - Available Modes on Display 0 07:17:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:17:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:17:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:17:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:17:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:17:31 INFO - Intel Iris: 07:17:31 INFO - Chipset Model: Intel Iris 07:17:31 INFO - Type: GPU 07:17:31 INFO - Bus: Built-In 07:17:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:17:31 INFO - Vendor: Intel (0x8086) 07:17:31 INFO - Device ID: 0x0a2e 07:17:31 INFO - Revision ID: 0x0009 07:17:31 INFO - Displays: 07:17:31 INFO - Display: 07:17:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:17:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:17:31 INFO - Display Serial Number: 1600x1200 60 07:17:31 INFO - Main Display: Yes 07:17:31 INFO - Mirror: Off 07:17:31 INFO - Online: Yes 07:17:31 INFO - Rotation: Supported 07:17:31 INFO - Return code: 0 07:17:31 INFO - Running post-action listener: _resource_record_post_action 07:17:31 INFO - [mozharness: 2016-09-24 14:17:31.507129Z] Finished run-tests step (success) 07:17:31 INFO - Running post-run listener: _resource_record_post_run 07:17:31 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 33907200; Write bytes: 709257728; Read time: 315; Write time: 1924 07:17:31 INFO - TinderboxPrint: CPU usage
54.5% 07:17:31 INFO - TinderboxPrint: I/O read bytes / time
33,907,200 / 315 07:17:31 INFO - TinderboxPrint: I/O write bytes / time
709,257,728 / 1,924 07:17:31 INFO - TinderboxPrint: CPU idle
2,205.1 (45.5%) 07:17:31 INFO - TinderboxPrint: CPU system
982.2 (20.3%) 07:17:31 INFO - TinderboxPrint: CPU user
1,654.4 (34.2%) 07:17:31 INFO - TinderboxPrint: Swap in / out
436,514,816 / 0 07:17:31 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390859264; Write bytes: 385238528; Read time: 29281; Write time: 708 07:17:31 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 32948736; Write bytes: 299779072; Read time: 300; Write time: 1168 07:17:31 INFO - Running post-run listener: _upload_blobber_files 07:17:31 INFO - Blob upload gear active. 07:17:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:17:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:17:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:33 INFO - (blobuploader) - INFO - Done attempting. 07:17:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:17:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:34 INFO - (blobuploader) - INFO - Done attempting. 07:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:36 INFO - (blobuploader) - INFO - Done attempting. 07:17:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:17:36 INFO - Return code: 0 07:17:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:17:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:17:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ed068f95a8a458a4b761920b8d97243cd7d7f78ad13e6ff8d3a1b46188959a9115d8e9e2a3937e3764bfabe5e55c509c211bb753e96c7132a965182337b493", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7c5f8a37b10c1e8503660168b59a57105e00e0c601a99cdc66628952f9affa9f0d3e861bb6e81659d57dcc7113831d01def0e1e968ba519ed3a0e5f5f2bbf1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc47e42e6c03706867b8bb8ef61bde8a12f764d8f867eced175ee8c2782ec9d30ef7d3da2b91fc610d69eb2342ae79dc5a968cd3d012d20bdd06928e4b6465b6"} 07:17:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:17:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:17:36 INFO - Contents: 07:17:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ed068f95a8a458a4b761920b8d97243cd7d7f78ad13e6ff8d3a1b46188959a9115d8e9e2a3937e3764bfabe5e55c509c211bb753e96c7132a965182337b493", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7c5f8a37b10c1e8503660168b59a57105e00e0c601a99cdc66628952f9affa9f0d3e861bb6e81659d57dcc7113831d01def0e1e968ba519ed3a0e5f5f2bbf1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc47e42e6c03706867b8bb8ef61bde8a12f764d8f867eced175ee8c2782ec9d30ef7d3da2b91fc610d69eb2342ae79dc5a968cd3d012d20bdd06928e4b6465b6"} 07:17:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:17:36 INFO - Copying logs to upload dir... 07:17:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:17:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.855789 ========= master_lag: 3.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-24 07:17:40.541559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 07:17:40.542743) ========= 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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/Firefox/sha512/40ed068f95a8a458a4b761920b8d97243cd7d7f78ad13e6ff8d3a1b46188959a9115d8e9e2a3937e3764bfabe5e55c509c211bb753e96c7132a965182337b493", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7c5f8a37b10c1e8503660168b59a57105e00e0c601a99cdc66628952f9affa9f0d3e861bb6e81659d57dcc7113831d01def0e1e968ba519ed3a0e5f5f2bbf1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc47e42e6c03706867b8bb8ef61bde8a12f764d8f867eced175ee8c2782ec9d30ef7d3da2b91fc610d69eb2342ae79dc5a968cd3d012d20bdd06928e4b6465b6"} build_url:https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/dp_-RDDyQkGeVUzrX5DtCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ed068f95a8a458a4b761920b8d97243cd7d7f78ad13e6ff8d3a1b46188959a9115d8e9e2a3937e3764bfabe5e55c509c211bb753e96c7132a965182337b493", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7c5f8a37b10c1e8503660168b59a57105e00e0c601a99cdc66628952f9affa9f0d3e861bb6e81659d57dcc7113831d01def0e1e968ba519ed3a0e5f5f2bbf1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc47e42e6c03706867b8bb8ef61bde8a12f764d8f867eced175ee8c2782ec9d30ef7d3da2b91fc610d69eb2342ae79dc5a968cd3d012d20bdd06928e4b6465b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 07:17:40.578234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:17:40.578580) ========= 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.aDJjq7Akhv/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.tFGo5UtZ7b/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005016 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:17:40.627767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 07:17:40.628921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 07:17:40.629253) ========= ========= Total master_lag: 3.86 =========