builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0306 starttime: 1484304934.39 results: success (0) buildid: 20170113011916 builduid: 5ad6546c740e4c1eb15bf18aaa68da23 revision: eca7348f32d8410559e342bff1a7698ceb2e9a30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.390234) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.391221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.392132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.420654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.421384) ========= 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.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-13 02:55:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-01-13 02:55:34 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.590089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.590512) ========= 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.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.027060 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:34.641640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 02:55:34.642160) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eca7348f32d8410559e342bff1a7698ceb2e9a30 --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 eca7348f32d8410559e342bff1a7698ceb2e9a30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-13 02:55:34,741 truncating revision to first 12 chars 2017-01-13 02:55:34,741 Setting DEBUG logging. 2017-01-13 02:55:34,741 attempt 1/10 2017-01-13 02:55:34,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eca7348f32d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 02:55:35,856 unpacking tar archive at: mozilla-central-eca7348f32d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 02:55:36.067207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:36.067570) ========= script_repo_revision: eca7348f32d8410559e342bff1a7698ceb2e9a30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:36.068001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:36.068320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:55:36.088112) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-13 02:55:36.088527) ========= /tools/buildbot/bin/python -u 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', '-u', '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.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:55:36 INFO - MultiFileLogger online at 20170113 02:55:36 in /builds/slave/test 02:55:36 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 02:55:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:36 INFO - {'append_to_log': False, 02:55:36 INFO - 'base_work_dir': '/builds/slave/test', 02:55:36 INFO - 'blob_upload_branch': 'Firefox', 02:55:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:36 INFO - 'branch': 'Firefox', 02:55:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:36 INFO - 'config_files': ('talos/mac_config.py',), 02:55:36 INFO - 'default_actions': ('clobber', 02:55:36 INFO - 'read-buildbot-config', 02:55:36 INFO - 'download-and-extract', 02:55:36 INFO - 'populate-webroot', 02:55:36 INFO - 'create-virtualenv', 02:55:36 INFO - 'install', 02:55:36 INFO - 'run-tests'), 02:55:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:36 INFO - 'download_minidump_stackwalk': True, 02:55:36 INFO - 'download_symbols': 'ondemand', 02:55:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:36 INFO - 'installer_path': 'installer.exe', 02:55:36 INFO - 'log_level': 'info', 02:55:36 INFO - 'log_name': 'talos', 02:55:36 INFO - 'log_to_console': True, 02:55:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:36 INFO - 'opt_config_files': (), 02:55:36 INFO - 'pip_index': False, 02:55:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:36 INFO - 'cmd': ('bash', 02:55:36 INFO - '-c', 02:55:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:36 INFO - 'enabled': True, 02:55:36 INFO - 'halt_on_failure': False, 02:55:36 INFO - 'name': 'check_screen_resolution'},), 02:55:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:36 INFO - 'cmd': ('bash', 02:55:36 INFO - '-c', 02:55:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:36 INFO - 'enabled': True, 02:55:36 INFO - 'halt_on_failure': False, 02:55:36 INFO - 'name': 'check_screen_resolution'},), 02:55:36 INFO - 'run_cmd_checks_enabled': True, 02:55:36 INFO - 'sps_profile': False, 02:55:36 INFO - 'sps_profile_interval': 0, 02:55:36 INFO - 'suite': 'dromaeojs-e10s', 02:55:36 INFO - 'system_bits': '32', 02:55:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:36 INFO - 'title': 't-yosemite-r7-0306', 02:55:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:36 INFO - 'use_talos_json': True, 02:55:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:36 INFO - 'work_dir': 'build'} 02:55:36 INFO - [mozharness: 2017-01-13 10:55:36.292753Z] Running clobber step. 02:55:36 INFO - Running pre-action listener: _resource_record_pre_action 02:55:36 INFO - Running main action method: clobber 02:55:36 INFO - rmtree: /builds/slave/test/build 02:55:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:38 INFO - Running post-action listener: _resource_record_post_action 02:55:38 INFO - [mozharness: 2017-01-13 10:55:38.622433Z] Finished clobber step (success) 02:55:38 INFO - [mozharness: 2017-01-13 10:55:38.622611Z] Running read-buildbot-config step. 02:55:38 INFO - Running pre-action listener: _resource_record_pre_action 02:55:38 INFO - Running main action method: read_buildbot_config 02:55:38 INFO - Using buildbot properties: 02:55:38 INFO - { 02:55:38 INFO - "project": "", 02:55:38 INFO - "product": "firefox", 02:55:38 INFO - "script_repo_revision": "production", 02:55:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:55:38 INFO - "repository": "", 02:55:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:55:38 INFO - "buildid": "20170113011916", 02:55:38 INFO - "pgo_build": "False", 02:55:38 INFO - "basedir": "/builds/slave/test", 02:55:38 INFO - "buildnumber": 54, 02:55:38 INFO - "slavename": "t-yosemite-r7-0306", 02:55:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:55:38 INFO - "platform": "yosemite_r7", 02:55:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:55:38 INFO - "branch": "mozilla-central", 02:55:38 INFO - "repo_path": "mozilla-central", 02:55:38 INFO - "revision": "eca7348f32d8410559e342bff1a7698ceb2e9a30", 02:55:38 INFO - "stage_platform": "macosx64", 02:55:38 INFO - "builduid": "5ad6546c740e4c1eb15bf18aaa68da23", 02:55:38 INFO - "slavebuilddir": "test" 02:55:38 INFO - } 02:55:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 02:55:38 INFO - Running post-action listener: _resource_record_post_action 02:55:38 INFO - [mozharness: 2017-01-13 10:55:38.626814Z] Finished read-buildbot-config step (success) 02:55:38 INFO - [mozharness: 2017-01-13 10:55:38.626936Z] Running download-and-extract step. 02:55:38 INFO - Running pre-action listener: _resource_record_pre_action 02:55:38 INFO - Running main action method: download_and_extract 02:55:38 INFO - mkdir: /builds/slave/test/build/tests 02:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:38 INFO - trying https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 02:55:40 INFO - Downloaded 1199 bytes. 02:55:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:55:40 INFO - Using the following test package requirements: 02:55:40 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:55:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 02:55:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 02:55:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'jsshell-mac.zip'], 02:55:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 02:55:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:55:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 02:55:40 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 02:55:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 02:55:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:55:40 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 02:55:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:55:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:55:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:55:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:55:40 INFO - Expected file size: 16317025 02:55:40 INFO - Obtained file size: 16317025 02:55:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:55:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:55:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:55:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:55:48 INFO - Expected file size: 16317025 02:55:48 INFO - Obtained file size: 16317025 02:55:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 02:55:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:55:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 02:55:55 INFO - Expected file size: 14403555 02:55:55 INFO - Obtained file size: 14403555 02:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:56 INFO - trying https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 02:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 02:55:58 INFO - Downloaded 70078676 bytes. 02:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:58 INFO - mkdir: /builds/slave/test/properties 02:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:58 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:58 INFO - Contents: 02:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:55:58 INFO - Running post-action listener: _resource_record_post_action 02:55:58 INFO - Running post-action listener: set_extra_try_arguments 02:55:58 INFO - [mozharness: 2017-01-13 10:55:58.960722Z] Finished download-and-extract step (success) 02:55:58 INFO - [mozharness: 2017-01-13 10:55:58.960867Z] Running populate-webroot step. 02:55:58 INFO - Running pre-action listener: _resource_record_pre_action 02:55:58 INFO - Running main action method: populate_webroot 02:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:58 INFO - '--tppagecycles', 02:55:58 INFO - '7'], 02:55:58 INFO - 'tests': ['tsvgm']}}, 02:55:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['damp', 'tps']}, 02:55:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'tests': ['damp', 'tps']}, 02:55:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['dromaeo_dom']}, 02:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['basic_compositor_video']}, 02:55:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:55:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['tsvgx', 02:55:58 INFO - 'tsvgr_opacity', 02:55:58 INFO - 'tart', 02:55:58 INFO - 'tscrollx', 02:55:58 INFO - 'cart', 02:55:58 INFO - 'tsvg_static']}, 02:55:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:58 INFO - 'tsvgr_opacity', 02:55:58 INFO - 'tart', 02:55:58 INFO - 'tscrollx', 02:55:58 INFO - 'cart', 02:55:58 INFO - 'tsvg_static']}, 02:55:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--disable-e10s'], 02:55:58 INFO - 'tests': ['tp5o']}, 02:55:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--disable-e10s', 02:55:58 INFO - '--xperf_path', 02:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:58 INFO - 'tests': ['tp5n']}, 02:55:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--xperf_path', 02:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:58 INFO - 'tests': ['tp5n']}}, 02:55:58 INFO - 'talos.zip': {'path': '', 02:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:58 INFO - Running post-action listener: _resource_record_post_action 02:55:58 INFO - [mozharness: 2017-01-13 10:55:58.979596Z] Finished populate-webroot step (success) 02:55:58 INFO - [mozharness: 2017-01-13 10:55:58.979722Z] Running create-virtualenv step. 02:55:58 INFO - Running pre-action listener: _resource_record_pre_action 02:55:58 INFO - Running main action method: create_virtualenv 02:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:58 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 02:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:59 INFO - Using real prefix '/tools/python27' 02:55:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 02:56:02 INFO - Installing pip.................done. 02:56:02 INFO - Return code: 0 02:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:56:02 INFO - Reading from file tmpfile_stdout 02:56:02 INFO - Output received: 02:56:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:56:02 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')]} 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:02 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')]} 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:02 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:02 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 02:56:02 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 02:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:02 INFO - 'HOME': '/Users/cltbld', 02:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:02 INFO - 'LOGNAME': 'cltbld', 02:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:02 INFO - 'MOZ_NO_REMOTE': '1', 02:56:02 INFO - 'NO_EM_RESTART': '1', 02:56:02 INFO - 'PAGER': '/bin/cat', 02:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:02 INFO - 'PWD': '/builds/slave/test', 02:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:02 INFO - 'SHELL': '/bin/bash', 02:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:02 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:02 INFO - 'USER': 'cltbld', 02:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:02 INFO - 'XPC_FLAGS': '0x0', 02:56:02 INFO - 'XPC_SERVICE_NAME': '0', 02:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:03 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 02:56:03 INFO - Cleaning up... 02:56:03 INFO - Return code: 0 02:56:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56:03 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')]} 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:03 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')]} 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:03 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:03 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 02:56:03 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 02:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:03 INFO - 'HOME': '/Users/cltbld', 02:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:03 INFO - 'LOGNAME': 'cltbld', 02:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:03 INFO - 'MOZ_NO_REMOTE': '1', 02:56:03 INFO - 'NO_EM_RESTART': '1', 02:56:03 INFO - 'PAGER': '/bin/cat', 02:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:03 INFO - 'PWD': '/builds/slave/test', 02:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:03 INFO - 'SHELL': '/bin/bash', 02:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:03 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:03 INFO - 'USER': 'cltbld', 02:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:03 INFO - 'XPC_FLAGS': '0x0', 02:56:03 INFO - 'XPC_SERVICE_NAME': '0', 02:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:03 INFO - Downloading/unpacking psutil>=3.1.1 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:06 INFO - Installing collected packages: psutil 02:56:06 INFO - Running setup.py install for psutil 02:56:07 INFO - building 'psutil._psutil_osx' extension 02:56:07 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 02:56:07 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 02:56:07 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 02:56:07 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 02:56:07 INFO - building 'psutil._psutil_posix' extension 02:56:07 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 02:56:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:56:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:56:07 INFO - ^ 02:56:07 INFO - 1 warning generated. 02:56:07 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 02:56:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:08 INFO - Successfully installed psutil 02:56:08 INFO - Cleaning up... 02:56:08 INFO - Return code: 0 02:56:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56:08 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')]} 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:08 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')]} 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:08 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:08 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 02:56:08 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 02:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:08 INFO - 'HOME': '/Users/cltbld', 02:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:08 INFO - 'LOGNAME': 'cltbld', 02:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:08 INFO - 'MOZ_NO_REMOTE': '1', 02:56:08 INFO - 'NO_EM_RESTART': '1', 02:56:08 INFO - 'PAGER': '/bin/cat', 02:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:08 INFO - 'PWD': '/builds/slave/test', 02:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:08 INFO - 'SHELL': '/bin/bash', 02:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:08 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:08 INFO - 'USER': 'cltbld', 02:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:08 INFO - 'XPC_FLAGS': '0x0', 02:56:08 INFO - 'XPC_SERVICE_NAME': '0', 02:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:11 INFO - Installing collected packages: mozsystemmonitor 02:56:11 INFO - Running setup.py install for mozsystemmonitor 02:56:11 INFO - Successfully installed mozsystemmonitor 02:56:11 INFO - Cleaning up... 02:56:11 INFO - Return code: 0 02:56:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56:11 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')]} 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:11 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')]} 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:11 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:11 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 02:56:11 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 02:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:11 INFO - 'HOME': '/Users/cltbld', 02:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:11 INFO - 'LOGNAME': 'cltbld', 02:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:11 INFO - 'MOZ_NO_REMOTE': '1', 02:56:11 INFO - 'NO_EM_RESTART': '1', 02:56:11 INFO - 'PAGER': '/bin/cat', 02:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:11 INFO - 'PWD': '/builds/slave/test', 02:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:11 INFO - 'SHELL': '/bin/bash', 02:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:11 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:11 INFO - 'USER': 'cltbld', 02:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:11 INFO - 'XPC_FLAGS': '0x0', 02:56:11 INFO - 'XPC_SERVICE_NAME': '0', 02:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:14 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 02:56:14 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 02:56:14 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 02:56:14 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 02:56:14 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 02:56:14 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 02:56:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:14 INFO - warning: no files found matching '*.txt' 02:56:14 INFO - no previously-included directories found matching 'build' 02:56:14 INFO - no previously-included directories found matching 'dist' 02:56:14 INFO - no previously-included directories found matching '.git*' 02:56:14 INFO - Installing collected packages: jsonschema, functools32 02:56:14 INFO - Running setup.py install for functools32 02:56:14 INFO - warning: no files found matching '*.txt' 02:56:15 INFO - no previously-included directories found matching 'build' 02:56:15 INFO - no previously-included directories found matching 'dist' 02:56:15 INFO - no previously-included directories found matching '.git*' 02:56:15 INFO - Successfully installed jsonschema functools32 02:56:15 INFO - Cleaning up... 02:56:15 INFO - Return code: 0 02:56:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:56:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:15 INFO - 'HOME': '/Users/cltbld', 02:56:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:15 INFO - 'LOGNAME': 'cltbld', 02:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:15 INFO - 'MOZ_NO_REMOTE': '1', 02:56:15 INFO - 'NO_EM_RESTART': '1', 02:56:15 INFO - 'PAGER': '/bin/cat', 02:56:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:15 INFO - 'PWD': '/builds/slave/test', 02:56:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:15 INFO - 'SHELL': '/bin/bash', 02:56:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:15 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:15 INFO - 'USER': 'cltbld', 02:56:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:15 INFO - 'XPC_FLAGS': '0x0', 02:56:15 INFO - 'XPC_SERVICE_NAME': '0', 02:56:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:56:15 INFO - Cleaning up... 02:56:15 INFO - Return code: 0 02:56:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:56:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:15 INFO - 'HOME': '/Users/cltbld', 02:56:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:15 INFO - 'LOGNAME': 'cltbld', 02:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:15 INFO - 'MOZ_NO_REMOTE': '1', 02:56:15 INFO - 'NO_EM_RESTART': '1', 02:56:15 INFO - 'PAGER': '/bin/cat', 02:56:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:15 INFO - 'PWD': '/builds/slave/test', 02:56:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:15 INFO - 'SHELL': '/bin/bash', 02:56:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:15 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:15 INFO - 'USER': 'cltbld', 02:56:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:15 INFO - 'XPC_FLAGS': '0x0', 02:56:15 INFO - 'XPC_SERVICE_NAME': '0', 02:56:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:56:15 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 02:56:15 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 02:56:15 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 02:56:15 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 02:56:15 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 02:56:15 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 02:56:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:19 INFO - Downloading docopt-0.6.1.tar.gz 02:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:19 INFO - Running setup.py install for blobuploader 02:56:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:19 INFO - Running setup.py install for requests 02:56:20 INFO - Running setup.py install for docopt 02:56:20 INFO - Successfully installed blobuploader requests docopt 02:56:20 INFO - Cleaning up... 02:56:20 INFO - Return code: 0 02:56:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:20 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:20 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 02:56:20 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 02:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:20 INFO - 'HOME': '/Users/cltbld', 02:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:20 INFO - 'LOGNAME': 'cltbld', 02:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:20 INFO - 'MOZ_NO_REMOTE': '1', 02:56:20 INFO - 'NO_EM_RESTART': '1', 02:56:20 INFO - 'PAGER': '/bin/cat', 02:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:20 INFO - 'PWD': '/builds/slave/test', 02:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:20 INFO - 'SHELL': '/bin/bash', 02:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:20 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:20 INFO - 'USER': 'cltbld', 02:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:20 INFO - 'XPC_FLAGS': '0x0', 02:56:20 INFO - 'XPC_SERVICE_NAME': '0', 02:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-JPxz5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-dxS_CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-mVaxp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-fFpCjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-uyN_V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-MUmop6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-NusksV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-dN0e92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-5kG7A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-OGfZVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-t8OqcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-jV7daM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-RSGzkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-uH00vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-YWW1eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-NzdVtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:22 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Zdt0fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:22 INFO - Running setup.py install for manifestparser 02:56:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:22 INFO - Running setup.py install for mozcrash 02:56:22 INFO - Running setup.py install for mozdebug 02:56:23 INFO - Running setup.py install for mozdevice 02:56:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Running setup.py install for mozfile 02:56:23 INFO - Running setup.py install for mozhttpd 02:56:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Running setup.py install for mozinfo 02:56:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Running setup.py install for mozInstall 02:56:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:23 INFO - Running setup.py install for mozleak 02:56:23 INFO - Running setup.py install for mozlog 02:56:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Running setup.py install for moznetwork 02:56:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Running setup.py install for mozprocess 02:56:24 INFO - Running setup.py install for mozprofile 02:56:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Running setup.py install for mozrunner 02:56:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:24 INFO - Running setup.py install for mozscreenshot 02:56:24 INFO - Running setup.py install for moztest 02:56:25 INFO - Running setup.py install for mozversion 02:56:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:25 INFO - Cleaning up... 02:56:25 INFO - Return code: 0 02:56:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:25 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')]} 02:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:25 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')]} 02:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:25 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:25 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 02:56:25 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 02:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:25 INFO - 'HOME': '/Users/cltbld', 02:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:25 INFO - 'LOGNAME': 'cltbld', 02:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:25 INFO - 'MOZ_NO_REMOTE': '1', 02:56:25 INFO - 'NO_EM_RESTART': '1', 02:56:25 INFO - 'PAGER': '/bin/cat', 02:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:25 INFO - 'PWD': '/builds/slave/test', 02:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:25 INFO - 'SHELL': '/bin/bash', 02:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:25 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:25 INFO - 'USER': 'cltbld', 02:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:25 INFO - 'XPC_FLAGS': '0x0', 02:56:25 INFO - 'XPC_SERVICE_NAME': '0', 02:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-vE1hO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:25 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)) 02:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-OkPKI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-H5Bc6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:25 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)) 02:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-igrPxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-EYx14W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-lycs6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-God3ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-tOS6DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-MbOSFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-j5JOZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-O9bQSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-kZ0frM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6_Dwv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:26 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)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-CtIz64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-tFcrCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:27 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)) 02:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:27 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-YWBe9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:27 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-UUuVIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:27 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)) 02:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:27 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)) 02:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:27 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 02:56:27 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 02:56:27 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 02:56:27 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 02:56:27 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 02:56:27 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 02:56:30 INFO - Downloading blessings-1.6.tar.gz 02:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:31 INFO - Installing collected packages: blessings 02:56:31 INFO - Running setup.py install for blessings 02:56:31 INFO - Successfully installed blessings 02:56:31 INFO - Cleaning up... 02:56:31 INFO - Return code: 0 02:56:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:31 INFO - Reading from file tmpfile_stdout 02:56:31 INFO - Current package versions: 02:56:31 INFO - blessings == 1.6 02:56:31 INFO - blobuploader == 1.2.4 02:56:31 INFO - docopt == 0.6.1 02:56:31 INFO - functools32 == 3.2.3-2 02:56:31 INFO - jsonschema == 2.5.1 02:56:31 INFO - manifestparser == 1.1 02:56:31 INFO - mozInstall == 1.12 02:56:31 INFO - mozcrash == 1.0 02:56:31 INFO - mozdebug == 0.1 02:56:31 INFO - mozdevice == 0.49 02:56:31 INFO - mozfile == 1.2 02:56:31 INFO - mozhttpd == 0.7 02:56:31 INFO - mozinfo == 0.9 02:56:31 INFO - mozleak == 0.1 02:56:31 INFO - mozlog == 3.4 02:56:31 INFO - moznetwork == 0.27 02:56:31 INFO - mozprocess == 0.24 02:56:31 INFO - mozprofile == 0.28 02:56:31 INFO - mozrunner == 6.13 02:56:31 INFO - mozscreenshot == 0.1 02:56:31 INFO - mozsystemmonitor == 0.3 02:56:31 INFO - moztest == 0.8 02:56:31 INFO - mozversion == 1.4 02:56:31 INFO - psutil == 3.1.1 02:56:31 INFO - requests == 1.2.3 02:56:31 INFO - wsgiref == 0.1.2 02:56:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:31 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')]} 02:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:31 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')]} 02:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:32 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:32 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 02:56:32 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 02:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:32 INFO - 'HOME': '/Users/cltbld', 02:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:32 INFO - 'LOGNAME': 'cltbld', 02:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:32 INFO - 'MOZ_NO_REMOTE': '1', 02:56:32 INFO - 'NO_EM_RESTART': '1', 02:56:32 INFO - 'PAGER': '/bin/cat', 02:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:32 INFO - 'PWD': '/builds/slave/test', 02:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:32 INFO - 'SHELL': '/bin/bash', 02:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:32 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:32 INFO - 'USER': 'cltbld', 02:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:32 INFO - 'XPC_FLAGS': '0x0', 02:56:32 INFO - 'XPC_SERVICE_NAME': '0', 02:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 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)) 02:56:32 INFO - Cleaning up... 02:56:32 INFO - Return code: 0 02:56:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:33 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 0x109778b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e84a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, '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.8osDteODY2/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.UbLRl3Xczs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 02:56:33 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 02:56:33 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 02:56:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:33 INFO - 'HOME': '/Users/cltbld', 02:56:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:33 INFO - 'LOGNAME': 'cltbld', 02:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:33 INFO - 'MOZ_NO_REMOTE': '1', 02:56:33 INFO - 'NO_EM_RESTART': '1', 02:56:33 INFO - 'PAGER': '/bin/cat', 02:56:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:33 INFO - 'PWD': '/builds/slave/test', 02:56:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:33 INFO - 'SHELL': '/bin/bash', 02:56:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:33 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:33 INFO - 'USER': 'cltbld', 02:56:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:33 INFO - 'XPC_FLAGS': '0x0', 02:56:33 INFO - 'XPC_SERVICE_NAME': '0', 02:56:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:33 INFO - Cleaning up... 02:56:33 INFO - Return code: 0 02:56:33 INFO - Running post-action listener: _resource_record_post_action 02:56:33 INFO - Running post-action listener: _start_resource_monitoring 02:56:33 INFO - Starting resource monitoring. 02:56:33 INFO - [mozharness: 2017-01-13 10:56:33.334073Z] Finished create-virtualenv step (success) 02:56:33 INFO - [mozharness: 2017-01-13 10:56:33.335006Z] Running install step. 02:56:33 INFO - Running pre-action listener: _resource_record_pre_action 02:56:33 INFO - Running main action method: install 02:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:33 INFO - Reading from file tmpfile_stdout 02:56:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:33 INFO - Reading from file tmpfile_stdout 02:56:33 INFO - Output received: 02:56:33 INFO - Usage: mozinstall [options] installer 02:56:33 INFO - Options: 02:56:33 INFO - -h, --help show this help message and exit 02:56:33 INFO - -d DEST, --destination=DEST 02:56:33 INFO - Directory to install application into. [default: 02:56:33 INFO - "/builds/slave/test"] 02:56:33 INFO - --app=APP Application being installed. [default: firefox] 02:56:33 INFO - mkdir: /builds/slave/test/build/application 02:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:56:55 INFO - Reading from file tmpfile_stdout 02:56:55 INFO - Output received: 02:56:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:56:55 INFO - Running post-action listener: _resource_record_post_action 02:56:55 INFO - [mozharness: 2017-01-13 10:56:55.921398Z] Finished install step (success) 02:56:55 INFO - [mozharness: 2017-01-13 10:56:55.921556Z] Running run-tests step. 02:56:55 INFO - Running pre-action listener: _resource_record_pre_action 02:56:55 INFO - Running main action method: run_tests 02:56:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:55 INFO - 2017-01-13 02:56:55.935 screenresolution[1633:7530] starting screenresolution argv=screenresolution get 02:56:55 INFO - 2017-01-13 02:56:55.938 screenresolution[1633:7530] Display 0: 1600x1200x32@60 02:56:55 INFO - 2017-01-13 02:56:55.944 screenresolution[1634:7532] starting screenresolution argv=screenresolution list 02:56:55 INFO - Available Modes on Display 0 02:56:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:56 INFO - Intel Iris: 02:56:56 INFO - Chipset Model: Intel Iris 02:56:56 INFO - Type: GPU 02:56:56 INFO - Bus: Built-In 02:56:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:56 INFO - Vendor: Intel (0x8086) 02:56:56 INFO - Device ID: 0x0a2e 02:56:56 INFO - Revision ID: 0x0009 02:56:56 INFO - Displays: 02:56:56 INFO - Display: 02:56:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:56 INFO - Display Serial Number: 1600x1200 60 02:56:56 INFO - Main Display: Yes 02:56:56 INFO - Mirror: Off 02:56:56 INFO - Online: Yes 02:56:56 INFO - Rotation: Supported 02:56:56 INFO - Return code: 0 02:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:56 INFO - Python 2.7.3 02:56:56 INFO - Return code: 0 02:56:56 INFO - grabbing minidump binary from tooltool 02:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:56 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 0x109556d30>, '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 0x10947ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10954bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:56 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 02:56:56 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 02:56:56 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 02:56:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:56 INFO - Return code: 0 02:56:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56: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/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 02:56: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/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 02:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8osDteODY2/Render', 02:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:56 INFO - 'HOME': '/Users/cltbld', 02:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:56 INFO - 'LOGNAME': 'cltbld', 02:56:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:56 INFO - 'MOZ_NO_REMOTE': '1', 02:56:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:56 INFO - 'NO_EM_RESTART': '1', 02:56:56 INFO - 'PAGER': '/bin/cat', 02:56:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:56 INFO - 'PWD': '/builds/slave/test', 02:56:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:56 INFO - 'SHELL': '/bin/bash', 02:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UbLRl3Xczs/Listeners', 02:56:56 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 02:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:56 INFO - 'USER': 'cltbld', 02:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:56 INFO - 'XPC_FLAGS': '0x0', 02:56:56 INFO - 'XPC_SERVICE_NAME': '0', 02:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56: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/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 02:56:56 INFO - mozversion application_buildid: 20170113011916 02:56:56 INFO - mozversion application_changeset: eca7348f32d8410559e342bff1a7698ceb2e9a30 02:56:56 INFO - mozversion application_display_name: Nightly 02:56:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:56 INFO - mozversion application_name: Firefox 02:56:56 INFO - mozversion application_remotingname: firefox 02:56:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:56 INFO - mozversion application_vendor: Mozilla 02:56:56 INFO - mozversion application_version: 53.0a1 02:56:56 INFO - mozversion platform_buildid: 20170113011916 02:56:56 INFO - mozversion platform_changeset: eca7348f32d8410559e342bff1a7698ceb2e9a30 02:56:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:56 INFO - mozversion platform_version: 53.0a1 02:56:56 INFO - using testdate: 1484305016 02:56:56 INFO - actual date: 1484305016 02:56:56 INFO - starting webserver on 'localhost:49248' 02:56:56 INFO - SUITE-START | Running 2 tests 02:56:56 INFO - TEST-START | dromaeo_css 02:56:56 INFO - operating with platform_type : mac_ 02:56:56 INFO - Initialising browser for dromaeo_css test... 02:56:56 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmprCXZ0h/profile http://localhost:49248/getInfo.html) 02:56:59 INFO - PROCESS | 1644 | 2017-01-13 02:56:59.211 plugin-container[1646:7685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b43, name = 'com.apple.tsm.portname' 02:56:59 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:56:59 INFO - PROCESS | 1644 | 2017-01-13 02:56:59.213 plugin-container[1646:7685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9513, name = 'com.apple.CFPasteboardClient' 02:56:59 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:56:59 INFO - PROCESS | 1644 | 2017-01-13 02:56:59.213 plugin-container[1646:7685] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:56:59 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 02:56:59 INFO - PROCESS | 1644 | colorDepth:24 02:56:59 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 02:56:59 INFO - PROCESS | 1644 | __metrics 02:56:59 ERROR - PROCESS | 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 02:56:59 INFO - TEST-INFO | 1644: exit 0 02:56:59 INFO - Browser initialized. 02:56:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:59 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmprCXZ0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:02 INFO - PROCESS | 1647 | 2017-01-13 02:57:02.464 plugin-container[1648:7802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 02:57:02 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:57:02 INFO - PROCESS | 1647 | 2017-01-13 02:57:02.465 plugin-container[1648:7802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 02:57:02 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:57:02 INFO - PROCESS | 1647 | 2017-01-13 02:57:02.465 plugin-container[1648:7802] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:57:12 INFO - PROCESS | 1647 | RSS: Main: 233512960 02:57:12 INFO - PROCESS | 1647 | 03:00:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 03:00:16 INFO - PROCESS | 1647 | RSS: Main: 252555264 03:00:16 INFO - PROCESS | 1647 | 03:02:00 INFO - PROCESS | 1647 | ************************* 03:02:00 INFO - PROCESS | 1647 | A coding exception was thrown and uncaught in a Task. 03:02:00 INFO - PROCESS | 1647 | 03:02:00 ERROR - PROCESS | 1647 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:02:00 INFO - PROCESS | 1647 | Full stack: 03:02:00 INFO - PROCESS | 1647 | ************************* 03:03:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 03:03:19 INFO - PROCESS | 1647 | RSS: Main: 262565888 03:03:19 INFO - PROCESS | 1647 | 03:06:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 03:06:21 INFO - PROCESS | 1647 | RSS: Main: 270147584 03:06:21 INFO - PROCESS | 1647 | 03:09:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 03:09:24 INFO - PROCESS | 1647 | RSS: Main: 267055104 03:09:24 INFO - PROCESS | 1647 | 03:12:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 03:12:28 INFO - PROCESS | 1647 | RSS: Main: 271388672 03:12:28 INFO - PROCESS | 1647 | 03:15:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 03:15:31 INFO - PROCESS | 1647 | RSS: Main: 273842176 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | __start_tp_report 03:15:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 03:15:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 03:15:31 INFO - PROCESS | 1647 | |i|pagename|runs| 03:15:31 INFO - PROCESS | 1647 | |0;dojo.html;2925.882964681413;2928.238657948934;3130.311331507069;3247.3667634811213;3296.76922615417;4758.8102974256435;5274;5292.523672869445;5459.617826752129;5612.102063669803;5487.890242195163;5491.560675145989;5572.080606699889;5629.4652008059165;5685.260916080903;4248.511421186557;4997;5108;5132.5124113209185;5221.086309895772;5105.208692652626;5166.17341225404;5177.430482646906;5184.896302073957;5235.450277720842;4667.55658212471;5013.6490445668815;5076.695398276097;5112.795488180505;5159.458256883011;5016;5056.367954005749;5078.847634570969;5099.235114732783;5138.049460849755;5069.340985671876;5119.923201151985;5142;5148.459411761749;5157.355330583677;5347.946520534783;5455.454454554552;5489.149181876815;5529.723513824292;5615.887682246373;6046.27444706638;6053.334133245339;6142.6314421134875;6151;6153.692315384213;6071.483923866476;6076.088586711984;6088.756449742005;6112.959454150325;6133.570650054498;5513.117901135799;5587.469190426903;5591.4688104629995;5594;5633.971830140823;6085.056816193497;6123;6134.294556126013;6150.846228844225;6174.845628859314;5822.155787410802;5915.911261331084;5929.73316200772;5951.791687290924;5969.462748352669;5942.851428714317;6153.692315384213;6165.568410211242;6180.66006369645;6182.60891299454;5663.716814159358;5783.59514833966;6002.249718785152;6029;6137.1624860202055;4849.515048495122;6077.36187700294;6156.168917196122;6174.104754810527;6211.9689401553605;4795.760211989386;4847.903041939141;4858.02839432115;4944;4952.801887924443;4335.7181783184;4348.608625223745;4356.128774245164;4390.890227744332;4459.821607135678;5632.493075623213;5637.49262566371;5659.151127330933;5666.178404131378;5677.51741102011;6226.315105338409;6242.781502647385;6265.310815810257;6268.561200715997;6271.529635277372;5474.151506516497;5494.340679118452;5535.806246781343;5558.777648893999;5611.6071874969175;5338.866528336823;5390.622656414092;5392.973035134878;5420.430854760193;5424.891502169935;5514.503694667339;6104;6194.81415557534;6201.10084037821;6223.159873417031;4890.486498917705;6037.18498002764;6133.815985520441;6180.598261113013;6259.749610015549;6141.670122563672;6143.204841796883;6154.292256390572;6206.658633775005;6234.438900498977;6122.969385153046;6143.784967526115;6159.784407545893;6171.56799024064;6192.411720886508;5215.322008138917;5741.080732397029;6065.6663883486835;6206.596571222856;6233.688315584112;4952.232403977389;5936.168936349001;5964.7912323068485;5967.76128954837;6078.787242446493;4770.403699537558;6007.699615019319;6014.969925150346;6026.246719160105;6033.396660333931;5690.630109042899;5774.162746401832;5804.361520232856;5928.703564821828;5937.643741375531;5152.8148525840015;5884.911726324194;5936.643801371932;6045.909311360245;6092.238470191226;5711.457411545896;5750.25246717924;5801.3908539602735;5802.506786923159;5946.316173639913 03:15:31 INFO - PROCESS | 1647 | |1;ext.html;486.69824708680625;497.7560995112395;504.6543117964194;517.0228268572399;527.6939375162401;33659.97060264576;42393.15213695732;42400;42580.36129458061;44703.55296447034;43456;43945.12109757803;43950.560494395046;43996.56003439965;44039.55960440395;9166.587503562323;9349;9353.719388418358;9379.062093790635;10833.458327083654;10892.509837057352;11158.274712143684;11170.27393219438;11171.49728262226;11209.103271738242;9231.492267925261;11140.997310242077;11173.553057877674;11182.32906025637;11187.776244475106;10980.560777568888;11027.44862756867;11047.447627618667;11049.116070714324;11063.612773552968;10971.354296855456;11022;11045.226834121615;11052.557897684082;11052.557897684082;37538;37837;37855.24289514222;37857.05357366088;38423.423648645294;3955.0903292242947;3992.041909941622;3998.52017757868;4049.088954985134;4145.854895078688;28952.710472895422;29434.558481622793;29543.091381723527;29545.261368465744;29619.259518512208;3096.2259435141214;3226.4837625979967;3272.96727032729;3277.2953814929906;3314.254292784128;388127;441993;453107;455037;458101;47190.52809471861;57499.712501438065;57710.845783084944;57996.710016449644;58152.4184758147;58793.412065878794;60374.49063773353;60938.69530652319;60955.39044609586;61050.38949610447;15247.695046099238;15410.691786164214;15525.301361438762;15552.84447155514;15574.221288935509;10798.352098873935;11052.944735276273;11921.463534140985;11995.220310679779;12273.324967126893;18151.72772408415;18257.63484730298;18298.90206587609;18407.631847362976;18425.907870460564;6770.1537307836525;7380.225076367012;7629.2752188542;7791.181925897812;7793.3113075988695;885.6545947080643;886.4548302793864;889.3107841422949;913.5432283858071;925.2829057480371;29065.854670726512;29777.40445191084;30231.848840756094;30776.846115769276;30957.690423095482;907.8865141857268;1038.48075962019;1099.3513826842202;1111.0056499432962;1113.5323164271026;15493.922530387275;15986.920065399598;16016.11911344864;16085.839141608434;16373;567107;567324;567974;569330;570167;63076;63618.68190659017;63701.681491593175;63862.042069368996;64170;1427.9085779287932;1460.5545308680742;1469.2506821521101;1473.9336729847398;1477.416420513891;28677.426451470437;29817.403651926405;30151.246218843826;30704.385912282076;30740;53820.73089634527;54169.916601668534;54210.45789542054;54450.45549544454;54533;441754;443880.78059609496;446059;446193;446972;26920.192394228205;27180.864095680186;27317.317067073483;27527.73320135382;27550.448991019668;47493.98009085801;48580.5141948576;48932.532024039334;48967.51032489629;49063.773405665146;38365;39349;39803.20393592054;40679.7966010168;40683.3897491532;34291.14272143217;35617.28765424729;39182.2163556733;39980.80009599934;40787.59212407838;31959.520607190447;37761.2447751049;38163.80918095392;38448.6155138445;38656.22687546177;28257.57613635756;32869.89126359205;34964.825175874976;35211.47182792312;35350;20975.8951205243;24977.75022249827;25407.36481587975;25462.490750184523;25991.74008259893 03:15:31 INFO - PROCESS | 1647 | |2;jquery.html;348.7192809788121;370.2465482742619;391.3093390166359;399.756148749263;407.1023393417515;14617.415303387852;14673.046251993639;18876.622467550642;20308.39074827754;20608.793912060893;17002.40491582795;20781.584368312626;20887.791122088776;20922.89538552309;21663.67504487434;5848.502877255439;5926.822195334147;5949.560680121152;6069.211002569682;6091.939080609203;5862.325832529271;5907.0548712206055;6014.458698717114;6041.275046994367;6046.7883624073165;3953.051267695761;4133.813978370966;5960.701964901759;6374.362563743612;6648.468122550208;6474.384933431316;6656.567323123982;6715.56348837324;6721.059051732761;6738.056672065914;5814.912776308359;5876.147958546029;5882;5884.499817515516;5896.734646940898;24533.14134005319;24981.750182498123;25128.874355628104;25158.371040723945;25622.743772562222;2738.2332946774936;2798.1325789005473;2811.6063751074867;2818.633577634894;2821.5626577880257;15792.68414631701;15845.683086338324;15862.44481443144;16082.5979350516;16485.83514164855;1649.9505014849453;1842.1157844234708;1885.4249453916686;1894.2139012309874;1910.9140088696042;134237;135812.962805558;138713;157291.8437340645;165664;22315.330540083498;23090.538189236457;23980.16813106618;24024.87987560051;24266.878665606913;40921.38617920734;41213.96965075837;41318.9670258246;41362.586374136474;41621;8303.8339233215;8514.191151840565;8715.738527844174;8839.646414143492;8921.598528066253;8502.319814414832;8525.786855328666;8536.74389768308;8685.174908383693;8729.869051964226;4825.5898248649255;4873.463918968911;4880.6095512358925;4894.657373983858;4953.826616068421;1797.9032789998091;2049.928252511155;2076.5535409886947;2100.2334148035857;2102.3903068110076;988.515627342597;992.6624947517879;1001.2740762946805;1018.6943916824923;1052.9315594486334;18081.91508509467;20562.588748224953;21201.681974770392;21740.347789566338;21750.56498870014;1027.1885210683627;1032.2825636182781;1037.4034929915329;1051.695008447557;1060.0936199549428;10491.055804977588;11190.440477976232;11243.718907027389;11268.943655281671;11387.886121138848;594357;671359;709010.9098908945;736583;737231;106186.93813061925;117269.8273017276;147326;158402;162767;996.9351992120489;997.1075887081022;1012.9290949633603;1013.2755080117752;1019.0013786489282;18913.621727565645;18957.810421895603;19172.616547669248;19188.8081119187;19189.424317270503;61964.1410757678;62702;63209.68395157995;63537.68231158815;65058.349416507124;90514;90520.54739726259;92250.53874730584;92679.07320926705;92786;8157;8157.673693052211;8496.53269070207;8633.611487483204;8707.47755134694;10782.838257425989;10977.890221098007;12420.751584968431;12547.686307842012;13086.541971030969;10683;10859.674209773719;10897;11004.559817607205;11165.218434709492;10659.14726821868;10758.13934885223;10935.28920620157;10955.50700218508;11174.776504470028;11211.439428028403;11244.381559014333;11297.774044519228;11570.537178512765;11685.298882067103;7321.487495875238;8203.220694034057;8494.70268540598;8577.571121444027;8619.310455163697;9210.861837072584;11212.66362009141;11282;11377.032952198824;11490.253133546294 03:15:31 INFO - PROCESS | 1647 | |3;mootools.html;1319.2084749150508;1446.587722499088;1457.351478592027;1457.9648449600784;1474.970500589988;7625.504342217766;7881.763547093582;8180.836383272331;8621.353398495123;8624.827503449935;8091.757247282576;8221.506709597428;8329.458585191958;8456.704015359464;8470.534120623362;2284.760100189481;2320.7331156916916;2326.1160758911674;2327.534493101378;2337.754535773745;2078.511549785799;2148.7528934172537;2306;2356.8114550835976;2358.280724379072;2229.1974889039934;2290.9885450572724;2304.573653874039;2312.2600767754243;2331.5453486570127;2299.9540009199804;2309.6304591265484;2315.895784689693;2316.420894776306;2317.9420514487274;1904.2763749774997;2284.463151159476;2292.2091878302126;2301.1945818963227;2302.643090321003;8390.622421991025;8429.747107586782;8477.618507167192;8536.6158522866;8693.826123477558;4083.7141400102005;5031.4465408805;5185.740712964337;5192.714400707997;5198.298229739013;3385.86456541738;3440.587129544446;3503.3693935091674;3510.0347404463723;3525.9118522036897;1143.085531574737;1145.7078444996473;1163.6101905861547;1182.3969775414514;1210.6005018343926;9076.36465447419;10888.891111088868;10957.945210273898;10963.890361096366;11031.062359699436;4228.830846766156;4455.598996090367;4531.116432295737;4534.977325113353;4541.296099104644;8633.654653813903;8707.12928707137;8719.38964272495;8729.25801306896;8736.563171841382;5122.231665250168;5133.768980395891;5141.2288156776785;5151.2273159026445;5177.8187763428095;4699.2481203007355;4708.976455117771;4738.573528382393;4759.595434388047;4881.755912204376;3653.342398368319;3704.388775851954;3731.794751288651;3775.207206486614;3819.102510909934;1066.9039786419105;1093.830456279278;1153.4521102476256;1182.0779791762438;1184.7156682396162;677.7153595489906;772.3898120484754;888.3648191543077;905.909409059102;927.6660402255183;5364.865878353073;5496.395396506381;5627.493525582717;5676.489115979582;5763.88472230553;933.6032186320787;958.9760255993656;981.5975450065439;999.7300728803183;1024.7540590258284;3588.138846676779;3622.9637703623152;3761.962380376161;3788.962110378861;3842.8270727817317;9822.26333025026;10139.036791504795;10156.898431015743;10178.287519873686;10184.981501849756;9836.803263934682;10026.047525485068;10056.748581285527;10058.597656093674;10073.546690398949;6367.681615919186;7715.575643339558;7730.304272615492;7832.843343133105;7883.763487095396;5404.216388623706;5444.401115877171;5563.582731295088;5643.435656434323;5656.830295091154;7117.3238542338395;8809.251213646912;9154.084591540792;9319.767005824908;9321.72034838956;8975.281977441658;8975.28197744192;9071.138241867013;9138.31462640318;9463;7007.614581198083;7160.498765086394;7213.67538460781;7220.133583969957;7239.009272450118;7414.480986330905;7796.337311328601;7988.600569971594;8041.396895232998;8048.315893149148;7303.050603421733;7407;7486.850262994819;7551.471397002377;7576.621168941641;7290.817729556804;7320.524165929198;7366.852662946604;7383.889241661272;7403.851922961619;6245.875082498415;6301.369863013662;6356.141920840627;6393.840153996001;6427.517936154713;4987.476314986874;5001.099802035668;5022.899542009212;5062.569681577107;5084.745762711924;4470.552944705503;4896.92654610174;4922.409310882717;4984.102861484967;5089.491050894881 03:15:31 INFO - PROCESS | 1647 | |4;prototype.html;286.9569564565315;325.08974870362977;351.69051234913286;354.91659460026887;367.4103064581346;3961.7622942623425;4423.535528769481;4789.760511974405;5270.868228294295;5396.3524377074755;4305.92351912022;4892.923556817504;5395.973020134894;5409.810656627019;5425.674459532431;4272.465941757288;4290.656747460196;4301.612854843063;4305.375720520523;4313.223619748444;3543.316924460886;4264.87205383839;4300.741955482666;4310.306058713304;4332.783360831946;3725.2735716535285;3952.1741954502527;4059.6549293310104;4267.83885711432;4297.765162115698;4285.914281714364;4290.206311832306;4346.673999450054;4346.891327716832;4349.304111342201;3245.7403407727325;3834.5398552173638;3837.846486140579;3845.4231865220163;3847.5960024197334;5071.771770270347;5087.95696882142;5242.213667949838;5329.734862683344;5355.2770375999135;4467.553244675539;4692.9440875802675;4977.576905962997;4980.12847751642;4990.17662085759;5511.834644960618;5549.667019978774;5650.547956163538;5868.501177399926;5881.411858814127;3561.394562924309;3630.1832087780303;4154.335306350999;4204;4205.939089845984;4881.902361952777;5194.350706161692;5319.335083114611;5650.50261680655;5870.794522191745;3157.68423157687;3813.370793819044;4176.331786914079;4203.5376108628025;4343.2182207203;4021.3914434226544;4091.381515829871;4355.368471571668;4363.367311739843;4382.276924307517;4220.957790422057;4900.436449808247;4973.825916092992;4981.676191047571;5016.084237447322;4830.372051633335;5780.525965878758;5881;5899.439553242435;5945.086907415335;1426.9143851368951;1429.957101286963;1431.177073182924;1440.942362305496;1444.5521888214687;857.0743596915316;914.4239129348468;1005.5022763731853;1013.8492810659807;1020.3061917895902;4688.906221875543;4994.90010199794;5060.342155519759;5206.635535512478;5214.582833373321;5186.92219616706;5557.6109672323355;5767.337740534791;5821.476067153976;5828.562857785683;4823.517648235148;4949.628777841676;5011.9952019192615;5225.354013485739;5244.842654720364;2593.7017243017294;2709.8780554874684;2779.5824129694;2794.8882044717984;3019.6748503652066;5276.51749845108;5627.774889004394;5632.53554075935;5976.910346344808;6037.909431358533;5114.670185751657;5185.144451165591;5560.527355174855;6157;6172.197614310111;5026.974865125651;5680.7727690892725;5836.970815145982;6259.749610015549;6265.279492858289;4884.9985752921275;5846;5874.883772083291;5889.528837692888;6035.9094613579955;4532.98007948209;5029.421616514148;5553.694546799965;5583.609147359646;5932.228810254639;5219.0083884061905;5345.492178243061;5704.971475142764;6084.452399284086;6292.748290068346;3563.020169453421;3835.5013848199555;3956.9711874912155;4010.7794071326357;4044.8966537400975;5186.481351864783;5664.416268730374;5926.7925622603;6009.669468179292;6060.272767267956;4946.134426475281;5149.253358262956;5794.884102318014;5856.824295271149;5868.4424979626865;4558.384618076518;5211.400688920823;5430.9185362218805;5782.826515204551;5837.620554663933;5159.793608255628;5212.035773381936;5352.625316227826;5754.712264386848;5780.393058728773;4738.05238952204;5803;5848.707564621667;5891.1457838614015;5914.290285165807;4808.927866081942;4938.530839570235;5318.547923426398;5625.84670142628;5777.191193233035 03:15:31 INFO - PROCESS | 1647 | |5;yui.html;697.3967518096848;699.3950233048414;709.7586820481035;777.7200207925146;803.7387848949091;14645.340959656814;15518.84481155191;15552.53342399727;15618.297176627066;15637.296321665524;14417.495387661407;14562.417503299856;14567.198804065772;14575.34410951507;14594.927025364857;673.7002034094829;694.5207806613421;724.4421795217679;854.5300084953282;874.0647507167333;880.0803160697087;884.7345796261128;884.8318819424321;886.5655828643951;886.7694399456124;926.5876684875233;928.0209379105041;928.2017464980112;930.1814403325064;930.7347405989294;912.8128733609594;915.702396721065;918.7886786039215;919.8988111307751;920.9355345125844;680.7753441364338;681.3697329969758;681.5331497923888;682.331315310998;684.1516519515765;14917.254137293201;15416.768748468781;15435.073895566302;15488.148151851643;15770.921145394313;12060;14364.281785910767;14544.984308088695;14636.926815365961;14767.556973290819;11576.305421674642;11736.471858766376;11811.409429528576;11848.40757962107;12150.756984860252;3328.0681409205463;3332.3002169544425;3365.495175723661;3383.171123074838;3441.346144232613;102935.4853225729;105646;105777.47111264548;106081;106943.46528267386;10904.400257985886;10906.236563440641;11007.284526505911;11042.171837112248;11380.715482113013;23298.068077277057;23532;23747.525049498912;23817.166399175945;23830.16594419187;7662.310392064741;7740.6129693515095;7795.727149549739;7857.410694197958;7986.960065199753;3828;4217.1776503581505;4286.1856247313535;4295.398644189816;4307.547707490731;3543.6102028776813;3597.7661452005536;3612.512310838056;3620.3664358737115;3634.309481198564;559.9976042883275;579.3250862744856;640.7725257533601;645.8353119954381;656.8193746719691;654.1202083198091;668.9096971908828;671.5769065488711;672.2000819025344;687.4946914018193;8957.596908139149;9640.90359096414;9829.705108846745;9987.750306242402;10140.594376225015;663.4393937123124;689.8370969106602;689.8723736108836;692.1244625548685;695.09984569982;3749.893781334513;4672.415948006499;4680.742559159211;4808.543188397097;4826.131296366618;91899;94885;95646.52176739072;95695;96154.0384596145;71289.64355178295;90854.54572727095;91263;91889;93656.53171734097;82017;84811;85151.57424212963;85641.57179214065;85921.57039214889;8808;9329.207017403596;9345.906540934504;9347.672831450867;9352.859707104535;45313.32030019618;47053.29420058634;55692.72153639206;56254.249490061455;56669;54568;65180.37049073811;67598.66200669162;69883.60232795417;71664.28335716575;11723.472443740222;11743.119266055252;11888.227265227733;12282.754344912873;12306.261624302571;12056.879431205927;12164.18506247281;12171.2697238166;12183.512659493521;12698.746025079632;11839.644810655695;11850.762984740084;11895.756183535628;11905.674178828911;11951.22317049389;9694;11597.18819682614;11708.941455292668;11736.88263117358;11978.341191234565;11852.288862668267;11970.880291196976;12227.572034978733;12386.938065309616;12412.937935310265;8373.37199710012;9793.608255669978;9904.554295056596;10033.397996120257;10398.324108932895;8202.595922692017;9732.12410883024;9758.756031098996;9763.51182440861;9774.965892565477 03:15:31 INFO - PROCESS | 1647 | __end_tp_report 03:15:31 INFO - PROCESS | 1647 | __start_cc_report 03:15:31 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,373 03:15:31 INFO - PROCESS | 1647 | __end_cc_report 03:15:31 INFO - PROCESS | 1647 | __startTimestamp1484306131080__endTimestamp 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | ------- Summary: start ------- 03:15:31 INFO - PROCESS | 1647 | Number of tests: 6 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5570.57 Median:5685.26 stddev:664.73 (11.7%) stddev-sans-first:633.57 03:15:31 INFO - PROCESS | 1647 | Values: 2925.9 2928.2 3130.3 3247.4 3296.8 4758.8 5274.0 5292.5 5459.6 5612.1 5487.9 5491.6 5572.1 5629.5 5685.3 4248.5 4997.0 5108.0 5132.5 5221.1 5105.2 5166.2 5177.4 5184.9 5235.5 4667.6 5013.6 5076.7 5112.8 5159.5 5016.0 5056.4 5078.8 5099.2 5138.0 5069.3 5119.9 5142.0 5148.5 5157.4 5347.9 5455.5 5489.1 5529.7 5615.9 6046.3 6053.3 6142.6 6151.0 6153.7 6071.5 6076.1 6088.8 6113.0 6133.6 5513.1 5587.5 5591.5 5594.0 5634.0 6085.1 6123.0 6134.3 6150.8 6174.8 5822.2 5915.9 5929.7 5951.8 5969.5 5942.9 6153.7 6165.6 6180.7 6182.6 5663.7 5783.6 6002.2 6029.0 6137.2 4849.5 6077.4 6156.2 6174.1 6212.0 4795.8 4847.9 4858.0 4944.0 4952.8 4335.7 4348.6 4356.1 4390.9 4459.8 5632.5 5637.5 5659.2 5666.2 5677.5 6226.3 6242.8 6265.3 6268.6 6271.5 5474.2 5494.3 5535.8 5558.8 5611.6 5338.9 5390.6 5393.0 5420.4 5424.9 5514.5 6104.0 6194.8 6201.1 6223.2 4890.5 6037.2 6133.8 6180.6 6259.7 6141.7 6143.2 6154.3 6206.7 6234.4 6123.0 6143.8 6159.8 6171.6 6192.4 5215.3 5741.1 6065.7 6206.6 6233.7 4952.2 5936.2 5964.8 5967.8 6078.8 4770.4 6007.7 6015.0 6026.2 6033.4 5690.6 5774.2 5804.4 5928.7 5937.6 5152.8 5884.9 5936.6 6045.9 6092.2 5711.5 5750.3 5801.4 5802.5 5946.3 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:63371.28 Median:37846.12 stddev:129731.08 (342.8%) stddev-sans-first:130009.09 03:15:31 INFO - PROCESS | 1647 | Values: 486.7 497.8 504.7 517.0 527.7 33660.0 42393.2 42400.0 42580.4 44703.6 43456.0 43945.1 43950.6 43996.6 44039.6 9166.6 9349.0 9353.7 9379.1 10833.5 10892.5 11158.3 11170.3 11171.5 11209.1 9231.5 11141.0 11173.6 11182.3 11187.8 10980.6 11027.4 11047.4 11049.1 11063.6 10971.4 11022.0 11045.2 11052.6 11052.6 37538.0 37837.0 37855.2 37857.1 38423.4 3955.1 3992.0 3998.5 4049.1 4145.9 28952.7 29434.6 29543.1 29545.3 29619.3 3096.2 3226.5 3273.0 3277.3 3314.3 388127.0 441993.0 453107.0 455037.0 458101.0 47190.5 57499.7 57710.8 57996.7 58152.4 58793.4 60374.5 60938.7 60955.4 61050.4 15247.7 15410.7 15525.3 15552.8 15574.2 10798.4 11052.9 11921.5 11995.2 12273.3 18151.7 18257.6 18298.9 18407.6 18425.9 6770.2 7380.2 7629.3 7791.2 7793.3 885.7 886.5 889.3 913.5 925.3 29065.9 29777.4 30231.8 30776.8 30957.7 907.9 1038.5 1099.4 1111.0 1113.5 15493.9 15986.9 16016.1 16085.8 16373.0 567107.0 567324.0 567974.0 569330.0 570167.0 63076.0 63618.7 63701.7 63862.0 64170.0 1427.9 1460.6 1469.3 1473.9 1477.4 28677.4 29817.4 30151.2 30704.4 30740.0 53820.7 54169.9 54210.5 54450.5 54533.0 441754.0 443880.8 446059.0 446193.0 446972.0 26920.2 27180.9 27317.3 27527.7 27550.4 47494.0 48580.5 48932.5 48967.5 49063.8 38365.0 39349.0 39803.2 40679.8 40683.4 34291.1 35617.3 39182.2 39980.8 40787.6 31959.5 37761.2 38163.8 38448.6 38656.2 28257.6 32869.9 34964.8 35211.5 35350.0 20975.9 24977.8 25407.4 25462.5 25991.7 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:40534.97 Median:24757.45 stddev:115672.51 (467.2%) stddev-sans-first:115957.64 03:15:31 INFO - PROCESS | 1647 | Values: 348.7 370.2 391.3 399.8 407.1 14617.4 14673.0 18876.6 20308.4 20608.8 17002.4 20781.6 20887.8 20922.9 21663.7 5848.5 5926.8 5949.6 6069.2 6091.9 5862.3 5907.1 6014.5 6041.3 6046.8 3953.1 4133.8 5960.7 6374.4 6648.5 6474.4 6656.6 6715.6 6721.1 6738.1 5814.9 5876.1 5882.0 5884.5 5896.7 24533.1 24981.8 25128.9 25158.4 25622.7 2738.2 2798.1 2811.6 2818.6 2821.6 15792.7 15845.7 15862.4 16082.6 16485.8 1650.0 1842.1 1885.4 1894.2 1910.9 134237.0 135813.0 138713.0 157291.8 165664.0 22315.3 23090.5 23980.2 24024.9 24266.9 40921.4 41214.0 41319.0 41362.6 41621.0 8303.8 8514.2 8715.7 8839.6 8921.6 8502.3 8525.8 8536.7 8685.2 8729.9 4825.6 4873.5 4880.6 4894.7 4953.8 1797.9 2049.9 2076.6 2100.2 2102.4 988.5 992.7 1001.3 1018.7 1052.9 18081.9 20562.6 21201.7 21740.3 21750.6 1027.2 1032.3 1037.4 1051.7 1060.1 10491.1 11190.4 11243.7 11268.9 11387.9 594357.0 671359.0 709010.9 736583.0 737231.0 106186.9 117269.8 147326.0 158402.0 162767.0 996.9 997.1 1012.9 1013.3 1019.0 18913.6 18957.8 19172.6 19188.8 19189.4 61964.1 62702.0 63209.7 63537.7 65058.3 90514.0 90520.5 92250.5 92679.1 92786.0 8157.0 8157.7 8496.5 8633.6 8707.5 10782.8 10977.9 12420.8 12547.7 13086.5 10683.0 10859.7 10897.0 11004.6 11165.2 10659.1 10758.1 10935.3 10955.5 11174.8 11211.4 11244.4 11297.8 11570.5 11685.3 7321.5 8203.2 8494.7 8577.6 8619.3 9210.9 11212.7 11282.0 11377.0 11490.3 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5393.66 Median:5128.00 stddev:2938.90 (57.3%) stddev-sans-first:2931.18 03:15:31 INFO - PROCESS | 1647 | Values: 1319.2 1446.6 1457.4 1458.0 1475.0 7625.5 7881.8 8180.8 8621.4 8624.8 8091.8 8221.5 8329.5 8456.7 8470.5 2284.8 2320.7 2326.1 2327.5 2337.8 2078.5 2148.8 2306.0 2356.8 2358.3 2229.2 2291.0 2304.6 2312.3 2331.5 2300.0 2309.6 2315.9 2316.4 2317.9 1904.3 2284.5 2292.2 2301.2 2302.6 8390.6 8429.7 8477.6 8536.6 8693.8 4083.7 5031.4 5185.7 5192.7 5198.3 3385.9 3440.6 3503.4 3510.0 3525.9 1143.1 1145.7 1163.6 1182.4 1210.6 9076.4 10888.9 10957.9 10963.9 11031.1 4228.8 4455.6 4531.1 4535.0 4541.3 8633.7 8707.1 8719.4 8729.3 8736.6 5122.2 5133.8 5141.2 5151.2 5177.8 4699.2 4709.0 4738.6 4759.6 4881.8 3653.3 3704.4 3731.8 3775.2 3819.1 1066.9 1093.8 1153.5 1182.1 1184.7 677.7 772.4 888.4 905.9 927.7 5364.9 5496.4 5627.5 5676.5 5763.9 933.6 959.0 981.6 999.7 1024.8 3588.1 3623.0 3762.0 3789.0 3842.8 9822.3 10139.0 10156.9 10178.3 10185.0 9836.8 10026.0 10056.7 10058.6 10073.5 6367.7 7715.6 7730.3 7832.8 7883.8 5404.2 5444.4 5563.6 5643.4 5656.8 7117.3 8809.3 9154.1 9319.8 9321.7 8975.3 8975.3 9071.1 9138.3 9463.0 7007.6 7160.5 7213.7 7220.1 7239.0 7414.5 7796.3 7988.6 8041.4 8048.3 7303.1 7407.0 7486.9 7551.5 7576.6 7290.8 7320.5 7366.9 7383.9 7403.9 6245.9 6301.4 6356.1 6393.8 6427.5 4987.5 5001.1 5022.9 5062.6 5084.7 4470.6 4896.9 4922.4 4984.1 5089.5 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4617.22 Median:5014.04 stddev:1381.08 (27.5%) stddev-sans-first:1346.17 03:15:31 INFO - PROCESS | 1647 | Values: 287.0 325.1 351.7 354.9 367.4 3961.8 4423.5 4789.8 5270.9 5396.4 4305.9 4892.9 5396.0 5409.8 5425.7 4272.5 4290.7 4301.6 4305.4 4313.2 3543.3 4264.9 4300.7 4310.3 4332.8 3725.3 3952.2 4059.7 4267.8 4297.8 4285.9 4290.2 4346.7 4346.9 4349.3 3245.7 3834.5 3837.8 3845.4 3847.6 5071.8 5088.0 5242.2 5329.7 5355.3 4467.6 4692.9 4977.6 4980.1 4990.2 5511.8 5549.7 5650.5 5868.5 5881.4 3561.4 3630.2 4154.3 4204.0 4205.9 4881.9 5194.4 5319.3 5650.5 5870.8 3157.7 3813.4 4176.3 4203.5 4343.2 4021.4 4091.4 4355.4 4363.4 4382.3 4221.0 4900.4 4973.8 4981.7 5016.1 4830.4 5780.5 5881.0 5899.4 5945.1 1426.9 1430.0 1431.2 1440.9 1444.6 857.1 914.4 1005.5 1013.8 1020.3 4688.9 4994.9 5060.3 5206.6 5214.6 5186.9 5557.6 5767.3 5821.5 5828.6 4823.5 4949.6 5012.0 5225.4 5244.8 2593.7 2709.9 2779.6 2794.9 3019.7 5276.5 5627.8 5632.5 5976.9 6037.9 5114.7 5185.1 5560.5 6157.0 6172.2 5027.0 5680.8 5837.0 6259.7 6265.3 4885.0 5846.0 5874.9 5889.5 6035.9 4533.0 5029.4 5553.7 5583.6 5932.2 5219.0 5345.5 5705.0 6084.5 6292.7 3563.0 3835.5 3957.0 4010.8 4044.9 5186.5 5664.4 5926.8 6009.7 6060.3 4946.1 5149.3 5794.9 5856.8 5868.4 4558.4 5211.4 5430.9 5782.8 5837.6 5159.8 5212.0 5352.6 5754.7 5780.4 4738.1 5803.0 5848.7 5891.1 5914.3 4808.9 4938.5 5318.5 5625.8 5777.2 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:20135.75 Median:28126.36 stddev:29192.58 (103.8%) stddev-sans-first:29237.99 03:15:31 INFO - PROCESS | 1647 | Values: 697.4 699.4 709.8 777.7 803.7 14645.3 15518.8 15552.5 15618.3 15637.3 14417.5 14562.4 14567.2 14575.3 14594.9 673.7 694.5 724.4 854.5 874.1 880.1 884.7 884.8 886.6 886.8 926.6 928.0 928.2 930.2 930.7 912.8 915.7 918.8 919.9 920.9 680.8 681.4 681.5 682.3 684.2 14917.3 15416.8 15435.1 15488.1 15770.9 12060.0 14364.3 14545.0 14636.9 14767.6 11576.3 11736.5 11811.4 11848.4 12150.8 3328.1 3332.3 3365.5 3383.2 3441.3 102935.5 105646.0 105777.5 106081.0 106943.5 10904.4 10906.2 11007.3 11042.2 11380.7 23298.1 23532.0 23747.5 23817.2 23830.2 7662.3 7740.6 7795.7 7857.4 7987.0 3828.0 4217.2 4286.2 4295.4 4307.5 3543.6 3597.8 3612.5 3620.4 3634.3 560.0 579.3 640.8 645.8 656.8 654.1 668.9 671.6 672.2 687.5 8957.6 9640.9 9829.7 9987.8 10140.6 663.4 689.8 689.9 692.1 695.1 3749.9 4672.4 4680.7 4808.5 4826.1 91899.0 94885.0 95646.5 95695.0 96154.0 71289.6 90854.5 91263.0 91889.0 93656.5 82017.0 84811.0 85151.6 85641.6 85921.6 8808.0 9329.2 9345.9 9347.7 9352.9 45313.3 47053.3 55692.7 56254.2 56669.0 54568.0 65180.4 67598.7 69883.6 71664.3 11723.5 11743.1 11888.2 12282.8 12306.3 12056.9 12164.2 12171.3 12183.5 12698.7 11839.6 11850.8 11895.8 11905.7 11951.2 9694.0 11597.2 11708.9 11736.9 11978.3 11852.3 11970.9 12227.6 12386.9 12412.9 8373.4 9793.6 9904.6 10033.4 10398.3 8202.6 9732.1 9758.8 9763.5 9775.0 03:15:31 INFO - PROCESS | 1647 | -------- Summary: end -------- 03:15:31 INFO - PROCESS | 1647 | 03:15:31 INFO - TEST-INFO | 1647: exit 0 03:15:31 INFO - TEST-OK | dromaeo_css | took 1115206ms 03:15:31 INFO - TEST-START | kraken 03:15:31 INFO - operating with platform_type : mac_ 03:15:31 INFO - Initialising browser for kraken test... 03:15:31 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpk4YsUV/profile http://localhost:49248/getInfo.html) 03:15:34 INFO - PROCESS | 1659 | 2017-01-13 03:15:34.308 plugin-container[1660:10789] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 03:15:34 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:15:34 INFO - PROCESS | 1659 | 2017-01-13 03:15:34.312 plugin-container[1660:10789] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 03:15:34 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:15:34 INFO - PROCESS | 1659 | 2017-01-13 03:15:34.312 plugin-container[1660:10789] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:15:34 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:15:34 INFO - PROCESS | 1659 | colorDepth:24 03:15:34 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:15:34 INFO - PROCESS | 1659 | __metrics 03:15:34 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 03:15:35 INFO - TEST-INFO | 1659: exit 0 03:15:35 INFO - Browser initialized. 03:15:35 INFO - Running cycle 1/1 for kraken test... 03:15:35 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpk4YsUV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:37 INFO - PROCESS | 1661 | 2017-01-13 03:15:37.740 plugin-container[1662:10904] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 03:15:37 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:15:37 INFO - PROCESS | 1661 | 2017-01-13 03:15:37.741 plugin-container[1662:10904] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 03:15:37 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:15:37 INFO - PROCESS | 1661 | 2017-01-13 03:15:37.741 plugin-container[1662:10904] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:15:47 INFO - PROCESS | 1661 | RSS: Main: 233598976 03:15:47 INFO - PROCESS | 1661 | 03:15:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:51 INFO - PROCESS | 1661 | RSS: Main: 246374400 03:15:51 INFO - PROCESS | 1661 | 03:15:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 03:15:54 INFO - PROCESS | 1661 | RSS: Main: 254398464 03:15:54 INFO - PROCESS | 1661 | 03:15:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 03:15:58 INFO - PROCESS | 1661 | RSS: Main: 256901120 03:15:58 INFO - PROCESS | 1661 | 03:16:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 03:16:01 INFO - PROCESS | 1661 | RSS: Main: 259162112 03:16:01 INFO - PROCESS | 1661 | 03:16:03 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:03 INFO - PROCESS | 1661 | RSS: Main: 259788800 03:16:03 INFO - PROCESS | 1661 | 03:16:06 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 03:16:07 INFO - PROCESS | 1661 | RSS: Main: 265674752 03:16:07 INFO - PROCESS | 1661 | 03:16:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:11 INFO - PROCESS | 1661 | RSS: Main: 264609792 03:16:11 INFO - PROCESS | 1661 | 03:16:13 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 03:16:14 INFO - PROCESS | 1661 | RSS: Main: 264458240 03:16:14 INFO - PROCESS | 1661 | 03:16:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:16 INFO - PROCESS | 1661 | RSS: Main: 264019968 03:16:16 INFO - PROCESS | 1661 | 03:16:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:19 INFO - PROCESS | 1661 | RSS: Main: 264044544 03:16:19 INFO - PROCESS | 1661 | 03:16:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:22 INFO - PROCESS | 1661 | RSS: Main: 264028160 03:16:22 INFO - PROCESS | 1661 | 03:16:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:26 INFO - PROCESS | 1661 | RSS: Main: 264278016 03:16:26 INFO - PROCESS | 1661 | 03:16:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:29 INFO - PROCESS | 1661 | RSS: Main: 272310272 03:16:29 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 03:16:31 INFO - PROCESS | 1661 | RSS: Main: 273739776 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | __start_tp_report 03:16:31 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 03:16:31 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 03:16:31 INFO - PROCESS | 1661 | |i|pagename|runs| 03:16:31 INFO - PROCESS | 1661 | |0;ai-astar;111;117;119;118;119;119;118;120;122;121 03:16:31 INFO - PROCESS | 1661 | |1;audio-beat-detection;142;115;113;150;124;126;114;112;146;141 03:16:31 INFO - PROCESS | 1661 | |2;audio-dft;198;220;250;279;203;285;288;199;198;200 03:16:31 INFO - PROCESS | 1661 | |3;audio-fft;82;60;60;95;74;81;64;75;94;81 03:16:31 INFO - PROCESS | 1661 | |4;audio-oscillator;87;72;87;72;72;71;83;69;72;82 03:16:31 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;102;112;90;88;100;88;93;89;93;88 03:16:31 INFO - PROCESS | 1661 | |6;imaging-darkroom;101;100;102;101;102;101;101;101;100;115 03:16:31 INFO - PROCESS | 1661 | |7;imaging-desaturate;93;92;94;94;96;91;92;115;142;108 03:16:31 INFO - PROCESS | 1661 | |8;json-parse-financial;62;61;60;64;63;62;88;89;91;92 03:16:31 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;69;68;78;85;84;73;70;70;75;72 03:16:31 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;88;106;112;107;79;98;111;106;89;86 03:16:31 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;155;146;151;161;149;134;146;148;212;184 03:16:31 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;176;177;173;176;176;177;175;178;183;180 03:16:31 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;68;69;66;70;69;66;69;67;68;70 03:16:31 INFO - PROCESS | 1661 | __end_tp_report 03:16:31 INFO - PROCESS | 1661 | __start_cc_report 03:16:31 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,921 03:16:31 INFO - PROCESS | 1661 | __end_cc_report 03:16:31 INFO - PROCESS | 1661 | __startTimestamp1484306191876__endTimestamp 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | ------- Summary: start ------- 03:16:31 INFO - PROCESS | 1661 | Number of tests: 14 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:118.40 Median:119.00 stddev:2.99 (2.5%) stddev-sans-first:1.56 03:16:31 INFO - PROCESS | 1661 | Values: 111.0 117.0 119.0 118.0 119.0 119.0 118.0 120.0 122.0 121.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:133.50 stddev:15.05 (11.3%) stddev-sans-first:15.12 03:16:31 INFO - PROCESS | 1661 | Values: 142.0 115.0 113.0 150.0 124.0 126.0 114.0 112.0 146.0 141.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:232.00 Median:235.00 stddev:39.28 (16.7%) stddev-sans-first:39.69 03:16:31 INFO - PROCESS | 1661 | Values: 198.0 220.0 250.0 279.0 203.0 285.0 288.0 199.0 198.0 200.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:76.60 Median:81.00 stddev:12.60 (15.6%) stddev-sans-first:13.21 03:16:31 INFO - PROCESS | 1661 | Values: 82.0 60.0 60.0 95.0 74.0 81.0 64.0 75.0 94.0 81.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.00 stddev:7.15 (9.3%) stddev-sans-first:6.54 03:16:31 INFO - PROCESS | 1661 | Values: 87.0 72.0 87.0 72.0 72.0 71.0 83.0 69.0 72.0 82.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:88.50 stddev:7.99 (9.0%) stddev-sans-first:7.97 03:16:31 INFO - PROCESS | 1661 | Values: 102.0 112.0 90.0 88.0 100.0 88.0 93.0 89.0 93.0 88.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:101.00 stddev:4.48 (4.4%) stddev-sans-first:4.72 03:16:31 INFO - PROCESS | 1661 | Values: 101.0 100.0 102.0 101.0 102.0 101.0 101.0 101.0 100.0 115.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:92.50 stddev:16.23 (17.5%) stddev-sans-first:16.90 03:16:31 INFO - PROCESS | 1661 | Values: 93.0 92.0 94.0 94.0 96.0 91.0 92.0 115.0 142.0 108.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:73.20 Median:76.00 stddev:14.54 (19.1%) stddev-sans-first:14.84 03:16:31 INFO - PROCESS | 1661 | Values: 62.0 61.0 60.0 64.0 63.0 62.0 88.0 89.0 91.0 92.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.00 stddev:6.10 (8.2%) stddev-sans-first:6.14 03:16:31 INFO - PROCESS | 1661 | Values: 69.0 68.0 78.0 85.0 84.0 73.0 70.0 70.0 75.0 72.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:98.20 Median:82.50 stddev:11.83 (14.3%) stddev-sans-first:11.96 03:16:31 INFO - PROCESS | 1661 | Values: 88.0 106.0 112.0 107.0 79.0 98.0 111.0 106.0 89.0 86.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:153.00 stddev:22.85 (14.9%) stddev-sans-first:24.20 03:16:31 INFO - PROCESS | 1661 | Values: 155.0 146.0 151.0 161.0 149.0 134.0 146.0 148.0 212.0 184.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.00 stddev:2.77 (1.6%) stddev-sans-first:2.91 03:16:31 INFO - PROCESS | 1661 | Values: 176.0 177.0 173.0 176.0 176.0 177.0 175.0 178.0 183.0 180.0 03:16:31 INFO - PROCESS | 1661 | 03:16:31 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 03:16:31 INFO - PROCESS | 1661 | Values: 68.0 69.0 66.0 70.0 69.0 66.0 69.0 67.0 68.0 70.0 03:16:31 INFO - PROCESS | 1661 | -------- Summary: end -------- 03:16:31 INFO - PROCESS | 1661 | 03:16:32 INFO - TEST-INFO | 1661: exit 0 03:16:32 INFO - TEST-OK | kraken | took 61039ms 03:16:32 INFO - SUITE-END | took 1176s 03:16:33 INFO - Completed test suite (00:19:36) 03:16:33 INFO - javascript benchmark 03:16:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7340.536645036044, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2925.882964681413, 2928.238657948934, 3130.311331507069, 3247.3667634811213, 3296.76922615417, 4758.8102974256435, 5274.0, 5292.523672869445, 5459.617826752129, 5612.102063669803, 5487.890242195163, 5491.560675145989, 5572.080606699889, 5629.4652008059165, 5685.260916080903, 4248.511421186557, 4997.0, 5108.0, 5132.5124113209185, 5221.086309895772, 5105.208692652626, 5166.17341225404, 5177.430482646906, 5184.896302073957, 5235.450277720842, 4667.55658212471, 5013.6490445668815, 5076.695398276097, 5112.795488180505, 5159.458256883011, 5016.0, 5056.367954005749, 5078.847634570969, 5099.235114732783, 5138.049460849755, 5069.340985671876, 5119.923201151985, 5142.0, 5148.459411761749, 5157.355330583677, 5347.946520534783, 5455.454454554552, 5489.149181876815, 5529.723513824292, 5615.887682246373, 6046.27444706638, 6053.334133245339, 6142.6314421134875, 6151.0, 6153.692315384213, 6071.483923866476, 6076.088586711984, 6088.756449742005, 6112.959454150325, 6133.570650054498, 5513.117901135799, 5587.469190426903, 5591.4688104629995, 5594.0, 5633.971830140823, 6085.056816193497, 6123.0, 6134.294556126013, 6150.846228844225, 6174.845628859314, 5822.155787410802, 5915.911261331084, 5929.73316200772, 5951.791687290924, 5969.462748352669, 5942.851428714317, 6153.692315384213, 6165.568410211242, 6180.66006369645, 6182.60891299454, 5663.716814159358, 5783.59514833966, 6002.249718785152, 6029.0, 6137.1624860202055, 4849.515048495122, 6077.36187700294, 6156.168917196122, 6174.104754810527, 6211.9689401553605, 4795.760211989386, 4847.903041939141, 4858.02839432115, 4944.0, 4952.801887924443, 4335.7181783184, 4348.608625223745, 4356.128774245164, 4390.890227744332, 4459.821607135678, 5632.493075623213, 5637.49262566371, 5659.151127330933, 5666.178404131378, 5677.51741102011, 6226.315105338409, 6242.781502647385, 6265.310815810257, 6268.561200715997, 6271.529635277372, 5474.151506516497, 5494.340679118452, 5535.806246781343, 5558.777648893999, 5611.6071874969175, 5338.866528336823, 5390.622656414092, 5392.973035134878, 5420.430854760193, 5424.891502169935, 5514.503694667339, 6104.0, 6194.81415557534, 6201.10084037821, 6223.159873417031, 4890.486498917705, 6037.18498002764, 6133.815985520441, 6180.598261113013, 6259.749610015549, 6141.670122563672, 6143.204841796883, 6154.292256390572, 6206.658633775005, 6234.438900498977, 6122.969385153046, 6143.784967526115, 6159.784407545893, 6171.56799024064, 6192.411720886508, 5215.322008138917, 5741.080732397029, 6065.6663883486835, 6206.596571222856, 6233.688315584112, 4952.232403977389, 5936.168936349001, 5964.7912323068485, 5967.76128954837, 6078.787242446493, 4770.403699537558, 6007.699615019319, 6014.969925150346, 6026.246719160105, 6033.396660333931, 5690.630109042899, 5774.162746401832, 5804.361520232856, 5928.703564821828, 5937.643741375531, 5152.8148525840015, 5884.911726324194, 5936.643801371932, 6045.909311360245, 6092.238470191226, 5711.457411545896, 5750.25246717924, 5801.3908539602735, 5802.506786923159, 5946.316173639913], "value": 5527.896544297176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.69824708680625, 497.7560995112395, 504.6543117964194, 517.0228268572399, 527.6939375162401, 33659.97060264576, 42393.15213695732, 42400.0, 42580.36129458061, 44703.55296447034, 43456.0, 43945.12109757803, 43950.560494395046, 43996.56003439965, 44039.55960440395, 9166.587503562323, 9349.0, 9353.719388418358, 9379.062093790635, 10833.458327083654, 10892.509837057352, 11158.274712143684, 11170.27393219438, 11171.49728262226, 11209.103271738242, 9231.492267925261, 11140.997310242077, 11173.553057877674, 11182.32906025637, 11187.776244475106, 10980.560777568888, 11027.44862756867, 11047.447627618667, 11049.116070714324, 11063.612773552968, 10971.354296855456, 11022.0, 11045.226834121615, 11052.557897684082, 11052.557897684082, 37538.0, 37837.0, 37855.24289514222, 37857.05357366088, 38423.423648645294, 3955.0903292242947, 3992.041909941622, 3998.52017757868, 4049.088954985134, 4145.854895078688, 28952.710472895422, 29434.558481622793, 29543.091381723527, 29545.261368465744, 29619.259518512208, 3096.2259435141214, 3226.4837625979967, 3272.96727032729, 3277.2953814929906, 3314.254292784128, 388127.0, 441993.0, 453107.0, 455037.0, 458101.0, 47190.52809471861, 57499.712501438065, 57710.845783084944, 57996.710016449644, 58152.4184758147, 58793.412065878794, 60374.49063773353, 60938.69530652319, 60955.39044609586, 61050.38949610447, 15247.695046099238, 15410.691786164214, 15525.301361438762, 15552.84447155514, 15574.221288935509, 10798.352098873935, 11052.944735276273, 11921.463534140985, 11995.220310679779, 12273.324967126893, 18151.72772408415, 18257.63484730298, 18298.90206587609, 18407.631847362976, 18425.907870460564, 6770.1537307836525, 7380.225076367012, 7629.2752188542, 7791.181925897812, 7793.3113075988695, 885.6545947080643, 886.4548302793864, 889.3107841422949, 913.5432283858071, 925.2829057480371, 29065.854670726512, 29777.40445191084, 30231.848840756094, 30776.846115769276, 30957.690423095482, 907.8865141857268, 1038.48075962019, 1099.3513826842202, 1111.0056499432962, 1113.5323164271026, 15493.922530387275, 15986.920065399598, 16016.11911344864, 16085.839141608434, 16373.0, 567107.0, 567324.0, 567974.0, 569330.0, 570167.0, 63076.0, 63618.68190659017, 63701.681491593175, 63862.042069368996, 64170.0, 1427.9085779287932, 1460.5545308680742, 1469.2506821521101, 1473.9336729847398, 1477.416420513891, 28677.426451470437, 29817.403651926405, 30151.246218843826, 30704.385912282076, 30740.0, 53820.73089634527, 54169.916601668534, 54210.45789542054, 54450.45549544454, 54533.0, 441754.0, 443880.78059609496, 446059.0, 446193.0, 446972.0, 26920.192394228205, 27180.864095680186, 27317.317067073483, 27527.73320135382, 27550.448991019668, 47493.98009085801, 48580.5141948576, 48932.532024039334, 48967.51032489629, 49063.773405665146, 38365.0, 39349.0, 39803.20393592054, 40679.7966010168, 40683.3897491532, 34291.14272143217, 35617.28765424729, 39182.2163556733, 39980.80009599934, 40787.59212407838, 31959.520607190447, 37761.2447751049, 38163.80918095392, 38448.6155138445, 38656.22687546177, 28257.57613635756, 32869.89126359205, 34964.825175874976, 35211.47182792312, 35350.0, 20975.8951205243, 24977.75022249827, 25407.36481587975, 25462.490750184523, 25991.74008259893], "value": 20030.015425130252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7192809788121, 370.2465482742619, 391.3093390166359, 399.756148749263, 407.1023393417515, 14617.415303387852, 14673.046251993639, 18876.622467550642, 20308.39074827754, 20608.793912060893, 17002.40491582795, 20781.584368312626, 20887.791122088776, 20922.89538552309, 21663.67504487434, 5848.502877255439, 5926.822195334147, 5949.560680121152, 6069.211002569682, 6091.939080609203, 5862.325832529271, 5907.0548712206055, 6014.458698717114, 6041.275046994367, 6046.7883624073165, 3953.051267695761, 4133.813978370966, 5960.701964901759, 6374.362563743612, 6648.468122550208, 6474.384933431316, 6656.567323123982, 6715.56348837324, 6721.059051732761, 6738.056672065914, 5814.912776308359, 5876.147958546029, 5882.0, 5884.499817515516, 5896.734646940898, 24533.14134005319, 24981.750182498123, 25128.874355628104, 25158.371040723945, 25622.743772562222, 2738.2332946774936, 2798.1325789005473, 2811.6063751074867, 2818.633577634894, 2821.5626577880257, 15792.68414631701, 15845.683086338324, 15862.44481443144, 16082.5979350516, 16485.83514164855, 1649.9505014849453, 1842.1157844234708, 1885.4249453916686, 1894.2139012309874, 1910.9140088696042, 134237.0, 135812.962805558, 138713.0, 157291.8437340645, 165664.0, 22315.330540083498, 23090.538189236457, 23980.16813106618, 24024.87987560051, 24266.878665606913, 40921.38617920734, 41213.96965075837, 41318.9670258246, 41362.586374136474, 41621.0, 8303.8339233215, 8514.191151840565, 8715.738527844174, 8839.646414143492, 8921.598528066253, 8502.319814414832, 8525.786855328666, 8536.74389768308, 8685.174908383693, 8729.869051964226, 4825.5898248649255, 4873.463918968911, 4880.6095512358925, 4894.657373983858, 4953.826616068421, 1797.9032789998091, 2049.928252511155, 2076.5535409886947, 2100.2334148035857, 2102.3903068110076, 988.515627342597, 992.6624947517879, 1001.2740762946805, 1018.6943916824923, 1052.9315594486334, 18081.91508509467, 20562.588748224953, 21201.681974770392, 21740.347789566338, 21750.56498870014, 1027.1885210683627, 1032.2825636182781, 1037.4034929915329, 1051.695008447557, 1060.0936199549428, 10491.055804977588, 11190.440477976232, 11243.718907027389, 11268.943655281671, 11387.886121138848, 594357.0, 671359.0, 709010.9098908945, 736583.0, 737231.0, 106186.93813061925, 117269.8273017276, 147326.0, 158402.0, 162767.0, 996.9351992120489, 997.1075887081022, 1012.9290949633603, 1013.2755080117752, 1019.0013786489282, 18913.621727565645, 18957.810421895603, 19172.616547669248, 19188.8081119187, 19189.424317270503, 61964.1410757678, 62702.0, 63209.68395157995, 63537.68231158815, 65058.349416507124, 90514.0, 90520.54739726259, 92250.53874730584, 92679.07320926705, 92786.0, 8157.0, 8157.673693052211, 8496.53269070207, 8633.611487483204, 8707.47755134694, 10782.838257425989, 10977.890221098007, 12420.751584968431, 12547.686307842012, 13086.541971030969, 10683.0, 10859.674209773719, 10897.0, 11004.559817607205, 11165.218434709492, 10659.14726821868, 10758.13934885223, 10935.28920620157, 10955.50700218508, 11174.776504470028, 11211.439428028403, 11244.381559014333, 11297.774044519228, 11570.537178512765, 11685.298882067103, 7321.487495875238, 8203.220694034057, 8494.70268540598, 8577.571121444027, 8619.310455163697, 9210.861837072584, 11212.66362009141, 11282.0, 11377.032952198824, 11490.253133546294], "value": 10564.673810085738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.2084749150508, 1446.587722499088, 1457.351478592027, 1457.9648449600784, 1474.970500589988, 7625.504342217766, 7881.763547093582, 8180.836383272331, 8621.353398495123, 8624.827503449935, 8091.757247282576, 8221.506709597428, 8329.458585191958, 8456.704015359464, 8470.534120623362, 2284.760100189481, 2320.7331156916916, 2326.1160758911674, 2327.534493101378, 2337.754535773745, 2078.511549785799, 2148.7528934172537, 2306.0, 2356.8114550835976, 2358.280724379072, 2229.1974889039934, 2290.9885450572724, 2304.573653874039, 2312.2600767754243, 2331.5453486570127, 2299.9540009199804, 2309.6304591265484, 2315.895784689693, 2316.420894776306, 2317.9420514487274, 1904.2763749774997, 2284.463151159476, 2292.2091878302126, 2301.1945818963227, 2302.643090321003, 8390.622421991025, 8429.747107586782, 8477.618507167192, 8536.6158522866, 8693.826123477558, 4083.7141400102005, 5031.4465408805, 5185.740712964337, 5192.714400707997, 5198.298229739013, 3385.86456541738, 3440.587129544446, 3503.3693935091674, 3510.0347404463723, 3525.9118522036897, 1143.085531574737, 1145.7078444996473, 1163.6101905861547, 1182.3969775414514, 1210.6005018343926, 9076.36465447419, 10888.891111088868, 10957.945210273898, 10963.890361096366, 11031.062359699436, 4228.830846766156, 4455.598996090367, 4531.116432295737, 4534.977325113353, 4541.296099104644, 8633.654653813903, 8707.12928707137, 8719.38964272495, 8729.25801306896, 8736.563171841382, 5122.231665250168, 5133.768980395891, 5141.2288156776785, 5151.2273159026445, 5177.8187763428095, 4699.2481203007355, 4708.976455117771, 4738.573528382393, 4759.595434388047, 4881.755912204376, 3653.342398368319, 3704.388775851954, 3731.794751288651, 3775.207206486614, 3819.102510909934, 1066.9039786419105, 1093.830456279278, 1153.4521102476256, 1182.0779791762438, 1184.7156682396162, 677.7153595489906, 772.3898120484754, 888.3648191543077, 905.909409059102, 927.6660402255183, 5364.865878353073, 5496.395396506381, 5627.493525582717, 5676.489115979582, 5763.88472230553, 933.6032186320787, 958.9760255993656, 981.5975450065439, 999.7300728803183, 1024.7540590258284, 3588.138846676779, 3622.9637703623152, 3761.962380376161, 3788.962110378861, 3842.8270727817317, 9822.26333025026, 10139.036791504795, 10156.898431015743, 10178.287519873686, 10184.981501849756, 9836.803263934682, 10026.047525485068, 10056.748581285527, 10058.597656093674, 10073.546690398949, 6367.681615919186, 7715.575643339558, 7730.304272615492, 7832.843343133105, 7883.763487095396, 5404.216388623706, 5444.401115877171, 5563.582731295088, 5643.435656434323, 5656.830295091154, 7117.3238542338395, 8809.251213646912, 9154.084591540792, 9319.767005824908, 9321.72034838956, 8975.281977441658, 8975.28197744192, 9071.138241867013, 9138.31462640318, 9463.0, 7007.614581198083, 7160.498765086394, 7213.67538460781, 7220.133583969957, 7239.009272450118, 7414.480986330905, 7796.337311328601, 7988.600569971594, 8041.396895232998, 8048.315893149148, 7303.050603421733, 7407.0, 7486.850262994819, 7551.471397002377, 7576.621168941641, 7290.817729556804, 7320.524165929198, 7366.852662946604, 7383.889241661272, 7403.851922961619, 6245.875082498415, 6301.369863013662, 6356.141920840627, 6393.840153996001, 6427.517936154713, 4987.476314986874, 5001.099802035668, 5022.899542009212, 5062.569681577107, 5084.745762711924, 4470.552944705503, 4896.92654610174, 4922.409310882717, 4984.102861484967, 5089.491050894881], "value": 4375.746502856061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.9569564565315, 325.08974870362977, 351.69051234913286, 354.91659460026887, 367.4103064581346, 3961.7622942623425, 4423.535528769481, 4789.760511974405, 5270.868228294295, 5396.3524377074755, 4305.92351912022, 4892.923556817504, 5395.973020134894, 5409.810656627019, 5425.674459532431, 4272.465941757288, 4290.656747460196, 4301.612854843063, 4305.375720520523, 4313.223619748444, 3543.316924460886, 4264.87205383839, 4300.741955482666, 4310.306058713304, 4332.783360831946, 3725.2735716535285, 3952.1741954502527, 4059.6549293310104, 4267.83885711432, 4297.765162115698, 4285.914281714364, 4290.206311832306, 4346.673999450054, 4346.891327716832, 4349.304111342201, 3245.7403407727325, 3834.5398552173638, 3837.846486140579, 3845.4231865220163, 3847.5960024197334, 5071.771770270347, 5087.95696882142, 5242.213667949838, 5329.734862683344, 5355.2770375999135, 4467.553244675539, 4692.9440875802675, 4977.576905962997, 4980.12847751642, 4990.17662085759, 5511.834644960618, 5549.667019978774, 5650.547956163538, 5868.501177399926, 5881.411858814127, 3561.394562924309, 3630.1832087780303, 4154.335306350999, 4204.0, 4205.939089845984, 4881.902361952777, 5194.350706161692, 5319.335083114611, 5650.50261680655, 5870.794522191745, 3157.68423157687, 3813.370793819044, 4176.331786914079, 4203.5376108628025, 4343.2182207203, 4021.3914434226544, 4091.381515829871, 4355.368471571668, 4363.367311739843, 4382.276924307517, 4220.957790422057, 4900.436449808247, 4973.825916092992, 4981.676191047571, 5016.084237447322, 4830.372051633335, 5780.525965878758, 5881.0, 5899.439553242435, 5945.086907415335, 1426.9143851368951, 1429.957101286963, 1431.177073182924, 1440.942362305496, 1444.5521888214687, 857.0743596915316, 914.4239129348468, 1005.5022763731853, 1013.8492810659807, 1020.3061917895902, 4688.906221875543, 4994.90010199794, 5060.342155519759, 5206.635535512478, 5214.582833373321, 5186.92219616706, 5557.6109672323355, 5767.337740534791, 5821.476067153976, 5828.562857785683, 4823.517648235148, 4949.628777841676, 5011.9952019192615, 5225.354013485739, 5244.842654720364, 2593.7017243017294, 2709.8780554874684, 2779.5824129694, 2794.8882044717984, 3019.6748503652066, 5276.51749845108, 5627.774889004394, 5632.53554075935, 5976.910346344808, 6037.909431358533, 5114.670185751657, 5185.144451165591, 5560.527355174855, 6157.0, 6172.197614310111, 5026.974865125651, 5680.7727690892725, 5836.970815145982, 6259.749610015549, 6265.279492858289, 4884.9985752921275, 5846.0, 5874.883772083291, 5889.528837692888, 6035.9094613579955, 4532.98007948209, 5029.421616514148, 5553.694546799965, 5583.609147359646, 5932.228810254639, 5219.0083884061905, 5345.492178243061, 5704.971475142764, 6084.452399284086, 6292.748290068346, 3563.020169453421, 3835.5013848199555, 3956.9711874912155, 4010.7794071326357, 4044.8966537400975, 5186.481351864783, 5664.416268730374, 5926.7925622603, 6009.669468179292, 6060.272767267956, 4946.134426475281, 5149.253358262956, 5794.884102318014, 5856.824295271149, 5868.4424979626865, 4558.384618076518, 5211.400688920823, 5430.9185362218805, 5782.826515204551, 5837.620554663933, 5159.793608255628, 5212.035773381936, 5352.625316227826, 5754.712264386848, 5780.393058728773, 4738.05238952204, 5803.0, 5848.707564621667, 5891.1457838614015, 5914.290285165807, 4808.927866081942, 4938.530839570235, 5318.547923426398, 5625.84670142628, 5777.191193233035], "value": 4192.750334818698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3967518096848, 699.3950233048414, 709.7586820481035, 777.7200207925146, 803.7387848949091, 14645.340959656814, 15518.84481155191, 15552.53342399727, 15618.297176627066, 15637.296321665524, 14417.495387661407, 14562.417503299856, 14567.198804065772, 14575.34410951507, 14594.927025364857, 673.7002034094829, 694.5207806613421, 724.4421795217679, 854.5300084953282, 874.0647507167333, 880.0803160697087, 884.7345796261128, 884.8318819424321, 886.5655828643951, 886.7694399456124, 926.5876684875233, 928.0209379105041, 928.2017464980112, 930.1814403325064, 930.7347405989294, 912.8128733609594, 915.702396721065, 918.7886786039215, 919.8988111307751, 920.9355345125844, 680.7753441364338, 681.3697329969758, 681.5331497923888, 682.331315310998, 684.1516519515765, 14917.254137293201, 15416.768748468781, 15435.073895566302, 15488.148151851643, 15770.921145394313, 12060.0, 14364.281785910767, 14544.984308088695, 14636.926815365961, 14767.556973290819, 11576.305421674642, 11736.471858766376, 11811.409429528576, 11848.40757962107, 12150.756984860252, 3328.0681409205463, 3332.3002169544425, 3365.495175723661, 3383.171123074838, 3441.346144232613, 102935.4853225729, 105646.0, 105777.47111264548, 106081.0, 106943.46528267386, 10904.400257985886, 10906.236563440641, 11007.284526505911, 11042.171837112248, 11380.715482113013, 23298.068077277057, 23532.0, 23747.525049498912, 23817.166399175945, 23830.16594419187, 7662.310392064741, 7740.6129693515095, 7795.727149549739, 7857.410694197958, 7986.960065199753, 3828.0, 4217.1776503581505, 4286.1856247313535, 4295.398644189816, 4307.547707490731, 3543.6102028776813, 3597.7661452005536, 3612.512310838056, 3620.3664358737115, 3634.309481198564, 559.9976042883275, 579.3250862744856, 640.7725257533601, 645.8353119954381, 656.8193746719691, 654.1202083198091, 668.9096971908828, 671.5769065488711, 672.2000819025344, 687.4946914018193, 8957.596908139149, 9640.90359096414, 9829.705108846745, 9987.750306242402, 10140.594376225015, 663.4393937123124, 689.8370969106602, 689.8723736108836, 692.1244625548685, 695.09984569982, 3749.893781334513, 4672.415948006499, 4680.742559159211, 4808.543188397097, 4826.131296366618, 91899.0, 94885.0, 95646.52176739072, 95695.0, 96154.0384596145, 71289.64355178295, 90854.54572727095, 91263.0, 91889.0, 93656.53171734097, 82017.0, 84811.0, 85151.57424212963, 85641.57179214065, 85921.57039214889, 8808.0, 9329.207017403596, 9345.906540934504, 9347.672831450867, 9352.859707104535, 45313.32030019618, 47053.29420058634, 55692.72153639206, 56254.249490061455, 56669.0, 54568.0, 65180.37049073811, 67598.66200669162, 69883.60232795417, 71664.28335716575, 11723.472443740222, 11743.119266055252, 11888.227265227733, 12282.754344912873, 12306.261624302571, 12056.879431205927, 12164.18506247281, 12171.2697238166, 12183.512659493521, 12698.746025079632, 11839.644810655695, 11850.762984740084, 11895.756183535628, 11905.674178828911, 11951.22317049389, 9694.0, 11597.18819682614, 11708.941455292668, 11736.88263117358, 11978.341191234565, 11852.288862668267, 11970.880291196976, 12227.572034978733, 12386.938065309616, 12412.937935310265, 8373.37199710012, 9793.608255669978, 9904.554295056596, 10033.397996120257, 10398.324108932895, 8202.595922692017, 9732.12410883024, 9758.756031098996, 9763.51182440861, 9774.965892565477], "value": 7289.028599248428, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 119.0, 118.0, 119.0, 119.0, 118.0, 120.0, 122.0, 121.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 113.0, 150.0, 124.0, 126.0, 114.0, 112.0, 146.0, 141.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 220.0, 250.0, 279.0, 203.0, 285.0, 288.0, 199.0, 198.0, 200.0], "value": 232.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 95.0, 74.0, 81.0, 64.0, 75.0, 94.0, 81.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 87.0, 72.0, 72.0, 71.0, 83.0, 69.0, 72.0, 82.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 90.0, 88.0, 100.0, 88.0, 93.0, 89.0, 93.0, 88.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 102.0, 101.0, 102.0, 101.0, 101.0, 101.0, 100.0, 115.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 94.0, 96.0, 91.0, 92.0, 115.0, 142.0, 108.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 64.0, 63.0, 62.0, 88.0, 89.0, 91.0, 92.0], "value": 73.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 78.0, 85.0, 84.0, 73.0, 70.0, 70.0, 75.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 106.0, 112.0, 107.0, 79.0, 98.0, 111.0, 106.0, 89.0, 86.0], "value": 98.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 146.0, 151.0, 161.0, 149.0, 134.0, 146.0, 148.0, 212.0, 184.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 173.0, 176.0, 176.0, 177.0, 175.0, 178.0, 183.0, 180.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 70.0, 69.0, 66.0, 69.0, 67.0, 68.0, 70.0], "value": 68.2, "unit": "score"}]}]} 03:16:33 INFO - Return code: 0 03:16:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:33 ERROR - # TBPL SUCCESS # 03:16:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:33 INFO - 2017-01-13 03:16:33.181 screenresolution[1666:11305] starting screenresolution argv=screenresolution get 03:16:33 INFO - 2017-01-13 03:16:33.184 screenresolution[1666:11305] Display 0: 1600x1200x32@60 03:16:33 INFO - 2017-01-13 03:16:33.190 screenresolution[1667:11308] starting screenresolution argv=screenresolution list 03:16:33 INFO - Available Modes on Display 0 03:16:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:33 INFO - Intel Iris: 03:16:33 INFO - Chipset Model: Intel Iris 03:16:33 INFO - Type: GPU 03:16:33 INFO - Bus: Built-In 03:16:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:33 INFO - Vendor: Intel (0x8086) 03:16:33 INFO - Device ID: 0x0a2e 03:16:33 INFO - Revision ID: 0x0009 03:16:33 INFO - Displays: 03:16:33 INFO - Display: 03:16:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:33 INFO - Display Serial Number: 1600x1200 60 03:16:33 INFO - Main Display: Yes 03:16:33 INFO - Mirror: Off 03:16:33 INFO - Online: Yes 03:16:33 INFO - Rotation: Supported 03:16:33 INFO - Return code: 0 03:16:33 INFO - Running post-action listener: _resource_record_post_action 03:16:33 INFO - [mozharness: 2017-01-13 11:16:33.434148Z] Finished run-tests step (success) 03:16:33 INFO - Running post-run listener: _resource_record_post_run 03:16:33 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 38779392; Write bytes: 555693056; Read time: 247; Write time: 1720 03:16:33 INFO - TinderboxPrint: CPU usage
54.7% 03:16:33 INFO - TinderboxPrint: I/O read bytes / time
38,779,392 / 247 03:16:33 INFO - TinderboxPrint: I/O write bytes / time
555,693,056 / 1,720 03:16:33 INFO - TinderboxPrint: CPU idle
2,175.3 (45.3%) 03:16:33 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 03:16:33 INFO - TinderboxPrint: CPU user
1,654.0 (34.5%) 03:16:33 INFO - TinderboxPrint: Swap in / out
290,234,368 / 0 03:16:33 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241256960; Write bytes: 232752640; Read time: 17459; Write time: 508 03:16:33 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 36944384; Write bytes: 301252096; Read time: 231; Write time: 1161 03:16:33 INFO - Running post-run listener: _upload_blobber_files 03:16:33 INFO - Blob upload gear active. 03:16:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:33 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 03:16:33 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'] 03:16:33 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 03:16:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:35 INFO - (blobuploader) - INFO - Done attempting. 03:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:38 INFO - (blobuploader) - INFO - Done attempting. 03:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:39 INFO - (blobuploader) - INFO - Done attempting. 03:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:41 INFO - (blobuploader) - INFO - Done attempting. 03:16:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:41 INFO - Return code: 0 03:16:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac231f6b5594f65ca2f534bc9c76e862e9ec895839af802e3a5a10113292a2f345ee8e54c0a4ee51aa9feaaa83646038d51fdfb41b051947523399b7f1e5ccbc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94cc3323122611071866a412130757886190a6592ba3fc20b58a1d25f84b643bdec0202e0828fd307407e627fdedd1a8cb9a9053637c81538b6def7d97f88b22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54031987f894b6986ac7250c3d73e8cabde7512760a97cff0b99be6896d52e6d7f511eb2b805c91c2be64b499ca4f08176b29925e3b00a22c2121245f6f4f641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fd38a0782d000381b64256960994e398bcc656b8238dd05fb8256c1273ee78f85964222663bb298d24bf6cd10768946ac69c2e65d7250b5de8c62d9b977d42"} 03:16:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:41 INFO - Contents: 03:16:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac231f6b5594f65ca2f534bc9c76e862e9ec895839af802e3a5a10113292a2f345ee8e54c0a4ee51aa9feaaa83646038d51fdfb41b051947523399b7f1e5ccbc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94cc3323122611071866a412130757886190a6592ba3fc20b58a1d25f84b643bdec0202e0828fd307407e627fdedd1a8cb9a9053637c81538b6def7d97f88b22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54031987f894b6986ac7250c3d73e8cabde7512760a97cff0b99be6896d52e6d7f511eb2b805c91c2be64b499ca4f08176b29925e3b00a22c2121245f6f4f641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fd38a0782d000381b64256960994e398bcc656b8238dd05fb8256c1273ee78f85964222663bb298d24bf6cd10768946ac69c2e65d7250b5de8c62d9b977d42"} 03:16:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:41 INFO - Copying logs to upload dir... 03:16:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.398763 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-13 03:16:41.540813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:41.544718) ========= 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.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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/ac231f6b5594f65ca2f534bc9c76e862e9ec895839af802e3a5a10113292a2f345ee8e54c0a4ee51aa9feaaa83646038d51fdfb41b051947523399b7f1e5ccbc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94cc3323122611071866a412130757886190a6592ba3fc20b58a1d25f84b643bdec0202e0828fd307407e627fdedd1a8cb9a9053637c81538b6def7d97f88b22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54031987f894b6986ac7250c3d73e8cabde7512760a97cff0b99be6896d52e6d7f511eb2b805c91c2be64b499ca4f08176b29925e3b00a22c2121245f6f4f641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fd38a0782d000381b64256960994e398bcc656b8238dd05fb8256c1273ee78f85964222663bb298d24bf6cd10768946ac69c2e65d7250b5de8c62d9b977d42"} build_url:https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010843 build_url: 'https://queue.taskcluster.net/v1/task/Qd-_r5ZJQGqLsmCNLi3egQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac231f6b5594f65ca2f534bc9c76e862e9ec895839af802e3a5a10113292a2f345ee8e54c0a4ee51aa9feaaa83646038d51fdfb41b051947523399b7f1e5ccbc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94cc3323122611071866a412130757886190a6592ba3fc20b58a1d25f84b643bdec0202e0828fd307407e627fdedd1a8cb9a9053637c81538b6def7d97f88b22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54031987f894b6986ac7250c3d73e8cabde7512760a97cff0b99be6896d52e6d7f511eb2b805c91c2be64b499ca4f08176b29925e3b00a22c2121245f6f4f641", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fd38a0782d000381b64256960994e398bcc656b8238dd05fb8256c1273ee78f85964222663bb298d24bf6cd10768946ac69c2e65d7250b5de8c62d9b977d42"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:41.582154) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:41.582680) ========= 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.8osDteODY2/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.UbLRl3Xczs/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.005219 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 03:16:41.632610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:16:41.633083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 03:16:41.633588) ========= ========= Total master_lag: 0.20 =========