builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0161 starttime: 1489169698.97 results: success (0) buildid: 20170310084422 builduid: 85e318f108f84e02a096b09d9f7e56a7 revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:58.971060) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:58.971580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:58.971900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:58.996800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:58.997173) ========= 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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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-03-10 10:14:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 36.9M=0s 2017-03-10 10:14:59 (36.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.145297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.145589) ========= 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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.022285 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:14:59.238550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:14:59.238928) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev edd424223fb1c336294a0cc1ca0e31cbec79ec31 --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 edd424223fb1c336294a0cc1ca0e31cbec79ec31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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-03-10 10:14:59,326 truncating revision to first 12 chars 2017-03-10 10:14:59,326 Setting DEBUG logging. 2017-03-10 10:14:59,326 attempt 1/10 2017-03-10 10:14:59,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/edd424223fb1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 10:15:00,846 unpacking tar archive at: mozilla-central-edd424223fb1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.798687 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:15:01.162463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.162834) ========= script_repo_revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.163241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.163509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:15:01.187294) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-10 10:15:01.187686) ========= /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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:15:01 INFO - MultiFileLogger online at 20170310 10:15:01 in /builds/slave/test 10:15:01 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 10:15:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:01 INFO - {'append_to_log': False, 10:15:01 INFO - 'base_work_dir': '/builds/slave/test', 10:15:01 INFO - 'blob_upload_branch': 'Firefox', 10:15:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:01 INFO - 'branch': 'Firefox', 10:15:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:01 INFO - 'config_files': ('talos/mac_config.py',), 10:15:01 INFO - 'default_actions': ('clobber', 10:15:01 INFO - 'read-buildbot-config', 10:15:01 INFO - 'download-and-extract', 10:15:01 INFO - 'populate-webroot', 10:15:01 INFO - 'create-virtualenv', 10:15:01 INFO - 'install', 10:15:01 INFO - 'run-tests'), 10:15:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:01 INFO - 'download_minidump_stackwalk': True, 10:15:01 INFO - 'download_symbols': 'ondemand', 10:15:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:01 INFO - 'gecko_profile': False, 10:15:01 INFO - 'gecko_profile_interval': 0, 10:15:01 INFO - 'installer_path': 'installer.exe', 10:15:01 INFO - 'log_level': 'info', 10:15:01 INFO - 'log_name': 'talos', 10:15:01 INFO - 'log_to_console': True, 10:15:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:01 INFO - 'opt_config_files': (), 10:15:01 INFO - 'pip_index': False, 10:15:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'run_cmd_checks_enabled': True, 10:15:01 INFO - 'suite': 'dromaeojs-e10s', 10:15:01 INFO - 'system_bits': '32', 10:15:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:01 INFO - 'title': 't-yosemite-r7-0161', 10:15:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:01 INFO - 'use_talos_json': True, 10:15:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:01 INFO - 'work_dir': 'build'} 10:15:01 INFO - [mozharness: 2017-03-10 18:15:01.401879Z] Running clobber step. 10:15:01 INFO - Running pre-action listener: _resource_record_pre_action 10:15:01 INFO - Running main action method: clobber 10:15:01 INFO - rmtree: /builds/slave/test/build 10:15:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - [mozharness: 2017-03-10 18:15:03.437983Z] Finished clobber step (success) 10:15:03 INFO - [mozharness: 2017-03-10 18:15:03.438230Z] Running read-buildbot-config step. 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: read_buildbot_config 10:15:03 INFO - Using buildbot properties: 10:15:03 INFO - { 10:15:03 INFO - "project": "", 10:15:03 INFO - "product": "firefox", 10:15:03 INFO - "script_repo_revision": "production", 10:15:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:15:03 INFO - "repository": "", 10:15:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:15:03 INFO - "buildid": "20170310084422", 10:15:03 INFO - "pgo_build": "False", 10:15:03 INFO - "basedir": "/builds/slave/test", 10:15:03 INFO - "buildnumber": 97, 10:15:03 INFO - "slavename": "t-yosemite-r7-0161", 10:15:03 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:15:03 INFO - "platform": "yosemite_r7", 10:15:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:15:03 INFO - "branch": "mozilla-central", 10:15:03 INFO - "repo_path": "mozilla-central", 10:15:03 INFO - "revision": "edd424223fb1c336294a0cc1ca0e31cbec79ec31", 10:15:03 INFO - "stage_platform": "macosx64", 10:15:03 INFO - "builduid": "85e318f108f84e02a096b09d9f7e56a7", 10:15:03 INFO - "slavebuilddir": "test" 10:15:03 INFO - } 10:15:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - [mozharness: 2017-03-10 18:15:03.444126Z] Finished read-buildbot-config step (success) 10:15:03 INFO - [mozharness: 2017-03-10 18:15:03.444331Z] Running download-and-extract step. 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: download_and_extract 10:15:03 INFO - mkdir: /builds/slave/test/build/tests 10:15: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')]} 10:15:03 INFO - trying https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:15:04 INFO - Downloaded 1199 bytes. 10:15:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:15:04 INFO - Using the following test package requirements: 10:15:04 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:15:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:15:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'jsshell-mac.zip'], 10:15:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:15:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:15:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:15:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:15:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:15:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:15:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:15:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:15:04 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:15:06 INFO - Expected file size: 51789467 10:15:06 INFO - Obtained file size: 51789467 10:15:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:15:24 INFO - Expected file size: 51789467 10:15:24 INFO - Obtained file size: 51789467 10:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:15:41 INFO - Expected file size: 14404424 10:15:41 INFO - Obtained file size: 14404424 10:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:41 INFO - trying https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:41 INFO - Downloading https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:15:43 INFO - Downloaded 74939291 bytes. 10:15:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:43 INFO - mkdir: /builds/slave/test/properties 10:15:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:43 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:43 INFO - Contents: 10:15:43 INFO - build_url:https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:15:44 INFO - Running post-action listener: _resource_record_post_action 10:15:44 INFO - Running post-action listener: set_extra_try_arguments 10:15:44 INFO - [mozharness: 2017-03-10 18:15:44.419025Z] Finished download-and-extract step (success) 10:15:44 INFO - [mozharness: 2017-03-10 18:15:44.419158Z] Running populate-webroot step. 10:15:44 INFO - Running pre-action listener: _resource_record_pre_action 10:15:44 INFO - Running main action method: populate_webroot 10:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:44 INFO - '--tppagecycles', 10:15:44 INFO - '7'], 10:15:44 INFO - 'tests': ['tsvgm']}}, 10:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['damp', 'tps']}, 10:15:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'tests': ['damp', 'tps']}, 10:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['dromaeo_dom']}, 10:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['basic_compositor_video']}, 10:15:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['a11yr', 10:15:44 INFO - 'ts_paint', 10:15:44 INFO - 'tpaint', 10:15:44 INFO - 'sessionrestore', 10:15:44 INFO - 'sessionrestore_no_auto_restore', 10:15:44 INFO - 'tabpaint']}, 10:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['tsvgx', 10:15:44 INFO - 'tsvgr_opacity', 10:15:44 INFO - 'tart', 10:15:44 INFO - 'tscrollx', 10:15:44 INFO - 'cart', 10:15:44 INFO - 'tsvg_static']}, 10:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:44 INFO - 'tsvgr_opacity', 10:15:44 INFO - 'tart', 10:15:44 INFO - 'tscrollx', 10:15:44 INFO - 'cart', 10:15:44 INFO - 'tsvg_static']}, 10:15:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'talos_options': ['--disable-e10s'], 10:15:44 INFO - 'tests': ['tp5o']}, 10:15:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:15:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'talos_options': ['--disable-e10s', 10:15:44 INFO - '--xperf_path', 10:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:44 INFO - 'tests': ['tp5n']}, 10:15:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:15:44 INFO - 'talos_options': ['--xperf_path', 10:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:44 INFO - 'tests': ['tp5n']}}, 10:15:44 INFO - 'talos.zip': {'path': '', 10:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:44 INFO - Running post-action listener: _resource_record_post_action 10:15:44 INFO - [mozharness: 2017-03-10 18:15:44.437744Z] Finished populate-webroot step (success) 10:15:44 INFO - [mozharness: 2017-03-10 18:15:44.437885Z] Running create-virtualenv step. 10:15:44 INFO - Running pre-action listener: _resource_record_pre_action 10:15:44 INFO - Running main action method: create_virtualenv 10:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:44 INFO - Using real prefix '/tools/python27' 10:15:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:48 INFO - Installing pip.................done. 10:15:48 INFO - Return code: 0 10:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:15:48 INFO - Reading from file tmpfile_stdout 10:15:48 INFO - Output received: 10:15:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:48 INFO - 'HOME': '/Users/cltbld', 10:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:48 INFO - 'LOGNAME': 'cltbld', 10:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:48 INFO - 'MOZ_NO_REMOTE': '1', 10:15:48 INFO - 'NO_EM_RESTART': '1', 10:15:48 INFO - 'PAGER': '/bin/cat', 10:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:48 INFO - 'PWD': '/builds/slave/test', 10:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:48 INFO - 'SHELL': '/bin/bash', 10:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:15:48 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:48 INFO - 'USER': 'cltbld', 10:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:48 INFO - 'XPC_FLAGS': '0x0', 10:15:48 INFO - 'XPC_SERVICE_NAME': '0', 10:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:15:48 INFO - Cleaning up... 10:15:48 INFO - Return code: 0 10:15:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:48 INFO - 'HOME': '/Users/cltbld', 10:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:48 INFO - 'LOGNAME': 'cltbld', 10:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:48 INFO - 'MOZ_NO_REMOTE': '1', 10:15:48 INFO - 'NO_EM_RESTART': '1', 10:15:48 INFO - 'PAGER': '/bin/cat', 10:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:48 INFO - 'PWD': '/builds/slave/test', 10:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:48 INFO - 'SHELL': '/bin/bash', 10:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:15:48 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:48 INFO - 'USER': 'cltbld', 10:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:48 INFO - 'XPC_FLAGS': '0x0', 10:15:48 INFO - 'XPC_SERVICE_NAME': '0', 10:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:48 INFO - Downloading/unpacking psutil>=3.1.1 10:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:52 INFO - Installing collected packages: psutil 10:15:52 INFO - Running setup.py install for psutil 10:15:52 INFO - building 'psutil._psutil_osx' extension 10:15:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:15:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:15:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:15:53 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 10:15:53 INFO - building 'psutil._psutil_posix' extension 10:15:53 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 10:15:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:15:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:15:53 INFO - ^ 10:15:53 INFO - 1 warning generated. 10:15:53 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 10:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:53 INFO - Successfully installed psutil 10:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 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')]} 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:15:54 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 10:15:54 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 10:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:54 INFO - 'HOME': '/Users/cltbld', 10:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:54 INFO - 'LOGNAME': 'cltbld', 10:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:54 INFO - 'MOZ_NO_REMOTE': '1', 10:15:54 INFO - 'NO_EM_RESTART': '1', 10:15:54 INFO - 'PAGER': '/bin/cat', 10:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:54 INFO - 'PWD': '/builds/slave/test', 10:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:54 INFO - 'SHELL': '/bin/bash', 10:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:15:54 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:54 INFO - 'USER': 'cltbld', 10:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:54 INFO - 'XPC_FLAGS': '0x0', 10:15:54 INFO - 'XPC_SERVICE_NAME': '0', 10:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:54 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 10:15:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:57 INFO - Installing collected packages: mozsystemmonitor 10:15:57 INFO - Running setup.py install for mozsystemmonitor 10:15:58 INFO - Successfully installed mozsystemmonitor 10:15:58 INFO - Cleaning up... 10:15:58 INFO - Return code: 0 10:15:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:58 INFO - 'HOME': '/Users/cltbld', 10:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:58 INFO - 'LOGNAME': 'cltbld', 10:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:58 INFO - 'MOZ_NO_REMOTE': '1', 10:15:58 INFO - 'NO_EM_RESTART': '1', 10:15:58 INFO - 'PAGER': '/bin/cat', 10:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:58 INFO - 'PWD': '/builds/slave/test', 10:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:58 INFO - 'SHELL': '/bin/bash', 10:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:15:58 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:58 INFO - 'USER': 'cltbld', 10:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:58 INFO - 'XPC_FLAGS': '0x0', 10:15:58 INFO - 'XPC_SERVICE_NAME': '0', 10:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 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 10:16:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:01 INFO - warning: no files found matching '*.txt' 10:16:01 INFO - no previously-included directories found matching 'build' 10:16:01 INFO - no previously-included directories found matching 'dist' 10:16:01 INFO - no previously-included directories found matching '.git*' 10:16:01 INFO - Installing collected packages: jsonschema, functools32 10:16:01 INFO - Running setup.py install for functools32 10:16:01 INFO - warning: no files found matching '*.txt' 10:16:01 INFO - no previously-included directories found matching 'build' 10:16:01 INFO - no previously-included directories found matching 'dist' 10:16:01 INFO - no previously-included directories found matching '.git*' 10:16:01 INFO - Successfully installed jsonschema functools32 10:16:01 INFO - Cleaning up... 10:16:01 INFO - Return code: 0 10:16:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:01 INFO - 'HOME': '/Users/cltbld', 10:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:01 INFO - 'LOGNAME': 'cltbld', 10:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:01 INFO - 'MOZ_NO_REMOTE': '1', 10:16:01 INFO - 'NO_EM_RESTART': '1', 10:16:01 INFO - 'PAGER': '/bin/cat', 10:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:01 INFO - 'PWD': '/builds/slave/test', 10:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:01 INFO - 'SHELL': '/bin/bash', 10:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:01 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:01 INFO - 'USER': 'cltbld', 10:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:01 INFO - 'XPC_FLAGS': '0x0', 10:16:01 INFO - 'XPC_SERVICE_NAME': '0', 10:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:16:02 INFO - Cleaning up... 10:16:02 INFO - Return code: 0 10:16:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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', '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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:16: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 blobuploader==1.2.4 10:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:02 INFO - 'HOME': '/Users/cltbld', 10:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:02 INFO - 'LOGNAME': 'cltbld', 10:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:02 INFO - 'MOZ_NO_REMOTE': '1', 10:16:02 INFO - 'NO_EM_RESTART': '1', 10:16:02 INFO - 'PAGER': '/bin/cat', 10:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:02 INFO - 'PWD': '/builds/slave/test', 10:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:02 INFO - 'SHELL': '/bin/bash', 10:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:02 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:02 INFO - 'USER': 'cltbld', 10:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:02 INFO - 'XPC_FLAGS': '0x0', 10:16:02 INFO - 'XPC_SERVICE_NAME': '0', 10:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - Downloading docopt-0.6.1.tar.gz 10:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:06 INFO - Running setup.py install for blobuploader 10:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:06 INFO - Running setup.py install for requests 10:16:06 INFO - Running setup.py install for docopt 10:16:07 INFO - Successfully installed blobuploader requests docopt 10:16:07 INFO - Cleaning up... 10:16:07 INFO - Return code: 0 10:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16:07 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 10:16:07 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 10:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:07 INFO - 'HOME': '/Users/cltbld', 10:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:07 INFO - 'LOGNAME': 'cltbld', 10:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:07 INFO - 'MOZ_NO_REMOTE': '1', 10:16:07 INFO - 'NO_EM_RESTART': '1', 10:16:07 INFO - 'PAGER': '/bin/cat', 10:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:07 INFO - 'PWD': '/builds/slave/test', 10:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:07 INFO - 'SHELL': '/bin/bash', 10:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:07 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:07 INFO - 'USER': 'cltbld', 10:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:07 INFO - 'XPC_FLAGS': '0x0', 10:16:07 INFO - 'XPC_SERVICE_NAME': '0', 10:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:07 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-bWwS2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:07 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-IXAIqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:07 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-neSKYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:07 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-w8Q6L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:07 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-czfMUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-x_1NFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-obe5WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-F_9t5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-PZGa5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Ba6LUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-7KUJbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-o7Y0FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-v5GHDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Ern3wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:08 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-93VBMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-4Ikaoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-tyA7Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:09 INFO - Running setup.py install for manifestparser 10:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:09 INFO - Running setup.py install for mozcrash 10:16:09 INFO - Running setup.py install for mozdebug 10:16:09 INFO - Running setup.py install for mozdevice 10:16:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:09 INFO - Running setup.py install for mozfile 10:16:10 INFO - Running setup.py install for mozhttpd 10:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozinfo 10:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozInstall 10:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozleak 10:16:10 INFO - Running setup.py install for mozlog 10:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for moznetwork 10:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozprocess 10:16:11 INFO - Running setup.py install for mozprofile 10:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozrunner 10:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozscreenshot 10:16:11 INFO - Running setup.py install for moztest 10:16:11 INFO - Running setup.py install for mozversion 10:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:11 INFO - Cleaning up... 10:16:11 INFO - Return code: 0 10:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16:11 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 10:16:11 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 10:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:11 INFO - 'HOME': '/Users/cltbld', 10:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PAGER': '/bin/cat', 10:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:11 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - 'XPC_FLAGS': '0x0', 10:16:11 INFO - 'XPC_SERVICE_NAME': '0', 10:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-kiUKB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-wVekP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-AAgMrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-2qh3yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ZNanw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-iIpDhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-cvqxAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Vf3AlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ubx_ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-5D05ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-x5aK4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-eL8PES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-780UTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-HlupdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Haul5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-nDRVu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:13 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)) 10:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-v1H371-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:13 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)) 10:16:13 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 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)) 10:16:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:16 INFO - Downloading blessings-1.6.tar.gz 10:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:16 INFO - Installing collected packages: blessings 10:16:16 INFO - Running setup.py install for blessings 10:16:16 INFO - Successfully installed blessings 10:16:16 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:17 INFO - Reading from file tmpfile_stdout 10:16:17 INFO - Current package versions: 10:16:17 INFO - blessings == 1.6 10:16:17 INFO - blobuploader == 1.2.4 10:16:17 INFO - docopt == 0.6.1 10:16:17 INFO - functools32 == 3.2.3-2 10:16:17 INFO - jsonschema == 2.5.1 10:16:17 INFO - manifestparser == 1.1 10:16:17 INFO - mozInstall == 1.12 10:16:17 INFO - mozcrash == 1.0 10:16:17 INFO - mozdebug == 0.1 10:16:17 INFO - mozdevice == 0.49 10:16:17 INFO - mozfile == 1.2 10:16:17 INFO - mozhttpd == 0.7 10:16:17 INFO - mozinfo == 0.9 10:16:17 INFO - mozleak == 0.1 10:16:17 INFO - mozlog == 3.4 10:16:17 INFO - moznetwork == 0.27 10:16:17 INFO - mozprocess == 0.25 10:16:17 INFO - mozprofile == 0.28 10:16:17 INFO - mozrunner == 6.13 10:16:17 INFO - mozscreenshot == 0.1 10:16:17 INFO - mozsystemmonitor == 0.3 10:16:17 INFO - moztest == 0.8 10:16:17 INFO - mozversion == 1.4 10:16:17 INFO - psutil == 3.1.1 10:16:17 INFO - requests == 1.2.3 10:16:17 INFO - wsgiref == 0.1.2 10:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:17 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')]} 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 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')]} 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16:17 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 10:16:17 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 10:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:17 INFO - 'HOME': '/Users/cltbld', 10:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:17 INFO - 'LOGNAME': 'cltbld', 10:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:17 INFO - 'MOZ_NO_REMOTE': '1', 10:16:17 INFO - 'NO_EM_RESTART': '1', 10:16:17 INFO - 'PAGER': '/bin/cat', 10:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:17 INFO - 'PWD': '/builds/slave/test', 10:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:17 INFO - 'SHELL': '/bin/bash', 10:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:17 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:17 INFO - 'USER': 'cltbld', 10:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:17 INFO - 'XPC_FLAGS': '0x0', 10:16:17 INFO - 'XPC_SERVICE_NAME': '0', 10:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 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)) 10:16:17 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:17 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')]} 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 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')]} 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 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 0x104fd6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b8563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, '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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 10:16:17 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 10:16:17 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 10:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:17 INFO - 'HOME': '/Users/cltbld', 10:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:17 INFO - 'LOGNAME': 'cltbld', 10:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:17 INFO - 'MOZ_NO_REMOTE': '1', 10:16:17 INFO - 'NO_EM_RESTART': '1', 10:16:17 INFO - 'PAGER': '/bin/cat', 10:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:17 INFO - 'PWD': '/builds/slave/test', 10:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:17 INFO - 'SHELL': '/bin/bash', 10:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:17 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:17 INFO - 'USER': 'cltbld', 10:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:17 INFO - 'XPC_FLAGS': '0x0', 10:16:17 INFO - 'XPC_SERVICE_NAME': '0', 10:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:17 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Running post-action listener: _resource_record_post_action 10:16:17 INFO - Running post-action listener: _start_resource_monitoring 10:16:17 INFO - Starting resource monitoring. 10:16:17 INFO - [mozharness: 2017-03-10 18:16:17.883635Z] Finished create-virtualenv step (success) 10:16:17 INFO - [mozharness: 2017-03-10 18:16:17.884641Z] Running install step. 10:16:17 INFO - Running pre-action listener: _resource_record_pre_action 10:16:17 INFO - Running main action method: install 10:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:18 INFO - Reading from file tmpfile_stdout 10:16:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:18 INFO - Reading from file tmpfile_stdout 10:16:18 INFO - Output received: 10:16:18 INFO - Usage: mozinstall [options] installer 10:16:18 INFO - Options: 10:16:18 INFO - -h, --help show this help message and exit 10:16:18 INFO - -d DEST, --destination=DEST 10:16:18 INFO - Directory to install application into. [default: 10:16:18 INFO - "/builds/slave/test"] 10:16:18 INFO - --app=APP Application being installed. [default: firefox] 10:16:18 INFO - mkdir: /builds/slave/test/build/application 10:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:16:38 INFO - Reading from file tmpfile_stdout 10:16:38 INFO - Output received: 10:16:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:16:38 INFO - Running post-action listener: _resource_record_post_action 10:16:38 INFO - [mozharness: 2017-03-10 18:16:38.580299Z] Finished install step (success) 10:16:38 INFO - [mozharness: 2017-03-10 18:16:38.580463Z] Running run-tests step. 10:16:38 INFO - Running pre-action listener: _resource_record_pre_action 10:16:38 INFO - Running main action method: run_tests 10:16:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:38 INFO - 2017-03-10 10:16:38.594 screenresolution[2256:23120] starting screenresolution argv=screenresolution get 10:16:38 INFO - 2017-03-10 10:16:38.597 screenresolution[2256:23120] Display 0: 1600x1200x32@60 10:16:38 INFO - 2017-03-10 10:16:38.602 screenresolution[2257:23122] starting screenresolution argv=screenresolution list 10:16:38 INFO - Available Modes on Display 0 10:16:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:38 INFO - Intel Iris: 10:16:38 INFO - Chipset Model: Intel Iris 10:16:38 INFO - Type: GPU 10:16:38 INFO - Bus: Built-In 10:16:38 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:38 INFO - Vendor: Intel (0x8086) 10:16:38 INFO - Device ID: 0x0a2e 10:16:38 INFO - Revision ID: 0x0009 10:16:38 INFO - Displays: 10:16:38 INFO - Display: 10:16:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:38 INFO - Display Serial Number: 1600x1200 60 10:16:38 INFO - Main Display: Yes 10:16:38 INFO - Mirror: Off 10:16:38 INFO - Online: Yes 10:16:38 INFO - Rotation: Supported 10:16:38 INFO - Return code: 0 10:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:38 INFO - Python 2.7.3 10:16:38 INFO - Return code: 0 10:16:38 INFO - grabbing minidump binary from tooltool 10:16: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')]} 10:16:38 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 0x104db4d30>, '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 0x104cdbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:38 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 10:16:38 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 10:16:38 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 10:16:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:38 INFO - Return code: 0 10:16:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:16:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:38 INFO - ENV: RUST_BACKTRACE is now 1 10:16:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:16:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:38 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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 10:16:38 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0161 --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 10:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nzFzOGbxCm/Render', 10:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:38 INFO - 'HOME': '/Users/cltbld', 10:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:38 INFO - 'LOGNAME': 'cltbld', 10:16:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:38 INFO - 'MOZ_NO_REMOTE': '1', 10:16:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:38 INFO - 'NO_EM_RESTART': '1', 10:16:38 INFO - 'PAGER': '/bin/cat', 10:16:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:38 INFO - 'PWD': '/builds/slave/test', 10:16:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:38 INFO - 'RUST_BACKTRACE': '1', 10:16:38 INFO - 'SHELL': '/bin/bash', 10:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e2HxQ7WQCR/Listeners', 10:16:38 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 10:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:38 INFO - 'USER': 'cltbld', 10:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:38 INFO - 'XPC_FLAGS': '0x0', 10:16:38 INFO - 'XPC_SERVICE_NAME': '0', 10:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:38 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/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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 10:16:39 INFO - mozversion application_buildid: 20170310084422 10:16:39 INFO - mozversion application_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 10:16:39 INFO - mozversion application_display_name: Nightly 10:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:39 INFO - mozversion application_name: Firefox 10:16:39 INFO - mozversion application_remotingname: firefox 10:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:16:39 INFO - mozversion application_vendor: Mozilla 10:16:39 INFO - mozversion application_version: 55.0a1 10:16:39 INFO - mozversion platform_buildid: 20170310084422 10:16:39 INFO - mozversion platform_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 10:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:16:39 INFO - mozversion platform_version: 55.0a1 10:16:39 INFO - using testdate: 1489169799 10:16:39 INFO - actual date: 1489169799 10:16:39 INFO - starting webserver on 'localhost:54218' 10:16:39 INFO - SUITE-START | Running 2 tests 10:16:39 INFO - TEST-START | dromaeo_css 10:16:39 INFO - operating with platform_type : mac_ 10:16:39 INFO - Initialising browser for dromaeo_css test... 10:16:39 INFO - TEST-INFO | started process 2267 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmp68Mqul/profile http://localhost:54218/getInfo.html) 10:16:42 INFO - PROCESS | 2267 | 2017-03-10 10:16:42.146 plugin-container[2269:23300] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 10:16:42 INFO - PROCESS | 2267 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:16:42 INFO - PROCESS | 2267 | 2017-03-10 10:16:42.149 plugin-container[2269:23300] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 10:16:42 INFO - PROCESS | 2267 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:16:42 INFO - PROCESS | 2267 | 2017-03-10 10:16:42.149 plugin-container[2269:23300] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:16:42 INFO - PROCESS | 2267 | __metrics Screen width/height:1600/1200 10:16:42 INFO - PROCESS | 2267 | colorDepth:24 10:16:42 INFO - PROCESS | 2267 | Browser inner width/height: 1024/689 10:16:42 INFO - PROCESS | 2267 | __metrics 10:16:42 ERROR - PROCESS | 2267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:16:43 INFO - TEST-INFO | 2267: exit 0 10:16:43 INFO - Browser initialized. 10:16:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:43 INFO - TEST-INFO | started process 2270 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmp68Mqul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:45 INFO - PROCESS | 2270 | 2017-03-10 10:16:45.734 plugin-container[2271:23419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 10:16:45 INFO - PROCESS | 2270 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:16:45 INFO - PROCESS | 2270 | 2017-03-10 10:16:45.737 plugin-container[2271:23419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4817, name = 'com.apple.CFPasteboardClient' 10:16:45 INFO - PROCESS | 2270 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:16:45 INFO - PROCESS | 2270 | 2017-03-10 10:16:45.737 plugin-container[2271:23419] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:16:55 INFO - PROCESS | 2270 | RSS: Main: 227446784 10:16:55 INFO - PROCESS | 2270 | 10:19:58 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54218/tests/dromaeo/cssquery-ext.html) 10:20:00 INFO - PROCESS | 2270 | RSS: Main: 253673472 10:20:00 INFO - PROCESS | 2270 | 10:21:43 INFO - PROCESS | 2270 | ************************* 10:21:43 INFO - PROCESS | 2270 | A coding exception was thrown and uncaught in a Task. 10:21:43 INFO - PROCESS | 2270 | 10:21:43 ERROR - PROCESS | 2270 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:21:43 INFO - PROCESS | 2270 | Full stack: 10:21:43 INFO - PROCESS | 2270 | ************************* 10:23:02 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-ext.html (next: http://localhost:54218/tests/dromaeo/cssquery-jquery.html) 10:23:03 INFO - PROCESS | 2270 | RSS: Main: 258887680 10:23:03 INFO - PROCESS | 2270 | 10:26:05 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54218/tests/dromaeo/cssquery-mootools.html) 10:26:06 INFO - PROCESS | 2270 | RSS: Main: 270110720 10:26:06 INFO - PROCESS | 2270 | 10:29:08 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54218/tests/dromaeo/cssquery-prototype.html) 10:29:09 INFO - PROCESS | 2270 | RSS: Main: 263360512 10:29:09 INFO - PROCESS | 2270 | 10:32:12 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54218/tests/dromaeo/cssquery-yui.html) 10:32:12 INFO - PROCESS | 2270 | RSS: Main: 273661952 10:32:12 INFO - PROCESS | 2270 | 10:35:15 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:54218/tests/dromaeo/cssquery-yui.html (next: http://localhost:54218/tests/dromaeo/cssquery-dojo.html) 10:35:15 INFO - PROCESS | 2270 | RSS: Main: 268423168 10:35:15 INFO - PROCESS | 2270 | 10:35:15 INFO - PROCESS | 2270 | __start_tp_report 10:35:15 INFO - PROCESS | 2270 | _x_x_mozilla_page_load 10:35:15 INFO - PROCESS | 2270 | _x_x_mozilla_page_load_details 10:35:15 INFO - PROCESS | 2270 | |i|pagename|runs| 10:35:16 INFO - PROCESS | 2270 | |0;dojo.html;2964.466396048711;3373.6795004474566;3403.778754380965;3429.4512877939533;3443.449048152296;5823.563232757544;5831.212786273852;5836.620619659724;5911.940880591193;5922.022866227067;5458.580769000058;5838.591298609099;5881.617694849831;6006.45941865232;6021.8193454196335;4694.694844835083;5276.445973172819;5288.127458969266;5327.680517054812;5388.973055134738;4804.639652026094;5424.349078110632;5427.945720542803;5436.891262174754;5461.317335333083;4902.852914412538;5284.313039304904;5365.222042803811;5395.3525576931015;5397.325334333189;5320.654157479751;5326.44072372403;5330.546903513206;5334.959682861843;5341.305630268079;5278.445763194848;5296.496832800916;5326.147816349404;5329.440408757102;5362.115250983583;5598.664080155204;5642.943570564283;5666.716664166816;5696.829095127153;5697.373288938214;6261.749530018794;6275.96862015687;6328.208973878265;6330.778422755181;6348.301686814447;6413.3266007069515;6413.422791948747;6427.710753016126;6437.259715132773;6458.709358078898;5973.253343332083;6060.909086363708;6065.059915713072;6080.331163572004;6089.451949324582;6281.560290779602;6332.398422149889;6426.164598602152;6471.482281417475;6560.835979100465;5364.168553874156;6176.4441200292185;6215.627062376272;6257.843553911098;6292.874142517124;6305.5901366411035;6319.557630965788;6339.936600633934;6356.173697419306;6357.4914006879335;6308.621482711052;6362.809115726535;6364.077208804697;6366.904496432558;6441.967790161019;6219.346968568326;6241.563090583706;6245.875082498415;6253.030780229072;6322.71547780351;5125.256837758504;5129.487051294916;5155.123628983007;5167.069927413027;5207.635465517377;4512.278035514302;4524.298733696282;4552.9772351138035;4554.726716397026;4588.990422107131;5763.991301522301;5856.795012174553;5931;6067.211262535842;6076.240469941257;5396.379416367168;6256.6871656417;6297.4962003039645;6297.905531417033;6363.395477429637;5457.099578569571;5616.045272303718;6080.847978800565;6094.573379863367;6102.084687296852;5608.943910560843;5614.550835933115;5624.91562626561;5629.971850140723;5639.407862174495;5401.459854014724;6240.438360547481;6403.423691867662;6446.806595802133;6606.966965165336;6420.550561460653;6435.839104022437;6450.193725784277;6450.48396128318;6450.870982580416;6534.869302613826;6579.967100164468;6607.702653380513;6621.238557565942;6635.270120286861;6165.3526379731275;6210.534209934182;6274.152989346379;6276.152719382825;6382.872342553216;6159;6347.428731414195;6361.14124593174;6368.808935731936;6373.936260637334;5137.8502231575485;6077.635341879324;6113.385090541831;6181.629102253879;6258.93598088317;6237.064440333987;6271.122042914087;6275.623462592259;6278.15244941927;6302.84242893913;5464.825062611558;5625.184348269559;5923.940760592339;6076.392360763888;6106.72519736604;5207.817726379559;6250.3749625037135;6314.526410519137;6322.525810564134;6326.493880489642;6160.568760186923;6170.691465426621;6173.475254603409;6190.319064902767;6190.938090619036 10:35:16 INFO - PROCESS | 2270 | |1;ext.html;725.7024619905836;782.2255966593073;801.6993627389727;936.6300311377006;944.1078181118837;39756.602433975655;40234.59765402345;40361.79819100904;40422;40484.19031619373;38642.80678596603;38958;38969.41545876814;38999.41500877489;39091.60908390922;7814.531128132302;7959;10900.945495272552;11053.502592383362;11132.888671113307;10725.249232553724;10810.891891081106;10827.67516974492;10855.945720271387;10866.61966831161;10810;10817;10838.458077096153;10848.78302433951;10859.457027148612;9414.670486532972;10627.309224900357;10806.945965270163;10824.621138260123;10840.728981775439;8984.326175536795;9378.437293762396;10824.891751082547;10875.510602022929;10911.290766100177;38758.80620596907;38935.61064389348;39005.41491877624;39063.82808515749;39106.022349441206;3682.6317368263226;3744.1949980754;3746.9437958430644;3776.7356285060055;3910.902227444337;23838.16566420167;27006.729932700815;27724.02965896204;28919;28930.855345723136;3079.538069289602;3248.4640034394297;3291.2923721400016;3291.391092647844;3301.60380754311;338026;341590;343392.2830385857;352321;361508.19245903863;49485.0102997938;49737.502624973284;49846.501534984185;49920;50043.24935125976;52000.73999629977;52386.95226095457;52615.21077183845;52737.47262527402;52896.47103528993;10833.29583577065;13721.588352349445;13822.032457727862;13888.375023123983;13931.233782142079;8996.59515321812;11037.613683521038;11095.83356249657;11141.442927853575;11181;13796.241206733726;13797.034207605371;13814.861851381558;13842.100263482842;13899.096558723651;5802.82591522255;5828.6211396259105;5873.383294754075;5883.205622285244;5889.911651325234;973.2749101919115;1118.8209886418297;1130.0789856267115;1154.186298659443;1184.8992835608897;24814.138939579243;25848.74151258501;26171.869140654177;26509.73490265111;26548.60177097345;1017.7710015246511;1062.2776511971933;1238.6407941696807;1262.9494820207271;1277.3804704718204;13556.525521606696;13632.591022269347;13732.244726540137;13864.584062478141;13970.860291397159;394908;395371;395501;396425;401016;43896.78051609721;55072.72463637656;55117.72441137768;55156.17265741017;55162.448375515734;1277.182603133995;1375.6148278482042;1426.1585664458019;1432.176498513359;1438.101186758276;21896.671549927083;22824.65763013523;25016.874915625307;25783.742162578135;25890.611640825027;34058.14854628654;34660.133496662784;41201.38197926973;41217.1756564873;41365.793171033954;285247;327975;331996;342789.2860535681;358117;32612.673873260963;32835.17912052218;34038.14904627404;34670.479942800375;35374.46938295876;44468;44787.65637030894;45237.77381113073;45697.77151114223;45745.08509829718;34708.47937280993;34879.12802179966;36645.816770915975;37570.624293757806;37828.81085594554;36139.63860361468;36207;36234;37055.07362315964;37546;36673.61621494701;37716.2456750858;39385.80307098446;39954.80022599868;40025.1994960105;27127.236729612512;29595.260118497208;33815;33936.32127357488;34179.24028356829;19745.901270493556;25127.74872251327;25441.236762897144;25730.09944651928;25735.8418871155 10:35:16 INFO - PROCESS | 2270 | |2;jquery.html;329.8334341157715;370.1061935425946;398.39841838823367;418.59814578005114;437.4597372245278;19640.803591964075;21884.343469695894;22128.33614991553;22392.440188995282;22855.08579656814;22282.220122295723;22534.43663908403;22906.77093229067;23037.424064398398;23133.537329253446;6282.2147231596055;6518.902216466757;6550.377714117151;6571.93428065718;6573.638449885254;6428.132202152719;7070.186928503236;7453.068366454193;7563.848723025536;7578.242175782433;6515.934840651604;7259.709611615529;7493.962530187341;7512;7553.055868016498;7518.360939320164;7562.962185189066;7609.124950630693;7611.2769286917655;7618.314351708345;7140.250273721236;7397.297256760599;7410.666520006613;7411.407087433046;7430.108386993541;24804.627930581057;26956;27199.728002720116;27474.450510989867;27690.861545692143;3235.3367559650214;3319.966800332014;3351.8491667875005;3371.1403592084107;3484.8257587120797;15713.607159821097;16234.837651623451;16615.916920415442;16942.152892355334;17084.743728844078;1926.6532024235632;1989.502624343914;2012.2956965062258;2064.84513661476;2075.2321640992777;144806;157146;157576;161335.1933240338;161435;14126.50557230492;16874.662506749795;17371.392001280146;21197.36407907765;21408.678869816966;34912;34931;35314.293714125575;35372.29255414877;35375;10148.492575371349;10159.695209143738;10340.948295258475;10350.741231469123;10555.788884222273;8204.8359032819;8206;8210.589470526449;8400.117987611335;8406.117357677478;10269.514202256649;10504.737381565523;10516.263861529773;10631.308964917256;10649.094826939798;3994.380870965005;4067.6745860331694;4067.9796601016806;4095.815688294034;4102.671786257092;1009.1926458833051;1019.3333899075066;1019.8726644420824;1055.6410820321128;1076.3165389977264;22487.887560562092;23983.760162398154;24012.51974960491;24042.038318467414;24188.758112419004;897.0043251990415;959.827231098409;977.5796407544824;977.8239916815041;1034.8395998620226;12061.698457538456;12134.817977730341;12425.875741242653;12441.564545240873;12527.310997895022;437942;494809;513144;513307;732370;151442.24278878755;161982;162006.18996905175;162082;166872.22827791094;1217.1662411248324;1341.4298922957703;1351.6620844788804;1365.6108009217326;1369.205860600849;18281.451556452797;18861.622767544846;20242.493937651678;20470.79529204689;20709;48632.270515943;58884;59054.70472647609;59218.70390648192;59915.40084599098;79937;82100.17899821165;82622.58688706759;83694;84066;11513.827292590451;11756;12011.099167562294;12036.578719744766;12138.786121387791;12420.254784712946;13418.798718019432;13872.4451021958;13876.098053626481;13950.441982321;10247.97808957321;11257.549698011988;11398.031167350868;11491.655250342503;11709.30685942221;8985.46087234768;11569.595064172714;11740.823887641864;12161.574344897886;12179.269243845398;10112.544935477774;10801.9738124878;12087.274763514217;12187.939060304641;12230.75538489243;10052;10281.84577231357;11806.114541409257;12061.276323420623;12334.876651233373;9288.674896378594;9853.211743060681;10645.308054976402;11573.18987670855;11910.821337680116 10:35:16 INFO - PROCESS | 2270 | |3;mootools.html;1309.9258607941488;1514.3488300030983;1565.2095691675702;1568.5608029751675;1580.3994482096803;10127.746806329846;10722.678319650404;10728.624498142566;10842.783144337109;11243.887561124386;9099.04460031697;10965.232433729621;10997.670069897897;11077.667669969915;11173.318403583122;2352.929412117635;2396.065534441569;2399.8920048597856;2403.435192729707;2403.807695384374;2330.3707998840305;2356.9528609427803;2363.8108951283857;2370.0519792083132;2375.928722138339;2228.699125618045;2324.23300310897;2352.6588644646517;2355.646653002046;2358.481134150493;2297.632378819381;2328.8136949044037;2332.183735692511;2333.2067097186955;2348.2720356689483;2294.300238427279;2354.599718047919;2364.7280562735164;2370.2533701883854;2373.41851246444;10988.340699557972;11021.008109270124;11093.55625774968;11115.944420277927;11129.499172537255;5548.750306236229;5791.768329266824;5876;5880.794172203995;5891.558133139989;2837.517622004264;3052.3132295233618;3613.2592818472413;3714.9783809452347;3719.237556300952;1168.6143572621015;1230.2434003088126;1253.1729058821224;1254.9184303020274;1777.6089260362698;13660.248686322248;13847.930760346133;14922.253887305591;15200.923995380062;15317.693646127127;4537.931931021038;4583.106294272651;4749.430068391815;4750.714957102585;4779.880502987384;11535.538578456935;11549.942250288863;11609.30344179335;11652.417379131179;11700.180987330805;5720.656760594377;5745.482906538432;5754.971225143848;5756.942430575725;5761;5125.513076257749;5201;5296.655717378358;5302.867428314323;5348.1175606025345;3165.9366812663616;3790.6019867914024;3860.6911447084726;3894.2990261753157;3918.5101862267215;1042.0829669890447;1042.8957104289511;1045.357105380201;1053.1206442620344;1058.317385286486;803.6865622407266;942.9114511357376;965.4062751407974;967.2455484721928;1001.5242759689235;6402.775902843471;6572.967135164389;6590.80227593173;6644.402003819583;6790.151231096113;1019.56158851693;1037.7613148975777;1053.346924906563;1063.6915294564644;1064.7391389109719;4233.534311225762;4250.914981700349;4253.298205796009;4385.495667998157;4396.824127034883;11218.943905280585;11712;13808.516701915385;13863.653408664864;13971;13446.596602101952;13569.321533923265;13695.972802039887;13889.583312500641;13897.861021389657;8730.170633789907;9338.393004454689;9524;9671.661491847752;10205.693829185137;6238.438540531374;6674;6766.93233067663;6814.284500127415;6891.965540172267;9498.382605130644;10657.733556661145;11579.957803797699;11896.821547676618;11917.702057448632;11962.700932476757;11985.22096063753;12176.330301833485;12316.507339706312;12372.62882113538;8351.498910065415;8497.74506764798;8554.657813687383;8556.614952327036;8575.914240857512;9941.155001824925;10243.795124097625;10315.27793054509;10317.48412579383;10498.580056797642;9226.907730922605;9275.443473391619;9303.976562577976;9381.014993425591;9514.619415223591;8793.120687931412;8861;8999.325050621099;9064.184223419923;9117.225035872025;7801.726939557088;7966.880496792669;7988.121306656147;7993.8401231976195;7998.280154786097;5852.239208902815;5852.239208902985;5931.822045338647;6006.639601623917;6034.758609655564;5192.5586325162785;5429.891402172014;5464.754086066057;5993.011153159854;6131.509479241561 10:35:16 INFO - PROCESS | 2270 | |4;prototype.html;369.5676059010957;372.5901508340825;374.21415028440276;385.8977370996686;391.5907876269296;4799.272261985682;4980.576650984671;5175.24958880962;5252.872586602427;5257.605679574033;3970;4532.592066713995;5148.665336753118;5199.298094757207;5229.646659003454;3364.360771453416;3894.162755007673;3921.2353591049755;4001.659858911996;4124.988758206511;3861.420786881962;4020.557738648746;4321.438213032317;4340.587644173798;4418.624416924566;4162.750234985895;4325.572561054844;4354.54277300882;4358.4987726411555;4393.924253022881;3696.5933747287777;3994.1013272013856;4239.809208585591;4275.978620106911;4372.825086996516;3938.074552480165;3950.545687245975;3951.9012024699323;3966.7619942803526;3978.468289708483;5016.749162541858;5072.873178170538;5082.018012974942;5088.582923111492;5089.465606111379;4704.623630109617;4723.976380118077;4800.495638184145;4865.6594038417325;5033.119204139261;5520.447955204488;5574.86062848428;5580.86047848807;5583.441655834384;5599.860003499945;3998.960270329706;4042.0299128209313;4055.4930633670792;4415.359772832953;4487.868262575284;5165.9225111623355;5425.701586412746;5639.407862174413;5644.915326270109;5951.333626584563;4016.2770701274053;4160.396742472385;4488.842890498817;4501.032278060167;4540.977295113504;4325.8269669213505;4611.2852507861335;4640.628749700016;4657.906841863144;4660.551192117876;4146.688998325138;4834.138856540258;4845.363869989462;5017.397912250553;5051.595872330205;5032.798688052437;5399.190121481731;5483.75323110461;5535;5538.972305138448;1385.2727318158047;1504.9247537623075;1559.235974372572;1565.882558808094;1569.2310767723961;1078.412265315405;1176.823476478535;1181.5805389086922;1183.6094088950626;1205.75884823034;4395.582419670126;5032.572231360376;5064.4935506449065;5256.2115682647145;5257.056048612789;4942;5557.693941923645;5732.398098199712;5773.913391299134;5820.970895145497;4654;4973.726445045557;5202.92195617066;5283.4452382499285;5306.469353064663;2572.0354866924904;2638.5514462541414;2672.4788666210293;2816.816906901045;2936.474631816636;5546.140348246028;5577.832665020056;5656.022700023953;5889.646621202742;5970.34326224115;4586.678932474695;5076.82231121909;5628.324601047819;5755.740991655385;5812.854678632983;5154.407243167084;5751.23294242272;5957.344692083867;6013.639181649115;6084.695765211722;4679.9064018718755;5456.454354564512;5749.8275051748515;5857.824265272048;5865.178874957594;5227.869303267449;5309.14180036984;5537.1140617501005;5554.377573411542;5739.655620662606;5187.858671092354;5384.273123128328;5852.4147585241135;6019.7125092464585;6028.90956635642;4036.7577945323374;4132.772697501546;4229.80965856531;5063.911259079316;5081.932794113278;5557.749506361198;5697.4872261495;5746;5795.246617939641;5802.794937923562;4423.734575925455;4724.71651700899;4885.511448855086;5537.750801213874;5539.750711217925;4726.574608285271;5247.370315562004;5286;5502.394736579053;5521.309836270466;4651.418572678415;4830;5221.425643179323;5458.536024437808;5498.862528436821;5064.4935506449065;5290;5356.651817631841;5432.7555260012605;5566.606359265555;4855.854324370274;5112.191417394065;5209.843704688866;5429.67421954684;5472.753726082256 10:35:16 INFO - PROCESS | 2270 | |5;yui.html;722.2197283695689;763.6369081190077;771.8764997600382;811.557701052926;816.8733846253831;14927.5521734348;15708.60728481787;15970.361185552592;15982.440614578492;16067.999999999985;14240;14923.477678281262;15020;15068.472603458853;15078.47225347113;930.7300882744013;954.1365064616533;956.4118067388575;959.3092973059386;959.8704174936399;928.5264515097315;937.746808361742;943.099340130174;958.5111593087506;974.907383798538;1017.0388982411624;1020.8213562626548;1021.9131373833233;1022.5858527296419;1023.2325755683238;853.7268074216285;955.5365647660878;998.1366118307684;998.2962011781676;1017.1710056304089;742.3244847189086;751.0349201276333;753.7098217186423;754.4680999895115;755.0486387152173;15622.609434764108;15965.201739912958;16020.118893460854;16352.509424717278;16821.327146914107;14494;14857.108573485626;14888;14898;14917.179555124463;11768.411579421081;11824.467898944567;11981.9592350003;12057.0957178212;12384.009279257638;3180.3321302526497;3544.5392099027217;3621.5473065866768;3714.8142592870518;3814.48504451901;92062;109662.45168774185;111422.81785987088;113255.43372283169;114248.42875785651;9389.765255868659;11253.66239012831;11345.546178152947;11553.36456494884;11720.003799676952;24421.877890610434;25262.74737252604;25262.989480420943;25277.494450111262;25333.74666253314;6712.697928593225;7579.696812127563;7656.234376562299;7714.382849372037;7779.144294127642;3705.6664900159117;4018.417329487208;4123.113530590877;4145.771982540929;4156.9792151039655;3455.87904423349;3499.720022398202;3511.719062474996;3543.273628906068;3545.4859045438784;632.1623848400795;640.4748106552676;646.3762469217228;647.1360733420936;656.7832615236961;569.5984331046602;649.4901502320656;680.6596701649175;686.3411125319649;709.6593635055202;9670.951645241728;10094.596216151418;10205.897941020643;10250.948745256375;10354.1198998086;611.6725858109846;631.7441436218339;660.798456470781;663.7776344924505;668.9698963546653;4672.556107169813;4880.343912199385;4909.558139767367;4933.753312334369;4945.159322915113;96321;96595;102524.48737756263;103732;105065;90924.54537727269;91380.08619913849;91846;92355;92588;64915.70168596696;78459;78875.2112478868;79739;81394;7685.385169186564;9448.244140468883;9591.808163836544;9622;9634.421934683662;35705.57177712862;49836;49968.750156248985;51600.22599661083;51859.740701297764;60775.69612151911;65650.34349656443;65812;66062.00906986302;66750;11563.768724625292;11602.76794464123;11713.765724685629;11760.529578816751;12254.754904901674;12161.96623286995;12221.083418743452;12255.87744122583;12513.812292815797;12731.80902286448;11862.525498980289;11969.820452693042;12009;12051.75896482083;12337.876621234032;11775.116866235237;11844.881551184379;11867.76264474723;11920.112753770913;11945.402729863647;11715.589954351557;11762.470688818852;11786.76426471483;11873;11882.643520694393;9850.670159528372;10005.799884002425;10066;10223.011448185363;10844.45777711127;6866.622335771581;9106.726798196065;9112.589933452879;9139.543022848964;9263.76840578964 10:35:16 INFO - PROCESS | 2270 | __end_tp_report 10:35:16 INFO - PROCESS | 2270 | __start_cc_report 10:35:16 INFO - PROCESS | 2270 | _x_x_mozilla_cycle_collect,433 10:35:16 INFO - PROCESS | 2270 | __end_cc_report 10:35:16 INFO - PROCESS | 2270 | __startTimestamp1489170915995__endTimestamp 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | ------- Summary: start ------- 10:35:16 INFO - PROCESS | 2270 | Number of tests: 6 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#0] dojo.html Cycles:165 Average:5841.57 Median:6089.45 stddev:675.83 (11.1%) stddev-sans-first:639.10 10:35:16 INFO - PROCESS | 2270 | Values: 2964.5 3373.7 3403.8 3429.5 3443.4 5823.6 5831.2 5836.6 5911.9 5922.0 5458.6 5838.6 5881.6 6006.5 6021.8 4694.7 5276.4 5288.1 5327.7 5389.0 4804.6 5424.3 5427.9 5436.9 5461.3 4902.9 5284.3 5365.2 5395.4 5397.3 5320.7 5326.4 5330.5 5335.0 5341.3 5278.4 5296.5 5326.1 5329.4 5362.1 5598.7 5642.9 5666.7 5696.8 5697.4 6261.7 6276.0 6328.2 6330.8 6348.3 6413.3 6413.4 6427.7 6437.3 6458.7 5973.3 6060.9 6065.1 6080.3 6089.5 6281.6 6332.4 6426.2 6471.5 6560.8 5364.2 6176.4 6215.6 6257.8 6292.9 6305.6 6319.6 6339.9 6356.2 6357.5 6308.6 6362.8 6364.1 6366.9 6442.0 6219.3 6241.6 6245.9 6253.0 6322.7 5125.3 5129.5 5155.1 5167.1 5207.6 4512.3 4524.3 4553.0 4554.7 4589.0 5764.0 5856.8 5931.0 6067.2 6076.2 5396.4 6256.7 6297.5 6297.9 6363.4 5457.1 5616.0 6080.8 6094.6 6102.1 5608.9 5614.6 5624.9 5630.0 5639.4 5401.5 6240.4 6403.4 6446.8 6607.0 6420.6 6435.8 6450.2 6450.5 6450.9 6534.9 6580.0 6607.7 6621.2 6635.3 6165.4 6210.5 6274.2 6276.2 6382.9 6159.0 6347.4 6361.1 6368.8 6373.9 5137.9 6077.6 6113.4 6181.6 6258.9 6237.1 6271.1 6275.6 6278.2 6302.8 5464.8 5625.2 5923.9 6076.4 6106.7 5207.8 6250.4 6314.5 6322.5 6326.5 6160.6 6170.7 6173.5 6190.3 6190.9 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#1] ext.html Cycles:180 Average:50849.01 Median:187884.62 stddev:94609.69 (50.4%) stddev-sans-first:94800.25 10:35:16 INFO - PROCESS | 2270 | Values: 725.7 782.2 801.7 936.6 944.1 39756.6 40234.6 40361.8 40422.0 40484.2 38642.8 38958.0 38969.4 38999.4 39091.6 7814.5 7959.0 10900.9 11053.5 11132.9 10725.2 10810.9 10827.7 10855.9 10866.6 10810.0 10817.0 10838.5 10848.8 10859.5 9414.7 10627.3 10806.9 10824.6 10840.7 8984.3 9378.4 10824.9 10875.5 10911.3 38758.8 38935.6 39005.4 39063.8 39106.0 3682.6 3744.2 3746.9 3776.7 3910.9 23838.2 27006.7 27724.0 28919.0 28930.9 3079.5 3248.5 3291.3 3291.4 3301.6 338026.0 341590.0 343392.3 352321.0 361508.2 49485.0 49737.5 49846.5 49920.0 50043.2 52000.7 52387.0 52615.2 52737.5 52896.5 10833.3 13721.6 13822.0 13888.4 13931.2 8996.6 11037.6 11095.8 11141.4 11181.0 13796.2 13797.0 13814.9 13842.1 13899.1 5802.8 5828.6 5873.4 5883.2 5889.9 973.3 1118.8 1130.1 1154.2 1184.9 24814.1 25848.7 26171.9 26509.7 26548.6 1017.8 1062.3 1238.6 1262.9 1277.4 13556.5 13632.6 13732.2 13864.6 13970.9 394908.0 395371.0 395501.0 396425.0 401016.0 43896.8 55072.7 55117.7 55156.2 55162.4 1277.2 1375.6 1426.2 1432.2 1438.1 21896.7 22824.7 25016.9 25783.7 25890.6 34058.1 34660.1 41201.4 41217.2 41365.8 285247.0 327975.0 331996.0 342789.3 358117.0 32612.7 32835.2 34038.1 34670.5 35374.5 44468.0 44787.7 45237.8 45697.8 45745.1 34708.5 34879.1 36645.8 37570.6 37828.8 36139.6 36207.0 36234.0 37055.1 37546.0 36673.6 37716.2 39385.8 39954.8 40025.2 27127.2 29595.3 33815.0 33936.3 34179.2 19745.9 25127.7 25441.2 25730.1 25735.8 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#2] jquery.html Cycles:180 Average:37553.26 Median:22205.28 stddev:93937.78 (423.0%) stddev-sans-first:94159.72 10:35:16 INFO - PROCESS | 2270 | Values: 329.8 370.1 398.4 418.6 437.5 19640.8 21884.3 22128.3 22392.4 22855.1 22282.2 22534.4 22906.8 23037.4 23133.5 6282.2 6518.9 6550.4 6571.9 6573.6 6428.1 7070.2 7453.1 7563.8 7578.2 6515.9 7259.7 7494.0 7512.0 7553.1 7518.4 7563.0 7609.1 7611.3 7618.3 7140.3 7397.3 7410.7 7411.4 7430.1 24804.6 26956.0 27199.7 27474.5 27690.9 3235.3 3320.0 3351.8 3371.1 3484.8 15713.6 16234.8 16615.9 16942.2 17084.7 1926.7 1989.5 2012.3 2064.8 2075.2 144806.0 157146.0 157576.0 161335.2 161435.0 14126.5 16874.7 17371.4 21197.4 21408.7 34912.0 34931.0 35314.3 35372.3 35375.0 10148.5 10159.7 10340.9 10350.7 10555.8 8204.8 8206.0 8210.6 8400.1 8406.1 10269.5 10504.7 10516.3 10631.3 10649.1 3994.4 4067.7 4068.0 4095.8 4102.7 1009.2 1019.3 1019.9 1055.6 1076.3 22487.9 23983.8 24012.5 24042.0 24188.8 897.0 959.8 977.6 977.8 1034.8 12061.7 12134.8 12425.9 12441.6 12527.3 437942.0 494809.0 513144.0 513307.0 732370.0 151442.2 161982.0 162006.2 162082.0 166872.2 1217.2 1341.4 1351.7 1365.6 1369.2 18281.5 18861.6 20242.5 20470.8 20709.0 48632.3 58884.0 59054.7 59218.7 59915.4 79937.0 82100.2 82622.6 83694.0 84066.0 11513.8 11756.0 12011.1 12036.6 12138.8 12420.3 13418.8 13872.4 13876.1 13950.4 10248.0 11257.5 11398.0 11491.7 11709.3 8985.5 11569.6 11740.8 12161.6 12179.3 10112.5 10802.0 12087.3 12187.9 12230.8 10052.0 10281.8 11806.1 12061.3 12334.9 9288.7 9853.2 10645.3 11573.2 11910.8 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#3] mootools.html Cycles:180 Average:6623.84 Median:2397.98 stddev:4088.90 (170.5%) stddev-sans-first:4080.87 10:35:16 INFO - PROCESS | 2270 | Values: 1309.9 1514.3 1565.2 1568.6 1580.4 10127.7 10722.7 10728.6 10842.8 11243.9 9099.0 10965.2 10997.7 11077.7 11173.3 2352.9 2396.1 2399.9 2403.4 2403.8 2330.4 2357.0 2363.8 2370.1 2375.9 2228.7 2324.2 2352.7 2355.6 2358.5 2297.6 2328.8 2332.2 2333.2 2348.3 2294.3 2354.6 2364.7 2370.3 2373.4 10988.3 11021.0 11093.6 11115.9 11129.5 5548.8 5791.8 5876.0 5880.8 5891.6 2837.5 3052.3 3613.3 3715.0 3719.2 1168.6 1230.2 1253.2 1254.9 1777.6 13660.2 13847.9 14922.3 15200.9 15317.7 4537.9 4583.1 4749.4 4750.7 4779.9 11535.5 11549.9 11609.3 11652.4 11700.2 5720.7 5745.5 5755.0 5756.9 5761.0 5125.5 5201.0 5296.7 5302.9 5348.1 3165.9 3790.6 3860.7 3894.3 3918.5 1042.1 1042.9 1045.4 1053.1 1058.3 803.7 942.9 965.4 967.2 1001.5 6402.8 6573.0 6590.8 6644.4 6790.2 1019.6 1037.8 1053.3 1063.7 1064.7 4233.5 4250.9 4253.3 4385.5 4396.8 11218.9 11712.0 13808.5 13863.7 13971.0 13446.6 13569.3 13696.0 13889.6 13897.9 8730.2 9338.4 9524.0 9671.7 10205.7 6238.4 6674.0 6766.9 6814.3 6892.0 9498.4 10657.7 11580.0 11896.8 11917.7 11962.7 11985.2 12176.3 12316.5 12372.6 8351.5 8497.7 8554.7 8556.6 8575.9 9941.2 10243.8 10315.3 10317.5 10498.6 9226.9 9275.4 9304.0 9381.0 9514.6 8793.1 8861.0 8999.3 9064.2 9117.2 7801.7 7966.9 7988.1 7993.8 7998.3 5852.2 5852.2 5931.8 6006.6 6034.8 5192.6 5429.9 5464.8 5993.0 6131.5 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#4] prototype.html Cycles:180 Average:4608.47 Median:5032.96 stddev:1298.98 (25.8%) stddev-sans-first:1263.06 10:35:16 INFO - PROCESS | 2270 | Values: 369.6 372.6 374.2 385.9 391.6 4799.3 4980.6 5175.2 5252.9 5257.6 3970.0 4532.6 5148.7 5199.3 5229.6 3364.4 3894.2 3921.2 4001.7 4125.0 3861.4 4020.6 4321.4 4340.6 4418.6 4162.8 4325.6 4354.5 4358.5 4393.9 3696.6 3994.1 4239.8 4276.0 4372.8 3938.1 3950.5 3951.9 3966.8 3978.5 5016.7 5072.9 5082.0 5088.6 5089.5 4704.6 4724.0 4800.5 4865.7 5033.1 5520.4 5574.9 5580.9 5583.4 5599.9 3999.0 4042.0 4055.5 4415.4 4487.9 5165.9 5425.7 5639.4 5644.9 5951.3 4016.3 4160.4 4488.8 4501.0 4541.0 4325.8 4611.3 4640.6 4657.9 4660.6 4146.7 4834.1 4845.4 5017.4 5051.6 5032.8 5399.2 5483.8 5535.0 5539.0 1385.3 1504.9 1559.2 1565.9 1569.2 1078.4 1176.8 1181.6 1183.6 1205.8 4395.6 5032.6 5064.5 5256.2 5257.1 4942.0 5557.7 5732.4 5773.9 5821.0 4654.0 4973.7 5202.9 5283.4 5306.5 2572.0 2638.6 2672.5 2816.8 2936.5 5546.1 5577.8 5656.0 5889.6 5970.3 4586.7 5076.8 5628.3 5755.7 5812.9 5154.4 5751.2 5957.3 6013.6 6084.7 4679.9 5456.5 5749.8 5857.8 5865.2 5227.9 5309.1 5537.1 5554.4 5739.7 5187.9 5384.3 5852.4 6019.7 6028.9 4036.8 4132.8 4229.8 5063.9 5081.9 5557.7 5697.5 5746.0 5795.2 5802.8 4423.7 4724.7 4885.5 5537.8 5539.8 4726.6 5247.4 5286.0 5502.4 5521.3 4651.4 4830.0 5221.4 5458.5 5498.9 5064.5 5290.0 5356.7 5432.8 5566.6 4855.9 5112.2 5209.8 5429.7 5472.8 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - PROCESS | 2270 | [#5] yui.html Cycles:180 Average:20248.13 Median:3764.65 stddev:29493.83 (783.4%) stddev-sans-first:29540.13 10:35:16 INFO - PROCESS | 2270 | Values: 722.2 763.6 771.9 811.6 816.9 14927.6 15708.6 15970.4 15982.4 16068.0 14240.0 14923.5 15020.0 15068.5 15078.5 930.7 954.1 956.4 959.3 959.9 928.5 937.7 943.1 958.5 974.9 1017.0 1020.8 1021.9 1022.6 1023.2 853.7 955.5 998.1 998.3 1017.2 742.3 751.0 753.7 754.5 755.0 15622.6 15965.2 16020.1 16352.5 16821.3 14494.0 14857.1 14888.0 14898.0 14917.2 11768.4 11824.5 11982.0 12057.1 12384.0 3180.3 3544.5 3621.5 3714.8 3814.5 92062.0 109662.5 111422.8 113255.4 114248.4 9389.8 11253.7 11345.5 11553.4 11720.0 24421.9 25262.7 25263.0 25277.5 25333.7 6712.7 7579.7 7656.2 7714.4 7779.1 3705.7 4018.4 4123.1 4145.8 4157.0 3455.9 3499.7 3511.7 3543.3 3545.5 632.2 640.5 646.4 647.1 656.8 569.6 649.5 680.7 686.3 709.7 9671.0 10094.6 10205.9 10250.9 10354.1 611.7 631.7 660.8 663.8 669.0 4672.6 4880.3 4909.6 4933.8 4945.2 96321.0 96595.0 102524.5 103732.0 105065.0 90924.5 91380.1 91846.0 92355.0 92588.0 64915.7 78459.0 78875.2 79739.0 81394.0 7685.4 9448.2 9591.8 9622.0 9634.4 35705.6 49836.0 49968.8 51600.2 51859.7 60775.7 65650.3 65812.0 66062.0 66750.0 11563.8 11602.8 11713.8 11760.5 12254.8 12162.0 12221.1 12255.9 12513.8 12731.8 11862.5 11969.8 12009.0 12051.8 12337.9 11775.1 11844.9 11867.8 11920.1 11945.4 11715.6 11762.5 11786.8 11873.0 11882.6 9850.7 10005.8 10066.0 10223.0 10844.5 6866.6 9106.7 9112.6 9139.5 9263.8 10:35:16 INFO - PROCESS | 2270 | -------- Summary: end -------- 10:35:16 INFO - PROCESS | 2270 | 10:35:16 INFO - TEST-INFO | 2270: exit 0 10:35:16 INFO - TEST-OK | dromaeo_css | took 1117503ms 10:35:16 INFO - TEST-START | kraken 10:35:16 INFO - operating with platform_type : mac_ 10:35:16 INFO - Initialising browser for kraken test... 10:35:16 INFO - TEST-INFO | started process 2275 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpOg7q6l/profile http://localhost:54218/getInfo.html) 10:35:19 INFO - PROCESS | 2275 | 2017-03-10 10:35:19.545 plugin-container[2276:25564] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:35:19 INFO - PROCESS | 2275 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:19 INFO - PROCESS | 2275 | 2017-03-10 10:35:19.548 plugin-container[2276:25564] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 10:35:19 INFO - PROCESS | 2275 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:19 INFO - PROCESS | 2275 | 2017-03-10 10:35:19.548 plugin-container[2276:25564] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:35:19 INFO - PROCESS | 2275 | __metrics Screen width/height:1600/1200 10:35:19 INFO - PROCESS | 2275 | colorDepth:24 10:35:19 INFO - PROCESS | 2275 | Browser inner width/height: 1024/689 10:35:19 INFO - PROCESS | 2275 | __metrics 10:35:19 ERROR - PROCESS | 2275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:35:20 INFO - TEST-INFO | 2275: exit 0 10:35:20 INFO - Browser initialized. 10:35:20 INFO - Running cycle 1/1 for kraken test... 10:35:20 INFO - TEST-INFO | started process 2277 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpOg7q6l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:23 INFO - PROCESS | 2277 | 2017-03-10 10:35:23.138 plugin-container[2278:25685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 10:35:23 INFO - PROCESS | 2277 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:23 INFO - PROCESS | 2277 | 2017-03-10 10:35:23.139 plugin-container[2278:25685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 10:35:23 INFO - PROCESS | 2277 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:23 INFO - PROCESS | 2277 | 2017-03-10 10:35:23.139 plugin-container[2278:25685] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:35:32 INFO - PROCESS | 2277 | RSS: Main: 227549184 10:35:32 INFO - PROCESS | 2277 | 10:35:35 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54218/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:36 INFO - PROCESS | 2277 | RSS: Main: 241750016 10:35:36 INFO - PROCESS | 2277 | 10:35:39 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54218/tests/kraken/driver.html?testName=audio-dft) 10:35:40 INFO - PROCESS | 2277 | RSS: Main: 250249216 10:35:40 INFO - PROCESS | 2277 | 10:35:43 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54218/tests/kraken/driver.html?testName=audio-fft) 10:35:43 INFO - PROCESS | 2277 | RSS: Main: 252850176 10:35:43 INFO - PROCESS | 2277 | 10:35:46 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54218/tests/kraken/driver.html?testName=audio-oscillator) 10:35:46 INFO - PROCESS | 2277 | RSS: Main: 255123456 10:35:46 INFO - PROCESS | 2277 | 10:35:48 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:49 INFO - PROCESS | 2277 | RSS: Main: 255799296 10:35:49 INFO - PROCESS | 2277 | 10:35:52 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54218/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:52 INFO - PROCESS | 2277 | RSS: Main: 261021696 10:35:52 INFO - PROCESS | 2277 | 10:35:56 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54218/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:57 INFO - PROCESS | 2277 | RSS: Main: 259420160 10:35:57 INFO - PROCESS | 2277 | 10:36:00 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54218/tests/kraken/driver.html?testName=json-parse-financial) 10:36:00 INFO - PROCESS | 2277 | RSS: Main: 260636672 10:36:00 INFO - PROCESS | 2277 | 10:36:02 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:03 INFO - PROCESS | 2277 | RSS: Main: 260341760 10:36:03 INFO - PROCESS | 2277 | 10:36:05 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:05 INFO - PROCESS | 2277 | RSS: Main: 260300800 10:36:05 INFO - PROCESS | 2277 | 10:36:08 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:08 INFO - PROCESS | 2277 | RSS: Main: 260382720 10:36:08 INFO - PROCESS | 2277 | 10:36:11 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:12 INFO - PROCESS | 2277 | RSS: Main: 260804608 10:36:12 INFO - PROCESS | 2277 | 10:36:15 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:16 INFO - PROCESS | 2277 | RSS: Main: 260595712 10:36:16 INFO - PROCESS | 2277 | 10:36:17 INFO - PROCESS | 2277 | Cycle 1(1): loaded http://localhost:54218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54218/tests/kraken/driver.html?testName=ai-astar) 10:36:18 INFO - PROCESS | 2277 | RSS: Main: 263835648 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | __start_tp_report 10:36:18 INFO - PROCESS | 2277 | _x_x_mozilla_page_load 10:36:18 INFO - PROCESS | 2277 | _x_x_mozilla_page_load_details 10:36:18 INFO - PROCESS | 2277 | |i|pagename|runs| 10:36:18 INFO - PROCESS | 2277 | |0;ai-astar;113;179;155;119;119;119;120;118;120;134 10:36:18 INFO - PROCESS | 2277 | |1;audio-beat-detection;150;114;116;182;145;148;115;149;163;114 10:36:18 INFO - PROCESS | 2277 | |2;audio-dft;208;217;213;222;204;198;201;200;200;196 10:36:18 INFO - PROCESS | 2277 | |3;audio-fft;87;61;63;90;67;85;63;85;85;58 10:36:18 INFO - PROCESS | 2277 | |4;audio-oscillator;96;71;86;72;71;70;83;71;72;115 10:36:18 INFO - PROCESS | 2277 | |5;imaging-gaussian-blur;89;103;111;90;90;93;91;90;93;77 10:36:18 INFO - PROCESS | 2277 | |6;imaging-darkroom;154;121;109;151;120;112;156;134;140;155 10:36:18 INFO - PROCESS | 2277 | |7;imaging-desaturate;91;90;92;91;95;89;92;89;136;123 10:36:18 INFO - PROCESS | 2277 | |8;json-parse-financial;88;84;69;69;68;68;69;70;71;69 10:36:18 INFO - PROCESS | 2277 | |9;json-stringify-tinderbox;60;63;74;87;85;85;58;59;58;62 10:36:18 INFO - PROCESS | 2277 | |10;stanford-crypto-aes;90;87;89;87;88;90;90;88;90;110 10:36:18 INFO - PROCESS | 2277 | |11;stanford-crypto-ccm;143;150;166;149;140;143;154;147;197;159 10:36:18 INFO - PROCESS | 2277 | |12;stanford-crypto-pbkdf2;191;174;177;174;176;171;173;180;175;174 10:36:18 INFO - PROCESS | 2277 | |13;stanford-crypto-sha256-iterative;69;68;69;71;96;96;71;68;69;69 10:36:18 INFO - PROCESS | 2277 | __end_tp_report 10:36:18 INFO - PROCESS | 2277 | __start_cc_report 10:36:18 INFO - PROCESS | 2277 | _x_x_mozilla_cycle_collect,1011 10:36:18 INFO - PROCESS | 2277 | __end_cc_report 10:36:18 INFO - PROCESS | 2277 | __startTimestamp1489170978101__endTimestamp 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | ------- Summary: start ------- 10:36:18 INFO - PROCESS | 2277 | Number of tests: 14 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#0] ai-astar Cycles:10 Average:129.60 Median:120.00 stddev:21.18 (17.6%) stddev-sans-first:21.59 10:36:18 INFO - PROCESS | 2277 | Values: 113.0 179.0 155.0 119.0 119.0 119.0 120.0 118.0 120.0 134.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:148.50 stddev:23.84 (16.1%) stddev-sans-first:24.99 10:36:18 INFO - PROCESS | 2277 | Values: 150.0 114.0 116.0 182.0 145.0 148.0 115.0 149.0 163.0 114.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#2] audio-dft Cycles:10 Average:205.90 Median:206.00 stddev:8.79 (4.3%) stddev-sans-first:9.29 10:36:18 INFO - PROCESS | 2277 | Values: 208.0 217.0 213.0 222.0 204.0 198.0 201.0 200.0 200.0 196.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#3] audio-fft Cycles:10 Average:74.40 Median:85.00 stddev:12.92 (15.2%) stddev-sans-first:12.87 10:36:18 INFO - PROCESS | 2277 | Values: 87.0 61.0 63.0 90.0 67.0 85.0 63.0 85.0 85.0 58.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#4] audio-oscillator Cycles:10 Average:80.70 Median:72.00 stddev:14.88 (20.7%) stddev-sans-first:14.71 10:36:18 INFO - PROCESS | 2277 | Values: 96.0 71.0 86.0 72.0 71.0 70.0 83.0 71.0 72.0 115.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:90.00 stddev:8.98 (10.0%) stddev-sans-first:9.43 10:36:18 INFO - PROCESS | 2277 | Values: 89.0 103.0 111.0 90.0 90.0 93.0 91.0 90.0 93.0 77.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#6] imaging-darkroom Cycles:10 Average:135.20 Median:145.50 stddev:18.59 (12.8%) stddev-sans-first:18.43 10:36:18 INFO - PROCESS | 2277 | Values: 154.0 121.0 109.0 151.0 120.0 112.0 156.0 134.0 140.0 155.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:91.00 stddev:16.56 (18.2%) stddev-sans-first:17.32 10:36:18 INFO - PROCESS | 2277 | Values: 91.0 90.0 92.0 91.0 95.0 89.0 92.0 89.0 136.0 123.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#8] json-parse-financial Cycles:10 Average:72.50 Median:69.50 stddev:7.23 (10.4%) stddev-sans-first:5.04 10:36:18 INFO - PROCESS | 2277 | Values: 88.0 84.0 69.0 69.0 68.0 68.0 69.0 70.0 71.0 69.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:12.33 (18.0%) stddev-sans-first:12.63 10:36:18 INFO - PROCESS | 2277 | Values: 60.0 63.0 74.0 87.0 85.0 85.0 58.0 59.0 58.0 62.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:89.50 stddev:6.82 (7.6%) stddev-sans-first:7.23 10:36:18 INFO - PROCESS | 2277 | Values: 90.0 87.0 89.0 87.0 88.0 90.0 90.0 88.0 90.0 110.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:152.00 stddev:16.80 (11.1%) stddev-sans-first:17.27 10:36:18 INFO - PROCESS | 2277 | Values: 143.0 150.0 166.0 149.0 140.0 143.0 154.0 147.0 197.0 159.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:175.50 stddev:5.64 (3.2%) stddev-sans-first:2.57 10:36:18 INFO - PROCESS | 2277 | Values: 191.0 174.0 177.0 174.0 176.0 171.0 173.0 180.0 175.0 174.0 10:36:18 INFO - PROCESS | 2277 | 10:36:18 INFO - PROCESS | 2277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:70.00 stddev:11.33 (16.2%) stddev-sans-first:11.83 10:36:18 INFO - PROCESS | 2277 | Values: 69.0 68.0 69.0 71.0 96.0 96.0 71.0 68.0 69.0 69.0 10:36:18 INFO - PROCESS | 2277 | -------- Summary: end -------- 10:36:18 INFO - PROCESS | 2277 | 10:36:19 INFO - TEST-INFO | 2277: exit 0 10:36:19 INFO - TEST-OK | kraken | took 62479ms 10:36:19 INFO - SUITE-END | took 1179s 10:36:19 INFO - Completed test suite (00:19:40) 10:36:19 INFO - javascript benchmark 10:36:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7673.2977913947, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2964.466396048711, 3373.6795004474566, 3403.778754380965, 3429.4512877939533, 3443.449048152296, 5823.563232757544, 5831.212786273852, 5836.620619659724, 5911.940880591193, 5922.022866227067, 5458.580769000058, 5838.591298609099, 5881.617694849831, 6006.45941865232, 6021.8193454196335, 4694.694844835083, 5276.445973172819, 5288.127458969266, 5327.680517054812, 5388.973055134738, 4804.639652026094, 5424.349078110632, 5427.945720542803, 5436.891262174754, 5461.317335333083, 4902.852914412538, 5284.313039304904, 5365.222042803811, 5395.3525576931015, 5397.325334333189, 5320.654157479751, 5326.44072372403, 5330.546903513206, 5334.959682861843, 5341.305630268079, 5278.445763194848, 5296.496832800916, 5326.147816349404, 5329.440408757102, 5362.115250983583, 5598.664080155204, 5642.943570564283, 5666.716664166816, 5696.829095127153, 5697.373288938214, 6261.749530018794, 6275.96862015687, 6328.208973878265, 6330.778422755181, 6348.301686814447, 6413.3266007069515, 6413.422791948747, 6427.710753016126, 6437.259715132773, 6458.709358078898, 5973.253343332083, 6060.909086363708, 6065.059915713072, 6080.331163572004, 6089.451949324582, 6281.560290779602, 6332.398422149889, 6426.164598602152, 6471.482281417475, 6560.835979100465, 5364.168553874156, 6176.4441200292185, 6215.627062376272, 6257.843553911098, 6292.874142517124, 6305.5901366411035, 6319.557630965788, 6339.936600633934, 6356.173697419306, 6357.4914006879335, 6308.621482711052, 6362.809115726535, 6364.077208804697, 6366.904496432558, 6441.967790161019, 6219.346968568326, 6241.563090583706, 6245.875082498415, 6253.030780229072, 6322.71547780351, 5125.256837758504, 5129.487051294916, 5155.123628983007, 5167.069927413027, 5207.635465517377, 4512.278035514302, 4524.298733696282, 4552.9772351138035, 4554.726716397026, 4588.990422107131, 5763.991301522301, 5856.795012174553, 5931.0, 6067.211262535842, 6076.240469941257, 5396.379416367168, 6256.6871656417, 6297.4962003039645, 6297.905531417033, 6363.395477429637, 5457.099578569571, 5616.045272303718, 6080.847978800565, 6094.573379863367, 6102.084687296852, 5608.943910560843, 5614.550835933115, 5624.91562626561, 5629.971850140723, 5639.407862174495, 5401.459854014724, 6240.438360547481, 6403.423691867662, 6446.806595802133, 6606.966965165336, 6420.550561460653, 6435.839104022437, 6450.193725784277, 6450.48396128318, 6450.870982580416, 6534.869302613826, 6579.967100164468, 6607.702653380513, 6621.238557565942, 6635.270120286861, 6165.3526379731275, 6210.534209934182, 6274.152989346379, 6276.152719382825, 6382.872342553216, 6159.0, 6347.428731414195, 6361.14124593174, 6368.808935731936, 6373.936260637334, 5137.8502231575485, 6077.635341879324, 6113.385090541831, 6181.629102253879, 6258.93598088317, 6237.064440333987, 6271.122042914087, 6275.623462592259, 6278.15244941927, 6302.84242893913, 5464.825062611558, 5625.184348269559, 5923.940760592339, 6076.392360763888, 6106.72519736604, 5207.817726379559, 6250.3749625037135, 6314.526410519137, 6322.525810564134, 6326.493880489642, 6160.568760186923, 6170.691465426621, 6173.475254603409, 6190.319064902767, 6190.938090619036], "value": 5798.348469775398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.7024619905836, 782.2255966593073, 801.6993627389727, 936.6300311377006, 944.1078181118837, 39756.602433975655, 40234.59765402345, 40361.79819100904, 40422.0, 40484.19031619373, 38642.80678596603, 38958.0, 38969.41545876814, 38999.41500877489, 39091.60908390922, 7814.531128132302, 7959.0, 10900.945495272552, 11053.502592383362, 11132.888671113307, 10725.249232553724, 10810.891891081106, 10827.67516974492, 10855.945720271387, 10866.61966831161, 10810.0, 10817.0, 10838.458077096153, 10848.78302433951, 10859.457027148612, 9414.670486532972, 10627.309224900357, 10806.945965270163, 10824.621138260123, 10840.728981775439, 8984.326175536795, 9378.437293762396, 10824.891751082547, 10875.510602022929, 10911.290766100177, 38758.80620596907, 38935.61064389348, 39005.41491877624, 39063.82808515749, 39106.022349441206, 3682.6317368263226, 3744.1949980754, 3746.9437958430644, 3776.7356285060055, 3910.902227444337, 23838.16566420167, 27006.729932700815, 27724.02965896204, 28919.0, 28930.855345723136, 3079.538069289602, 3248.4640034394297, 3291.2923721400016, 3291.391092647844, 3301.60380754311, 338026.0, 341590.0, 343392.2830385857, 352321.0, 361508.19245903863, 49485.0102997938, 49737.502624973284, 49846.501534984185, 49920.0, 50043.24935125976, 52000.73999629977, 52386.95226095457, 52615.21077183845, 52737.47262527402, 52896.47103528993, 10833.29583577065, 13721.588352349445, 13822.032457727862, 13888.375023123983, 13931.233782142079, 8996.59515321812, 11037.613683521038, 11095.83356249657, 11141.442927853575, 11181.0, 13796.241206733726, 13797.034207605371, 13814.861851381558, 13842.100263482842, 13899.096558723651, 5802.82591522255, 5828.6211396259105, 5873.383294754075, 5883.205622285244, 5889.911651325234, 973.2749101919115, 1118.8209886418297, 1130.0789856267115, 1154.186298659443, 1184.8992835608897, 24814.138939579243, 25848.74151258501, 26171.869140654177, 26509.73490265111, 26548.60177097345, 1017.7710015246511, 1062.2776511971933, 1238.6407941696807, 1262.9494820207271, 1277.3804704718204, 13556.525521606696, 13632.591022269347, 13732.244726540137, 13864.584062478141, 13970.860291397159, 394908.0, 395371.0, 395501.0, 396425.0, 401016.0, 43896.78051609721, 55072.72463637656, 55117.72441137768, 55156.17265741017, 55162.448375515734, 1277.182603133995, 1375.6148278482042, 1426.1585664458019, 1432.176498513359, 1438.101186758276, 21896.671549927083, 22824.65763013523, 25016.874915625307, 25783.742162578135, 25890.611640825027, 34058.14854628654, 34660.133496662784, 41201.38197926973, 41217.1756564873, 41365.793171033954, 285247.0, 327975.0, 331996.0, 342789.2860535681, 358117.0, 32612.673873260963, 32835.17912052218, 34038.14904627404, 34670.479942800375, 35374.46938295876, 44468.0, 44787.65637030894, 45237.77381113073, 45697.77151114223, 45745.08509829718, 34708.47937280993, 34879.12802179966, 36645.816770915975, 37570.624293757806, 37828.81085594554, 36139.63860361468, 36207.0, 36234.0, 37055.07362315964, 37546.0, 36673.61621494701, 37716.2456750858, 39385.80307098446, 39954.80022599868, 40025.1994960105, 27127.236729612512, 29595.260118497208, 33815.0, 33936.32127357488, 34179.24028356829, 19745.901270493556, 25127.74872251327, 25441.236762897144, 25730.09944651928, 25735.8418871155], "value": 18653.34567398705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.8334341157715, 370.1061935425946, 398.39841838823367, 418.59814578005114, 437.4597372245278, 19640.803591964075, 21884.343469695894, 22128.33614991553, 22392.440188995282, 22855.08579656814, 22282.220122295723, 22534.43663908403, 22906.77093229067, 23037.424064398398, 23133.537329253446, 6282.2147231596055, 6518.902216466757, 6550.377714117151, 6571.93428065718, 6573.638449885254, 6428.132202152719, 7070.186928503236, 7453.068366454193, 7563.848723025536, 7578.242175782433, 6515.934840651604, 7259.709611615529, 7493.962530187341, 7512.0, 7553.055868016498, 7518.360939320164, 7562.962185189066, 7609.124950630693, 7611.2769286917655, 7618.314351708345, 7140.250273721236, 7397.297256760599, 7410.666520006613, 7411.407087433046, 7430.108386993541, 24804.627930581057, 26956.0, 27199.728002720116, 27474.450510989867, 27690.861545692143, 3235.3367559650214, 3319.966800332014, 3351.8491667875005, 3371.1403592084107, 3484.8257587120797, 15713.607159821097, 16234.837651623451, 16615.916920415442, 16942.152892355334, 17084.743728844078, 1926.6532024235632, 1989.502624343914, 2012.2956965062258, 2064.84513661476, 2075.2321640992777, 144806.0, 157146.0, 157576.0, 161335.1933240338, 161435.0, 14126.50557230492, 16874.662506749795, 17371.392001280146, 21197.36407907765, 21408.678869816966, 34912.0, 34931.0, 35314.293714125575, 35372.29255414877, 35375.0, 10148.492575371349, 10159.695209143738, 10340.948295258475, 10350.741231469123, 10555.788884222273, 8204.8359032819, 8206.0, 8210.589470526449, 8400.117987611335, 8406.117357677478, 10269.514202256649, 10504.737381565523, 10516.263861529773, 10631.308964917256, 10649.094826939798, 3994.380870965005, 4067.6745860331694, 4067.9796601016806, 4095.815688294034, 4102.671786257092, 1009.1926458833051, 1019.3333899075066, 1019.8726644420824, 1055.6410820321128, 1076.3165389977264, 22487.887560562092, 23983.760162398154, 24012.51974960491, 24042.038318467414, 24188.758112419004, 897.0043251990415, 959.827231098409, 977.5796407544824, 977.8239916815041, 1034.8395998620226, 12061.698457538456, 12134.817977730341, 12425.875741242653, 12441.564545240873, 12527.310997895022, 437942.0, 494809.0, 513144.0, 513307.0, 732370.0, 151442.24278878755, 161982.0, 162006.18996905175, 162082.0, 166872.22827791094, 1217.1662411248324, 1341.4298922957703, 1351.6620844788804, 1365.6108009217326, 1369.205860600849, 18281.451556452797, 18861.622767544846, 20242.493937651678, 20470.79529204689, 20709.0, 48632.270515943, 58884.0, 59054.70472647609, 59218.70390648192, 59915.40084599098, 79937.0, 82100.17899821165, 82622.58688706759, 83694.0, 84066.0, 11513.827292590451, 11756.0, 12011.099167562294, 12036.578719744766, 12138.786121387791, 12420.254784712946, 13418.798718019432, 13872.4451021958, 13876.098053626481, 13950.441982321, 10247.97808957321, 11257.549698011988, 11398.031167350868, 11491.655250342503, 11709.30685942221, 8985.46087234768, 11569.595064172714, 11740.823887641864, 12161.574344897886, 12179.269243845398, 10112.544935477774, 10801.9738124878, 12087.274763514217, 12187.939060304641, 12230.75538489243, 10052.0, 10281.84577231357, 11806.114541409257, 12061.276323420623, 12334.876651233373, 9288.674896378594, 9853.211743060681, 10645.308054976402, 11573.18987670855, 11910.821337680116], "value": 11776.416902601935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.9258607941488, 1514.3488300030983, 1565.2095691675702, 1568.5608029751675, 1580.3994482096803, 10127.746806329846, 10722.678319650404, 10728.624498142566, 10842.783144337109, 11243.887561124386, 9099.04460031697, 10965.232433729621, 10997.670069897897, 11077.667669969915, 11173.318403583122, 2352.929412117635, 2396.065534441569, 2399.8920048597856, 2403.435192729707, 2403.807695384374, 2330.3707998840305, 2356.9528609427803, 2363.8108951283857, 2370.0519792083132, 2375.928722138339, 2228.699125618045, 2324.23300310897, 2352.6588644646517, 2355.646653002046, 2358.481134150493, 2297.632378819381, 2328.8136949044037, 2332.183735692511, 2333.2067097186955, 2348.2720356689483, 2294.300238427279, 2354.599718047919, 2364.7280562735164, 2370.2533701883854, 2373.41851246444, 10988.340699557972, 11021.008109270124, 11093.55625774968, 11115.944420277927, 11129.499172537255, 5548.750306236229, 5791.768329266824, 5876.0, 5880.794172203995, 5891.558133139989, 2837.517622004264, 3052.3132295233618, 3613.2592818472413, 3714.9783809452347, 3719.237556300952, 1168.6143572621015, 1230.2434003088126, 1253.1729058821224, 1254.9184303020274, 1777.6089260362698, 13660.248686322248, 13847.930760346133, 14922.253887305591, 15200.923995380062, 15317.693646127127, 4537.931931021038, 4583.106294272651, 4749.430068391815, 4750.714957102585, 4779.880502987384, 11535.538578456935, 11549.942250288863, 11609.30344179335, 11652.417379131179, 11700.180987330805, 5720.656760594377, 5745.482906538432, 5754.971225143848, 5756.942430575725, 5761.0, 5125.513076257749, 5201.0, 5296.655717378358, 5302.867428314323, 5348.1175606025345, 3165.9366812663616, 3790.6019867914024, 3860.6911447084726, 3894.2990261753157, 3918.5101862267215, 1042.0829669890447, 1042.8957104289511, 1045.357105380201, 1053.1206442620344, 1058.317385286486, 803.6865622407266, 942.9114511357376, 965.4062751407974, 967.2455484721928, 1001.5242759689235, 6402.775902843471, 6572.967135164389, 6590.80227593173, 6644.402003819583, 6790.151231096113, 1019.56158851693, 1037.7613148975777, 1053.346924906563, 1063.6915294564644, 1064.7391389109719, 4233.534311225762, 4250.914981700349, 4253.298205796009, 4385.495667998157, 4396.824127034883, 11218.943905280585, 11712.0, 13808.516701915385, 13863.653408664864, 13971.0, 13446.596602101952, 13569.321533923265, 13695.972802039887, 13889.583312500641, 13897.861021389657, 8730.170633789907, 9338.393004454689, 9524.0, 9671.661491847752, 10205.693829185137, 6238.438540531374, 6674.0, 6766.93233067663, 6814.284500127415, 6891.965540172267, 9498.382605130644, 10657.733556661145, 11579.957803797699, 11896.821547676618, 11917.702057448632, 11962.700932476757, 11985.22096063753, 12176.330301833485, 12316.507339706312, 12372.62882113538, 8351.498910065415, 8497.74506764798, 8554.657813687383, 8556.614952327036, 8575.914240857512, 9941.155001824925, 10243.795124097625, 10315.27793054509, 10317.48412579383, 10498.580056797642, 9226.907730922605, 9275.443473391619, 9303.976562577976, 9381.014993425591, 9514.619415223591, 8793.120687931412, 8861.0, 8999.325050621099, 9064.184223419923, 9117.225035872025, 7801.726939557088, 7966.880496792669, 7988.121306656147, 7993.8401231976195, 7998.280154786097, 5852.239208902815, 5852.239208902985, 5931.822045338647, 6006.639601623917, 6034.758609655564, 5192.5586325162785, 5429.891402172014, 5464.754086066057, 5993.011153159854, 6131.509479241561], "value": 5090.552398726003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5676059010957, 372.5901508340825, 374.21415028440276, 385.8977370996686, 391.5907876269296, 4799.272261985682, 4980.576650984671, 5175.24958880962, 5252.872586602427, 5257.605679574033, 3970.0, 4532.592066713995, 5148.665336753118, 5199.298094757207, 5229.646659003454, 3364.360771453416, 3894.162755007673, 3921.2353591049755, 4001.659858911996, 4124.988758206511, 3861.420786881962, 4020.557738648746, 4321.438213032317, 4340.587644173798, 4418.624416924566, 4162.750234985895, 4325.572561054844, 4354.54277300882, 4358.4987726411555, 4393.924253022881, 3696.5933747287777, 3994.1013272013856, 4239.809208585591, 4275.978620106911, 4372.825086996516, 3938.074552480165, 3950.545687245975, 3951.9012024699323, 3966.7619942803526, 3978.468289708483, 5016.749162541858, 5072.873178170538, 5082.018012974942, 5088.582923111492, 5089.465606111379, 4704.623630109617, 4723.976380118077, 4800.495638184145, 4865.6594038417325, 5033.119204139261, 5520.447955204488, 5574.86062848428, 5580.86047848807, 5583.441655834384, 5599.860003499945, 3998.960270329706, 4042.0299128209313, 4055.4930633670792, 4415.359772832953, 4487.868262575284, 5165.9225111623355, 5425.701586412746, 5639.407862174413, 5644.915326270109, 5951.333626584563, 4016.2770701274053, 4160.396742472385, 4488.842890498817, 4501.032278060167, 4540.977295113504, 4325.8269669213505, 4611.2852507861335, 4640.628749700016, 4657.906841863144, 4660.551192117876, 4146.688998325138, 4834.138856540258, 4845.363869989462, 5017.397912250553, 5051.595872330205, 5032.798688052437, 5399.190121481731, 5483.75323110461, 5535.0, 5538.972305138448, 1385.2727318158047, 1504.9247537623075, 1559.235974372572, 1565.882558808094, 1569.2310767723961, 1078.412265315405, 1176.823476478535, 1181.5805389086922, 1183.6094088950626, 1205.75884823034, 4395.582419670126, 5032.572231360376, 5064.4935506449065, 5256.2115682647145, 5257.056048612789, 4942.0, 5557.693941923645, 5732.398098199712, 5773.913391299134, 5820.970895145497, 4654.0, 4973.726445045557, 5202.92195617066, 5283.4452382499285, 5306.469353064663, 2572.0354866924904, 2638.5514462541414, 2672.4788666210293, 2816.816906901045, 2936.474631816636, 5546.140348246028, 5577.832665020056, 5656.022700023953, 5889.646621202742, 5970.34326224115, 4586.678932474695, 5076.82231121909, 5628.324601047819, 5755.740991655385, 5812.854678632983, 5154.407243167084, 5751.23294242272, 5957.344692083867, 6013.639181649115, 6084.695765211722, 4679.9064018718755, 5456.454354564512, 5749.8275051748515, 5857.824265272048, 5865.178874957594, 5227.869303267449, 5309.14180036984, 5537.1140617501005, 5554.377573411542, 5739.655620662606, 5187.858671092354, 5384.273123128328, 5852.4147585241135, 6019.7125092464585, 6028.90956635642, 4036.7577945323374, 4132.772697501546, 4229.80965856531, 5063.911259079316, 5081.932794113278, 5557.749506361198, 5697.4872261495, 5746.0, 5795.246617939641, 5802.794937923562, 4423.734575925455, 4724.71651700899, 4885.511448855086, 5537.750801213874, 5539.750711217925, 4726.574608285271, 5247.370315562004, 5286.0, 5502.394736579053, 5521.309836270466, 4651.418572678415, 4830.0, 5221.425643179323, 5458.536024437808, 5498.862528436821, 5064.4935506449065, 5290.0, 5356.651817631841, 5432.7555260012605, 5566.606359265555, 4855.854324370274, 5112.191417394065, 5209.843704688866, 5429.67421954684, 5472.753726082256], "value": 4229.934719268642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2197283695689, 763.6369081190077, 771.8764997600382, 811.557701052926, 816.8733846253831, 14927.5521734348, 15708.60728481787, 15970.361185552592, 15982.440614578492, 16067.999999999985, 14240.0, 14923.477678281262, 15020.0, 15068.472603458853, 15078.47225347113, 930.7300882744013, 954.1365064616533, 956.4118067388575, 959.3092973059386, 959.8704174936399, 928.5264515097315, 937.746808361742, 943.099340130174, 958.5111593087506, 974.907383798538, 1017.0388982411624, 1020.8213562626548, 1021.9131373833233, 1022.5858527296419, 1023.2325755683238, 853.7268074216285, 955.5365647660878, 998.1366118307684, 998.2962011781676, 1017.1710056304089, 742.3244847189086, 751.0349201276333, 753.7098217186423, 754.4680999895115, 755.0486387152173, 15622.609434764108, 15965.201739912958, 16020.118893460854, 16352.509424717278, 16821.327146914107, 14494.0, 14857.108573485626, 14888.0, 14898.0, 14917.179555124463, 11768.411579421081, 11824.467898944567, 11981.9592350003, 12057.0957178212, 12384.009279257638, 3180.3321302526497, 3544.5392099027217, 3621.5473065866768, 3714.8142592870518, 3814.48504451901, 92062.0, 109662.45168774185, 111422.81785987088, 113255.43372283169, 114248.42875785651, 9389.765255868659, 11253.66239012831, 11345.546178152947, 11553.36456494884, 11720.003799676952, 24421.877890610434, 25262.74737252604, 25262.989480420943, 25277.494450111262, 25333.74666253314, 6712.697928593225, 7579.696812127563, 7656.234376562299, 7714.382849372037, 7779.144294127642, 3705.6664900159117, 4018.417329487208, 4123.113530590877, 4145.771982540929, 4156.9792151039655, 3455.87904423349, 3499.720022398202, 3511.719062474996, 3543.273628906068, 3545.4859045438784, 632.1623848400795, 640.4748106552676, 646.3762469217228, 647.1360733420936, 656.7832615236961, 569.5984331046602, 649.4901502320656, 680.6596701649175, 686.3411125319649, 709.6593635055202, 9670.951645241728, 10094.596216151418, 10205.897941020643, 10250.948745256375, 10354.1198998086, 611.6725858109846, 631.7441436218339, 660.798456470781, 663.7776344924505, 668.9698963546653, 4672.556107169813, 4880.343912199385, 4909.558139767367, 4933.753312334369, 4945.159322915113, 96321.0, 96595.0, 102524.48737756263, 103732.0, 105065.0, 90924.54537727269, 91380.08619913849, 91846.0, 92355.0, 92588.0, 64915.70168596696, 78459.0, 78875.2112478868, 79739.0, 81394.0, 7685.385169186564, 9448.244140468883, 9591.808163836544, 9622.0, 9634.421934683662, 35705.57177712862, 49836.0, 49968.750156248985, 51600.22599661083, 51859.740701297764, 60775.69612151911, 65650.34349656443, 65812.0, 66062.00906986302, 66750.0, 11563.768724625292, 11602.76794464123, 11713.765724685629, 11760.529578816751, 12254.754904901674, 12161.96623286995, 12221.083418743452, 12255.87744122583, 12513.812292815797, 12731.80902286448, 11862.525498980289, 11969.820452693042, 12009.0, 12051.75896482083, 12337.876621234032, 11775.116866235237, 11844.881551184379, 11867.76264474723, 11920.112753770913, 11945.402729863647, 11715.589954351557, 11762.470688818852, 11786.76426471483, 11873.0, 11882.643520694393, 9850.670159528372, 10005.799884002425, 10066.0, 10223.011448185363, 10844.45777711127, 6866.622335771581, 9106.726798196065, 9112.589933452879, 9139.543022848964, 9263.76840578964], "value": 7441.7951912436965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 179.0, 155.0, 119.0, 119.0, 119.0, 120.0, 118.0, 120.0, 134.0], "value": 129.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 116.0, 182.0, 145.0, 148.0, 115.0, 149.0, 163.0, 114.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 217.0, 213.0, 222.0, 204.0, 198.0, 201.0, 200.0, 200.0, 196.0], "value": 205.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 61.0, 63.0, 90.0, 67.0, 85.0, 63.0, 85.0, 85.0, 58.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 71.0, 86.0, 72.0, 71.0, 70.0, 83.0, 71.0, 72.0, 115.0], "value": 80.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 103.0, 111.0, 90.0, 90.0, 93.0, 91.0, 90.0, 93.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 109.0, 151.0, 120.0, 112.0, 156.0, 134.0, 140.0, 155.0], "value": 135.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 92.0, 91.0, 95.0, 89.0, 92.0, 89.0, 136.0, 123.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 69.0, 69.0, 68.0, 68.0, 69.0, 70.0, 71.0, 69.0], "value": 72.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 74.0, 87.0, 85.0, 85.0, 58.0, 59.0, 58.0, 62.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 88.0, 90.0, 90.0, 88.0, 90.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 150.0, 166.0, 149.0, 140.0, 143.0, 154.0, 147.0, 197.0, 159.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 174.0, 177.0, 174.0, 176.0, 171.0, 173.0, 180.0, 175.0, 174.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 71.0, 96.0, 96.0, 71.0, 68.0, 69.0, 69.0], "value": 74.6, "unit": "score"}]}]} 10:36:19 INFO - Return code: 0 10:36:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:19 ERROR - # TBPL SUCCESS # 10:36:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:19 INFO - 2017-03-10 10:36:19.460 screenresolution[2282:26068] starting screenresolution argv=screenresolution get 10:36:19 INFO - 2017-03-10 10:36:19.463 screenresolution[2282:26068] Display 0: 1600x1200x32@60 10:36:19 INFO - 2017-03-10 10:36:19.469 screenresolution[2283:26071] starting screenresolution argv=screenresolution list 10:36:19 INFO - Available Modes on Display 0 10:36:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:19 INFO - Intel Iris: 10:36:19 INFO - Chipset Model: Intel Iris 10:36:19 INFO - Type: GPU 10:36:19 INFO - Bus: Built-In 10:36:19 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:19 INFO - Vendor: Intel (0x8086) 10:36:19 INFO - Device ID: 0x0a2e 10:36:19 INFO - Revision ID: 0x0009 10:36:19 INFO - Displays: 10:36:19 INFO - Display: 10:36:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:19 INFO - Display Serial Number: 1600x1200 60 10:36:19 INFO - Main Display: Yes 10:36:19 INFO - Mirror: Off 10:36:19 INFO - Online: Yes 10:36:19 INFO - Rotation: Supported 10:36:19 INFO - Return code: 0 10:36:19 INFO - Running post-action listener: _resource_record_post_action 10:36:19 INFO - [mozharness: 2017-03-10 18:36:19.711489Z] Finished run-tests step (success) 10:36:19 INFO - Running post-run listener: _resource_record_post_run 10:36:19 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 634880; Write bytes: 513596928; Read time: 6; Write time: 1872 10:36:19 INFO - TinderboxPrint: CPU usage
54.8% 10:36:19 INFO - TinderboxPrint: I/O read bytes / time
634,880 / 6 10:36:19 INFO - TinderboxPrint: I/O write bytes / time
513,596,928 / 1,872 10:36:19 INFO - TinderboxPrint: CPU idle
2,173.9 (45.2%) 10:36:19 INFO - TinderboxPrint: CPU system
969.4 (20.2%) 10:36:19 INFO - TinderboxPrint: CPU user
1,662.4 (34.6%) 10:36:19 INFO - TinderboxPrint: Swap in / out
209,756,160 / 0 10:36:19 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203078144; Write bytes: 200843264; Read time: 15793; Write time: 373 10:36:19 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 634880; Write bytes: 302845440; Read time: 6; Write time: 1468 10:36:20 INFO - Running post-run listener: _upload_blobber_files 10:36:20 INFO - Blob upload gear active. 10:36:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:20 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 10:36:20 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'] 10:36:20 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 10:36:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:21 INFO - (blobuploader) - INFO - Done attempting. 10:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:22 INFO - (blobuploader) - INFO - Done attempting. 10:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:23 INFO - (blobuploader) - INFO - Done attempting. 10:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:25 INFO - (blobuploader) - INFO - Done attempting. 10:36:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:25 INFO - Return code: 0 10:36:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23f7fd65de9ccbdddc3001783372eca187ba24dbc59e9d093088dcffe38c0ba8209a78b5a7c4a59de382b6e8420727e84a61c21cfeb7e3b2526c81344fcb77ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/687413c9c506c7d2fd2f4df3f1fdd7eb5990582ca465e7a8598f839018dae16c008a4c9218cdd6784555839620801d8e4d4452defff40976e852038aef8ef3c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d547f77d99d835c40957957e362f09ccd12351989acde124d4a28cc70535332242b78ee34d8743bf3f680a85c1eaef06b43358f97fe6147bb5f3b45c9ada88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/073dd8ade764c79ba984f92dc1b5b618ca867548e1d486994a0a95c88a6384d5bcc984ea14cfc23328b5573f0f9b1647b7b1b5a760ec77ade955edfe7186e129"} 10:36:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:25 INFO - Contents: 10:36:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23f7fd65de9ccbdddc3001783372eca187ba24dbc59e9d093088dcffe38c0ba8209a78b5a7c4a59de382b6e8420727e84a61c21cfeb7e3b2526c81344fcb77ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/687413c9c506c7d2fd2f4df3f1fdd7eb5990582ca465e7a8598f839018dae16c008a4c9218cdd6784555839620801d8e4d4452defff40976e852038aef8ef3c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d547f77d99d835c40957957e362f09ccd12351989acde124d4a28cc70535332242b78ee34d8743bf3f680a85c1eaef06b43358f97fe6147bb5f3b45c9ada88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/073dd8ade764c79ba984f92dc1b5b618ca867548e1d486994a0a95c88a6384d5bcc984ea14cfc23328b5573f0f9b1647b7b1b5a760ec77ade955edfe7186e129"} 10:36:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:25 INFO - Copying logs to upload dir... 10:36:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.051288 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-10 10:36:25.292505) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:25.296424) ========= 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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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/23f7fd65de9ccbdddc3001783372eca187ba24dbc59e9d093088dcffe38c0ba8209a78b5a7c4a59de382b6e8420727e84a61c21cfeb7e3b2526c81344fcb77ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/687413c9c506c7d2fd2f4df3f1fdd7eb5990582ca465e7a8598f839018dae16c008a4c9218cdd6784555839620801d8e4d4452defff40976e852038aef8ef3c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d547f77d99d835c40957957e362f09ccd12351989acde124d4a28cc70535332242b78ee34d8743bf3f680a85c1eaef06b43358f97fe6147bb5f3b45c9ada88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/073dd8ade764c79ba984f92dc1b5b618ca867548e1d486994a0a95c88a6384d5bcc984ea14cfc23328b5573f0f9b1647b7b1b5a760ec77ade955edfe7186e129"} build_url:https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011631 build_url: 'https://queue.taskcluster.net/v1/task/LSTw15ovTbK2o1AaTQQUdQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23f7fd65de9ccbdddc3001783372eca187ba24dbc59e9d093088dcffe38c0ba8209a78b5a7c4a59de382b6e8420727e84a61c21cfeb7e3b2526c81344fcb77ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/687413c9c506c7d2fd2f4df3f1fdd7eb5990582ca465e7a8598f839018dae16c008a4c9218cdd6784555839620801d8e4d4452defff40976e852038aef8ef3c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d547f77d99d835c40957957e362f09ccd12351989acde124d4a28cc70535332242b78ee34d8743bf3f680a85c1eaef06b43358f97fe6147bb5f3b45c9ada88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/073dd8ade764c79ba984f92dc1b5b618ca867548e1d486994a0a95c88a6384d5bcc984ea14cfc23328b5573f0f9b1647b7b1b5a760ec77ade955edfe7186e129"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:25.333096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:25.333612) ========= 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.nzFzOGbxCm/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.e2HxQ7WQCR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005272 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:36:25.382683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:36:25.383007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:36:25.383339) ========= ========= Total master_lag: 0.34 =========