builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0336 starttime: 1488329626.97 results: success (0) buildid: 20170228153103 builduid: ff9560d6583c404ca8018a9694f0f1db revision: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:46.973366) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:46.973862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:46.974171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.002620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.002994) ========= 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.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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-02-28 16:53:47-- 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% 49.8M=0s 2017-02-28 16:53:47 (49.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.572097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.597002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.597390) ========= 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.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.026431 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.649700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.650532) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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-02-28 16:53:47,760 truncating revision to first 12 chars 2017-02-28 16:53:47,760 Setting DEBUG logging. 2017-02-28 16:53:47,760 attempt 1/10 2017-02-28 16:53:47,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/397bf222b4d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-28 16:53:48,420 unpacking tar archive at: mozilla-aurora-397bf222b4d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934087 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:48.610203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:48.610584) ========= script_repo_revision: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:48.611081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:48.611403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:48.632100) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-28 16:53:48.632545) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:53:48 INFO - MultiFileLogger online at 20170228 16:53:48 in /builds/slave/test 16:53:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:53:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:48 INFO - {'append_to_log': False, 16:53:48 INFO - 'base_work_dir': '/builds/slave/test', 16:53:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:53:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:48 INFO - 'branch': 'Mozilla-Aurora', 16:53:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:48 INFO - 'config_files': ('talos/mac_config.py',), 16:53:48 INFO - 'default_actions': ('clobber', 16:53:48 INFO - 'read-buildbot-config', 16:53:48 INFO - 'download-and-extract', 16:53:48 INFO - 'populate-webroot', 16:53:48 INFO - 'create-virtualenv', 16:53:48 INFO - 'install', 16:53:48 INFO - 'run-tests'), 16:53:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:48 INFO - 'download_minidump_stackwalk': True, 16:53:48 INFO - 'download_symbols': 'ondemand', 16:53:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:48 INFO - 'installer_path': 'installer.exe', 16:53:48 INFO - 'log_level': 'info', 16:53:48 INFO - 'log_name': 'talos', 16:53:48 INFO - 'log_to_console': True, 16:53:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:48 INFO - 'opt_config_files': (), 16:53:48 INFO - 'pip_index': False, 16:53:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:48 INFO - 'cmd': ('bash', 16:53:48 INFO - '-c', 16:53:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:48 INFO - 'enabled': True, 16:53:48 INFO - 'halt_on_failure': False, 16:53:48 INFO - 'name': 'check_screen_resolution'},), 16:53:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:48 INFO - 'cmd': ('bash', 16:53:48 INFO - '-c', 16:53:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:48 INFO - 'enabled': True, 16:53:48 INFO - 'halt_on_failure': False, 16:53:48 INFO - 'name': 'check_screen_resolution'},), 16:53:48 INFO - 'run_cmd_checks_enabled': True, 16:53:48 INFO - 'sps_profile': False, 16:53:48 INFO - 'sps_profile_interval': 0, 16:53:48 INFO - 'suite': 'dromaeojs-e10s', 16:53:48 INFO - 'system_bits': '32', 16:53:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:48 INFO - 'title': 't-yosemite-r7-0336', 16:53:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:48 INFO - 'use_talos_json': True, 16:53:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:48 INFO - 'work_dir': 'build'} 16:53:48 INFO - [mozharness: 2017-03-01 00:53:48.852477Z] Running clobber step. 16:53:48 INFO - Running pre-action listener: _resource_record_pre_action 16:53:48 INFO - Running main action method: clobber 16:53:48 INFO - rmtree: /builds/slave/test/build 16:53:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:51 INFO - Running post-action listener: _resource_record_post_action 16:53:51 INFO - [mozharness: 2017-03-01 00:53:51.181483Z] Finished clobber step (success) 16:53:51 INFO - [mozharness: 2017-03-01 00:53:51.181643Z] Running read-buildbot-config step. 16:53:51 INFO - Running pre-action listener: _resource_record_pre_action 16:53:51 INFO - Running main action method: read_buildbot_config 16:53:51 INFO - Using buildbot properties: 16:53:51 INFO - { 16:53:51 INFO - "project": "", 16:53:51 INFO - "product": "firefox", 16:53:51 INFO - "script_repo_revision": "production", 16:53:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:53:51 INFO - "repository": "", 16:53:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:53:51 INFO - "buildid": "20170228153103", 16:53:51 INFO - "pgo_build": "False", 16:53:51 INFO - "basedir": "/builds/slave/test", 16:53:51 INFO - "buildnumber": 10, 16:53:51 INFO - "slavename": "t-yosemite-r7-0336", 16:53:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:53:51 INFO - "platform": "yosemite_r7", 16:53:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:53:51 INFO - "branch": "mozilla-aurora", 16:53:51 INFO - "repo_path": "releases/mozilla-aurora", 16:53:51 INFO - "revision": "397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4", 16:53:51 INFO - "stage_platform": "macosx64", 16:53:51 INFO - "builduid": "ff9560d6583c404ca8018a9694f0f1db", 16:53:51 INFO - "slavebuilddir": "test" 16:53:51 INFO - } 16:53:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 16:53:51 INFO - Running post-action listener: _resource_record_post_action 16:53:51 INFO - [mozharness: 2017-03-01 00:53:51.185119Z] Finished read-buildbot-config step (success) 16:53:51 INFO - [mozharness: 2017-03-01 00:53:51.185252Z] Running download-and-extract step. 16:53:51 INFO - Running pre-action listener: _resource_record_pre_action 16:53:51 INFO - Running main action method: download_and_extract 16:53:51 INFO - mkdir: /builds/slave/test/build/tests 16:53:51 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')]} 16:53:51 INFO - trying https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 16:53:51 INFO - Downloading https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 16:53:52 INFO - Downloaded 1199 bytes. 16:53:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:53:52 INFO - Using the following test package requirements: 16:53:52 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:53:52 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 16:53:52 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 16:53:52 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'jsshell-mac.zip'], 16:53:52 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 16:53:52 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:53:52 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 16:53:52 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 16:53:52 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 16:53:52 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:52 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 16:53:52 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:53:53 INFO - Expected file size: 16357774 16:53:53 INFO - Obtained file size: 16357774 16:54:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:54:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:54:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:54:00 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:54:01 INFO - Expected file size: 16357774 16:54:01 INFO - Obtained file size: 16357774 16:54:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 16:54:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:54:07 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 16:54:08 INFO - Expected file size: 14403472 16:54:08 INFO - Obtained file size: 14403472 16:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:08 INFO - trying https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:08 INFO - Downloading https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 16:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 16:54:10 INFO - Downloaded 73908741 bytes. 16:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:10 INFO - mkdir: /builds/slave/test/properties 16:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:10 INFO - Contents: 16:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:11 INFO - Running post-action listener: _resource_record_post_action 16:54:11 INFO - Running post-action listener: set_extra_try_arguments 16:54:11 INFO - [mozharness: 2017-03-01 00:54:11.425798Z] Finished download-and-extract step (success) 16:54:11 INFO - [mozharness: 2017-03-01 00:54:11.425941Z] Running populate-webroot step. 16:54:11 INFO - Running pre-action listener: _resource_record_pre_action 16:54:11 INFO - Running main action method: populate_webroot 16:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:11 INFO - '--tppagecycles', 16:54:11 INFO - '7'], 16:54:11 INFO - 'tests': ['tsvgm']}}, 16:54:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['damp', 'tps']}, 16:54:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'tests': ['damp', 'tps']}, 16:54:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['dromaeo_dom']}, 16:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['basic_compositor_video']}, 16:54:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['a11yr', 16:54:11 INFO - 'ts_paint', 16:54:11 INFO - 'tpaint', 16:54:11 INFO - 'sessionrestore', 16:54:11 INFO - 'sessionrestore_no_auto_restore', 16:54:11 INFO - 'tabpaint']}, 16:54:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['tsvgx', 16:54:11 INFO - 'tsvgr_opacity', 16:54:11 INFO - 'tart', 16:54:11 INFO - 'tscrollx', 16:54:11 INFO - 'cart', 16:54:11 INFO - 'tsvg_static']}, 16:54:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:11 INFO - 'tsvgr_opacity', 16:54:11 INFO - 'tart', 16:54:11 INFO - 'tscrollx', 16:54:11 INFO - 'cart', 16:54:11 INFO - 'tsvg_static']}, 16:54:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'talos_options': ['--disable-e10s'], 16:54:11 INFO - 'tests': ['tp5o']}, 16:54:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:54:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'talos_options': ['--disable-e10s', 16:54:11 INFO - '--xperf_path', 16:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:11 INFO - 'tests': ['tp5n']}, 16:54:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:54:11 INFO - 'talos_options': ['--xperf_path', 16:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:11 INFO - 'tests': ['tp5n']}}, 16:54:11 INFO - 'talos.zip': {'path': '', 16:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:11 INFO - Running post-action listener: _resource_record_post_action 16:54:11 INFO - [mozharness: 2017-03-01 00:54:11.444422Z] Finished populate-webroot step (success) 16:54:11 INFO - [mozharness: 2017-03-01 00:54:11.444553Z] Running create-virtualenv step. 16:54:11 INFO - Running pre-action listener: _resource_record_pre_action 16:54:11 INFO - Running main action method: create_virtualenv 16:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:11 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 16:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:11 INFO - Using real prefix '/tools/python27' 16:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:15 INFO - Installing pip.................done. 16:54:15 INFO - Return code: 0 16:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:54:15 INFO - Reading from file tmpfile_stdout 16:54:15 INFO - Output received: 16:54:15 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) 16:54:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:15 INFO - 'HOME': '/Users/cltbld', 16:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:15 INFO - 'LOGNAME': 'cltbld', 16:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:15 INFO - 'MOZ_NO_REMOTE': '1', 16:54:15 INFO - 'NO_EM_RESTART': '1', 16:54:15 INFO - 'PAGER': '/bin/cat', 16:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:15 INFO - 'PWD': '/builds/slave/test', 16:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:15 INFO - 'SHELL': '/bin/bash', 16:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:15 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:15 INFO - 'USER': 'cltbld', 16:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:15 INFO - 'XPC_FLAGS': '0x0', 16:54:15 INFO - 'XPC_SERVICE_NAME': '0', 16:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:15 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 16:54:15 INFO - Cleaning up... 16:54:15 INFO - Return code: 0 16:54:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:15 INFO - 'HOME': '/Users/cltbld', 16:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:15 INFO - 'LOGNAME': 'cltbld', 16:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:15 INFO - 'MOZ_NO_REMOTE': '1', 16:54:15 INFO - 'NO_EM_RESTART': '1', 16:54:15 INFO - 'PAGER': '/bin/cat', 16:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:15 INFO - 'PWD': '/builds/slave/test', 16:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:15 INFO - 'SHELL': '/bin/bash', 16:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:15 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:15 INFO - 'USER': 'cltbld', 16:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:15 INFO - 'XPC_FLAGS': '0x0', 16:54:15 INFO - 'XPC_SERVICE_NAME': '0', 16:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:15 INFO - Downloading/unpacking psutil>=3.1.1 16:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:19 INFO - Installing collected packages: psutil 16:54:19 INFO - Running setup.py install for psutil 16:54:20 INFO - building 'psutil._psutil_osx' extension 16:54:20 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 16:54:20 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 16:54:20 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 16:54:20 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 16:54:20 INFO - building 'psutil._psutil_posix' extension 16:54:20 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 16:54:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:54:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:54:20 INFO - ^ 16:54:20 INFO - 1 warning generated. 16:54:20 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 16:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:21 INFO - Successfully installed psutil 16:54:21 INFO - Cleaning up... 16:54:21 INFO - Return code: 0 16:54:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:21 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:21 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 16:54:21 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 16:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:21 INFO - 'HOME': '/Users/cltbld', 16:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:21 INFO - 'LOGNAME': 'cltbld', 16:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:21 INFO - 'MOZ_NO_REMOTE': '1', 16:54:21 INFO - 'NO_EM_RESTART': '1', 16:54:21 INFO - 'PAGER': '/bin/cat', 16:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:21 INFO - 'PWD': '/builds/slave/test', 16:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:21 INFO - 'SHELL': '/bin/bash', 16:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:21 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:21 INFO - 'USER': 'cltbld', 16:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:21 INFO - 'XPC_FLAGS': '0x0', 16:54:21 INFO - 'XPC_SERVICE_NAME': '0', 16:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:21 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 16:54:21 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 16:54:21 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 16:54:21 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 16:54:21 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 16:54:21 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 16:54:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:23 INFO - Installing collected packages: mozsystemmonitor 16:54:23 INFO - Running setup.py install for mozsystemmonitor 16:54:24 INFO - Successfully installed mozsystemmonitor 16:54:24 INFO - Cleaning up... 16:54:24 INFO - Return code: 0 16:54:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:24 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:24 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 16:54:24 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 16:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:24 INFO - 'HOME': '/Users/cltbld', 16:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:24 INFO - 'LOGNAME': 'cltbld', 16:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:24 INFO - 'MOZ_NO_REMOTE': '1', 16:54:24 INFO - 'NO_EM_RESTART': '1', 16:54:24 INFO - 'PAGER': '/bin/cat', 16:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:24 INFO - 'PWD': '/builds/slave/test', 16:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:24 INFO - 'SHELL': '/bin/bash', 16:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:24 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:24 INFO - 'USER': 'cltbld', 16:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:24 INFO - 'XPC_FLAGS': '0x0', 16:54:24 INFO - 'XPC_SERVICE_NAME': '0', 16:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:24 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:24 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 16:54:24 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 16:54:24 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 16:54:24 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 16:54:24 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 16:54:24 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 16:54:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:27 INFO - warning: no files found matching '*.txt' 16:54:27 INFO - no previously-included directories found matching 'build' 16:54:27 INFO - no previously-included directories found matching 'dist' 16:54:27 INFO - no previously-included directories found matching '.git*' 16:54:27 INFO - Installing collected packages: jsonschema, functools32 16:54:27 INFO - Running setup.py install for functools32 16:54:27 INFO - warning: no files found matching '*.txt' 16:54:27 INFO - no previously-included directories found matching 'build' 16:54:27 INFO - no previously-included directories found matching 'dist' 16:54:27 INFO - no previously-included directories found matching '.git*' 16:54:27 INFO - Successfully installed jsonschema functools32 16:54:27 INFO - Cleaning up... 16:54:27 INFO - Return code: 0 16:54:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:27 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 16:54:27 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 16:54:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:27 INFO - 'HOME': '/Users/cltbld', 16:54:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:27 INFO - 'LOGNAME': 'cltbld', 16:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:27 INFO - 'MOZ_NO_REMOTE': '1', 16:54:27 INFO - 'NO_EM_RESTART': '1', 16:54:27 INFO - 'PAGER': '/bin/cat', 16:54:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:27 INFO - 'PWD': '/builds/slave/test', 16:54:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:27 INFO - 'SHELL': '/bin/bash', 16:54:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:27 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:27 INFO - 'USER': 'cltbld', 16:54:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:27 INFO - 'XPC_FLAGS': '0x0', 16:54:27 INFO - 'XPC_SERVICE_NAME': '0', 16:54:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:28 INFO - Cleaning up... 16:54:28 INFO - Return code: 0 16:54:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:28 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')]} 16:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:28 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')]} 16:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:28 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:28 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 16:54:28 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 16:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:28 INFO - 'HOME': '/Users/cltbld', 16:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:28 INFO - 'LOGNAME': 'cltbld', 16:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:28 INFO - 'MOZ_NO_REMOTE': '1', 16:54:28 INFO - 'NO_EM_RESTART': '1', 16:54:28 INFO - 'PAGER': '/bin/cat', 16:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:28 INFO - 'PWD': '/builds/slave/test', 16:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:28 INFO - 'SHELL': '/bin/bash', 16:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:28 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:28 INFO - 'USER': 'cltbld', 16:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:28 INFO - 'XPC_FLAGS': '0x0', 16:54:28 INFO - 'XPC_SERVICE_NAME': '0', 16:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:32 INFO - Downloading docopt-0.6.1.tar.gz 16:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:32 INFO - Running setup.py install for blobuploader 16:54:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:32 INFO - Running setup.py install for requests 16:54:33 INFO - Running setup.py install for docopt 16:54:33 INFO - Successfully installed blobuploader requests docopt 16:54:33 INFO - Cleaning up... 16:54:33 INFO - Return code: 0 16:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:33 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')]} 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 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')]} 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:33 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 16:54:33 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 16:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:33 INFO - 'HOME': '/Users/cltbld', 16:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:33 INFO - 'LOGNAME': 'cltbld', 16:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:33 INFO - 'MOZ_NO_REMOTE': '1', 16:54:33 INFO - 'NO_EM_RESTART': '1', 16:54:33 INFO - 'PAGER': '/bin/cat', 16:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:33 INFO - 'PWD': '/builds/slave/test', 16:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:33 INFO - 'SHELL': '/bin/bash', 16:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:33 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:33 INFO - 'USER': 'cltbld', 16:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:33 INFO - 'XPC_FLAGS': '0x0', 16:54:33 INFO - 'XPC_SERVICE_NAME': '0', 16:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:33 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-ofi7kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:33 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-7T8U9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:33 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-lOvZQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:33 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-sMDXUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:33 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-BR_nli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-P4_tf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-dTldJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-VxNt20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-00ONY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-olYArF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-NJWFer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Cqad_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-gAbj2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-qNy2MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-odkJFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Mz1oRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-tLnPYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:35 INFO - Running setup.py install for manifestparser 16:54:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozcrash 16:54:35 INFO - Running setup.py install for mozdebug 16:54:35 INFO - Running setup.py install for mozdevice 16:54:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozfile 16:54:36 INFO - Running setup.py install for mozhttpd 16:54:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozinfo 16:54:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozInstall 16:54:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozleak 16:54:36 INFO - Running setup.py install for mozlog 16:54:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for moznetwork 16:54:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozprocess 16:54:37 INFO - Running setup.py install for mozprofile 16:54:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozrunner 16:54:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Running setup.py install for mozscreenshot 16:54:37 INFO - Running setup.py install for moztest 16:54:37 INFO - Running setup.py install for mozversion 16:54:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:37 INFO - Cleaning up... 16:54:37 INFO - Return code: 0 16:54:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:37 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')]} 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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')]} 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:37 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 16:54:37 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 16:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:37 INFO - 'HOME': '/Users/cltbld', 16:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:37 INFO - 'LOGNAME': 'cltbld', 16:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:37 INFO - 'MOZ_NO_REMOTE': '1', 16:54:37 INFO - 'NO_EM_RESTART': '1', 16:54:37 INFO - 'PAGER': '/bin/cat', 16:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:37 INFO - 'PWD': '/builds/slave/test', 16:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:37 INFO - 'SHELL': '/bin/bash', 16:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:37 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:37 INFO - 'USER': 'cltbld', 16:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:37 INFO - 'XPC_FLAGS': '0x0', 16:54:37 INFO - 'XPC_SERVICE_NAME': '0', 16:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Hxtwe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-q6r_sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-o1FII7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-XsJmKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-vplYpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-whh5Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-h_RpHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:38 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-vQyj4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-_VKoil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-pQgRhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Gzhmio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-luzc3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-UuY6Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-aozBx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-ieOOpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-aPEJxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:39 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Orj2Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:40 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 16:54:42 INFO - Downloading blessings-1.6.tar.gz 16:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:42 INFO - Installing collected packages: blessings 16:54:42 INFO - Running setup.py install for blessings 16:54:42 INFO - Successfully installed blessings 16:54:42 INFO - Cleaning up... 16:54:42 INFO - Return code: 0 16:54:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Current package versions: 16:54:43 INFO - blessings == 1.6 16:54:43 INFO - blobuploader == 1.2.4 16:54:43 INFO - docopt == 0.6.1 16:54:43 INFO - functools32 == 3.2.3-2 16:54:43 INFO - jsonschema == 2.5.1 16:54:43 INFO - manifestparser == 1.1 16:54:43 INFO - mozInstall == 1.12 16:54:43 INFO - mozcrash == 1.0 16:54:43 INFO - mozdebug == 0.1 16:54:43 INFO - mozdevice == 0.49 16:54:43 INFO - mozfile == 1.2 16:54:43 INFO - mozhttpd == 0.7 16:54:43 INFO - mozinfo == 0.9 16:54:43 INFO - mozleak == 0.1 16:54:43 INFO - mozlog == 3.4 16:54:43 INFO - moznetwork == 0.27 16:54:43 INFO - mozprocess == 0.24 16:54:43 INFO - mozprofile == 0.28 16:54:43 INFO - mozrunner == 6.13 16:54:43 INFO - mozscreenshot == 0.1 16:54:43 INFO - mozsystemmonitor == 0.3 16:54:43 INFO - moztest == 0.8 16:54:43 INFO - mozversion == 1.4 16:54:43 INFO - psutil == 3.1.1 16:54:43 INFO - requests == 1.2.3 16:54:43 INFO - wsgiref == 0.1.2 16:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:43 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')]} 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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')]} 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:43 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 16:54:43 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 16:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:43 INFO - 'HOME': '/Users/cltbld', 16:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:43 INFO - 'LOGNAME': 'cltbld', 16:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:43 INFO - 'MOZ_NO_REMOTE': '1', 16:54:43 INFO - 'NO_EM_RESTART': '1', 16:54:43 INFO - 'PAGER': '/bin/cat', 16:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:43 INFO - 'PWD': '/builds/slave/test', 16:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:43 INFO - 'SHELL': '/bin/bash', 16:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:43 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:43 INFO - 'USER': 'cltbld', 16:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:43 INFO - 'XPC_FLAGS': '0x0', 16:54:43 INFO - 'XPC_SERVICE_NAME': '0', 16:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 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)) 16:54:43 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:43 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')]} 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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')]} 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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 0x109070b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109073768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff299461ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, '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.34EkB3LTcO/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.UyAL4JgR8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 16:54:43 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 16:54:43 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 16:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:43 INFO - 'HOME': '/Users/cltbld', 16:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:43 INFO - 'LOGNAME': 'cltbld', 16:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:43 INFO - 'MOZ_NO_REMOTE': '1', 16:54:43 INFO - 'NO_EM_RESTART': '1', 16:54:43 INFO - 'PAGER': '/bin/cat', 16:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:43 INFO - 'PWD': '/builds/slave/test', 16:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:43 INFO - 'SHELL': '/bin/bash', 16:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:54:43 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:43 INFO - 'USER': 'cltbld', 16:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:43 INFO - 'XPC_FLAGS': '0x0', 16:54:43 INFO - 'XPC_SERVICE_NAME': '0', 16:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:43 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Running post-action listener: _resource_record_post_action 16:54:43 INFO - Running post-action listener: _start_resource_monitoring 16:54:43 INFO - Starting resource monitoring. 16:54:43 INFO - [mozharness: 2017-03-01 00:54:43.854938Z] Finished create-virtualenv step (success) 16:54:43 INFO - [mozharness: 2017-03-01 00:54:43.855944Z] Running install step. 16:54:43 INFO - Running pre-action listener: _resource_record_pre_action 16:54:43 INFO - Running main action method: install 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:44 INFO - Reading from file tmpfile_stdout 16:54:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:44 INFO - Reading from file tmpfile_stdout 16:54:44 INFO - Output received: 16:54:44 INFO - Usage: mozinstall [options] installer 16:54:44 INFO - Options: 16:54:44 INFO - -h, --help show this help message and exit 16:54:44 INFO - -d DEST, --destination=DEST 16:54:44 INFO - Directory to install application into. [default: 16:54:44 INFO - "/builds/slave/test"] 16:54:44 INFO - --app=APP Application being installed. [default: firefox] 16:54:44 INFO - mkdir: /builds/slave/test/build/application 16:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:55:04 INFO - Reading from file tmpfile_stdout 16:55:04 INFO - Output received: 16:55:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:55:04 INFO - Running post-action listener: _resource_record_post_action 16:55:04 INFO - [mozharness: 2017-03-01 00:55:04.329226Z] Finished install step (success) 16:55:04 INFO - [mozharness: 2017-03-01 00:55:04.329398Z] Running run-tests step. 16:55:04 INFO - Running pre-action listener: _resource_record_pre_action 16:55:04 INFO - Running main action method: run_tests 16:55:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:04 INFO - 2017-02-28 16:55:04.343 screenresolution[1650:14184] starting screenresolution argv=screenresolution get 16:55:04 INFO - 2017-02-28 16:55:04.346 screenresolution[1650:14184] Display 0: 1600x1200x32@60 16:55:04 INFO - 2017-02-28 16:55:04.352 screenresolution[1651:14187] starting screenresolution argv=screenresolution list 16:55:04 INFO - Available Modes on Display 0 16:55:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:04 INFO - Intel Iris: 16:55:04 INFO - Chipset Model: Intel Iris 16:55:04 INFO - Type: GPU 16:55:04 INFO - Bus: Built-In 16:55:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:04 INFO - Vendor: Intel (0x8086) 16:55:04 INFO - Device ID: 0x0a2e 16:55:04 INFO - Revision ID: 0x0009 16:55:04 INFO - Displays: 16:55:04 INFO - Display: 16:55:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:04 INFO - Display Serial Number: 1600x1200 60 16:55:04 INFO - Main Display: Yes 16:55:04 INFO - Mirror: Off 16:55:04 INFO - Online: Yes 16:55:04 INFO - Rotation: Supported 16:55:04 INFO - Return code: 0 16:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:04 INFO - Python 2.7.3 16:55:04 INFO - Return code: 0 16:55:04 INFO - grabbing minidump binary from tooltool 16:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:04 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 0x108e4ed30>, '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 0x108d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e43be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:04 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 16:55:04 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 16:55:04 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 16:55:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:04 INFO - Return code: 0 16:55:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 16:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0336 --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 16:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34EkB3LTcO/Render', 16:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:04 INFO - 'HOME': '/Users/cltbld', 16:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:04 INFO - 'LOGNAME': 'cltbld', 16:55:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:04 INFO - 'MOZ_NO_REMOTE': '1', 16:55:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:04 INFO - 'NO_EM_RESTART': '1', 16:55:04 INFO - 'PAGER': '/bin/cat', 16:55:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:04 INFO - 'PWD': '/builds/slave/test', 16:55:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:04 INFO - 'SHELL': '/bin/bash', 16:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyAL4JgR8K/Listeners', 16:55:04 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 16:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:04 INFO - 'USER': 'cltbld', 16:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:04 INFO - 'XPC_FLAGS': '0x0', 16:55:04 INFO - 'XPC_SERVICE_NAME': '0', 16:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 16:55:04 INFO - mozversion application_buildid: 20170228153103 16:55:04 INFO - mozversion application_changeset: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 16:55:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:55:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:04 INFO - mozversion application_name: Firefox 16:55:04 INFO - mozversion application_remotingname: firefox-dev 16:55:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:04 INFO - mozversion application_vendor: Mozilla 16:55:04 INFO - mozversion application_version: 53.0a2 16:55:04 INFO - mozversion platform_buildid: 20170228153103 16:55:04 INFO - mozversion platform_changeset: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 16:55:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:04 INFO - mozversion platform_version: 53.0a2 16:55:04 INFO - using testdate: 1488329704 16:55:04 INFO - actual date: 1488329704 16:55:04 INFO - starting webserver on 'localhost:49271' 16:55:04 INFO - SUITE-START | Running 2 tests 16:55:04 INFO - TEST-START | dromaeo_css 16:55:04 INFO - operating with platform_type : mac_ 16:55:04 INFO - Initialising browser for dromaeo_css test... 16:55:04 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpWoqeZa/profile http://localhost:49271/getInfo.html) 16:55:07 INFO - PROCESS | 1661 | 2017-02-28 16:55:07.904 plugin-container[1663:14363] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a37, name = 'com.apple.tsm.portname' 16:55:07 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:07 INFO - PROCESS | 1661 | 2017-02-28 16:55:07.907 plugin-container[1663:14363] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 16:55:07 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:07 INFO - PROCESS | 1661 | 2017-02-28 16:55:07.907 plugin-container[1663:14363] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:55:07 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:55:07 INFO - PROCESS | 1661 | colorDepth:24 16:55:07 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:55:07 INFO - PROCESS | 1661 | __metrics 16:55:08 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 16:55:08 INFO - TEST-INFO | 1661: exit 0 16:55:08 INFO - Browser initialized. 16:55:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:08 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpWoqeZa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:11 INFO - PROCESS | 1665 | 2017-02-28 16:55:11.293 plugin-container[1666:14500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 16:55:11 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:11 INFO - PROCESS | 1665 | 2017-02-28 16:55:11.293 plugin-container[1666:14500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 16:55:11 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:11 INFO - PROCESS | 1665 | 2017-02-28 16:55:11.293 plugin-container[1666:14500] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:55:20 INFO - PROCESS | 1665 | RSS: Main: 218505216 16:55:20 INFO - PROCESS | 1665 | 16:58:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:58:24 INFO - PROCESS | 1665 | RSS: Main: 237330432 16:58:24 INFO - PROCESS | 1665 | 17:00:09 INFO - PROCESS | 1665 | ************************* 17:00:09 INFO - PROCESS | 1665 | A coding exception was thrown and uncaught in a Task. 17:00:09 INFO - PROCESS | 1665 | 17:00:09 ERROR - PROCESS | 1665 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:00:09 INFO - PROCESS | 1665 | Full stack: 17:00:09 INFO - PROCESS | 1665 | ************************* 17:01:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 17:01:27 INFO - PROCESS | 1665 | RSS: Main: 246996992 17:01:27 INFO - PROCESS | 1665 | 17:04:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 17:04:30 INFO - PROCESS | 1665 | RSS: Main: 253198336 17:04:30 INFO - PROCESS | 1665 | 17:07:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 17:07:32 INFO - PROCESS | 1665 | RSS: Main: 249745408 17:07:32 INFO - PROCESS | 1665 | 17:10:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 17:10:36 INFO - PROCESS | 1665 | RSS: Main: 256831488 17:10:36 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 17:13:39 INFO - PROCESS | 1665 | RSS: Main: 258166784 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | __start_tp_report 17:13:39 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 17:13:39 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 17:13:39 INFO - PROCESS | 1665 | |i|pagename|runs| 17:13:39 INFO - PROCESS | 1665 | |0;dojo.html;3335.866565337385;3373.0555444475544;3387.5426817379653;3388.932486266824;3402.3365443738467;5601.3558440779325;5618.101103823389;5638.887222255553;5700.116481945295;5714.371419143901;4658.231391820345;5690.2887139107615;5710;5746.540276777858;5760.164776107473;5208.739563021843;5265.631405801595;5267.789288428458;5279.973600132013;5322.361316642008;5324.494173053554;5331.386890507583;5331.440198779131;5347.1177255752755;5393.973030134844;5171.689698618076;5198.220266959948;5338.332708411449;5338.958903013914;5341.599380046493;5275;5275.28783614211;5317.654352467077;5321.988822123784;5368.033753924292;5165.147750621143;5244.580433565344;5244.763985620656;5273.973630131824;5301.469853014668;4394.978025109854;5583.637063590853;5723.341815691208;5842.298924129089;5860.062390017577;5900.911486327708;6178.227721534809;6202.41077097675;6246.6876656167005;6284.7486100555925;6274.372562743734;6286.559940804145;6289.276733175698;6296.622202667854;6299.842503937438;5875.265591801025;5878.382769809194;5902.76388944446;5908.497777688902;5949.196858424058;5469;6082.391760823883;6272.749090036439;6332.398422149889;6351.174347334817;5046.394432668103;5888.705564721747;6121.663308518075;6189.0097584386285;6209.223847019122;6213.689315534205;6263.872502949422;6288.213973253343;6313.715882785285;6341;6109.981658125326;6114.175715401326;6124.594542075475;6146.200993870768;6285.779997700059;6153.446189842935;6176.135341052256;6179.3202747697715;6183.81448556544;6208.689565521796;5038.521340472649;5046.495350464924;5060.5951523878;5063.87340316495;5089.389273287155;4412.955870441255;4445.17764213615;4453.710508816916;4503.301988191835;4531.796069176895;5817.912731309034;5841.328247251536;5880.676562789002;5912.76348946046;5929.466348028698;6210.378962103844;6210.4100110489435;6210.937890621126;6229.065640154013;6248.187735594343;5685.914711279334;5731.484166425042;5796.536277097822;5830.679312637761;5872.29532456108;5493.368262649847;5497.202905578669;5502.889942201134;5510.366307874566;5533.7786488540005;6383.425491705769;6385.106085148083;6406.263279722892;6411.935880641134;6420.871582568416;6113.871604717183;6124.045297608125;6180.81457556274;6204.5967012144065;6230.719617617308;5319.38827034896;6333.461655759312;6354.586951848115;6360.713767880549;6362.809115726535;6189.226346706661;6208.9689551551955;6215.285242197205;6243.656598887105;6249;6163.3836616338;6200.503959683305;6217.378262173927;6292.370762923671;6306.054091886071;6076.361981992004;6135.110408990582;6143.143438301211;6151.0773383992755;6162.952298109242;6129.601575897553;6145.0782382642965;6154.861350650144;6159.322474527888;6164.137020817179;5806;5819.098039803837;5829.300483941955;5925.259342582177;6030.8793824122395;6084.269887613515;6087.086936959315;6137.815865524041;6173.783917562864;6179.011358182669;5953;5997.460228579449;6006.669633170043;6013.128096426081;6016.157737916607 17:13:39 INFO - PROCESS | 1665 | |1;ext.html;415.6716194206577;445.6791110400512;472.3623108803116;485.2163755534812;516.2926790297294;38334;41544.79227603865;41641.37537936933;41699.791501042455;41717.791411042905;42148.36777448333;42664.36003459951;42883.07026183821;42920.356194657026;43589.91025224371;7837.647305871221;8584.442011269279;8797.648094076229;9234.861477077866;9516.429014259133;11166.274192177523;11433.028192603597;11471.713207169845;11566.958973692366;11576.826347604792;11447.942760286229;11473.713157171096;11499.367534785584;11521.884781152206;11550.653480395602;11570.421478926062;11614.4192790361;11627;11633.418329083512;11681.824772628417;11481.942590287079;11546.36494992775;11567.53729850805;11567.826482602684;11572.768544629145;41501.1699766006;41624.37563436551;41856.1628767426;41892.952676183035;42011.36982945258;3875.8643447479485;3935.940960885589;3966.2662407454714;3989.3816458448987;3994.7802870842092;27710.3072423189;28890.85554572235;29332.97334593279;29520.409591808257;29583.556246656317;3105.8757649693985;3152.0701393089093;3220.6940340667597;3318.7179089777396;3326.135204846733;397130;469687;476036;476354.9458021675;483074.5846270746;57257.71371143118;57580.71209643925;57719.134212986835;57740.55648608734;58031;61689.691551542855;62062.689686551275;62075;62139.689301554106;62508.687456562424;15554.222288885736;15694.76457853133;15933.601659958595;16103.355865765237;16118.677626447405;10240.590376384862;11101.500432480558;11431.542738290542;12296.877031229573;12534.686632834251;14131.576052718436;18375.356862509747;18397.3560925367;18471.445856624323;18540.44378668642;7456.51532650376;7484.101907771103;8030.478018928751;8114.890128566497;8227.300679442194;858.1890113842484;869.6260607938647;875.3085062800444;876.3117322325635;903.6882275614902;25460.236192914243;31045.379092418025;31173.22066948299;31210.7515699374;31557.368852622818;998.12048669503;1046.6493724602192;1083.2038451737967;1087.798757229915;1105.4638500327335;15423.845761542465;16020.919895400448;16101.044796064163;16173.353065877232;16636.50090497287;495692;601819.9909000514;605260;605697;607941;47174.5282547177;47320;47379;47380.81547961329;47670.761646191546;1425.950091746784;1436.3751767980962;1468.544751127154;1470.801441805364;1474.800901878254;27775.888964441197;29143.417131657672;30482.390352193277;30840.228994275323;30959;52281;52733.7363313181;52765.20852187297;52873.7356313216;52965.470345297595;543624;543901;544723;547265;549957;25338.873305633355;26147.346316342242;26304.4739105213;26925.596116057885;27281;43560;43807.34288985732;44427;44704;44846.3273050898;28797.56803647905;35284.647153529164;36103.81948090243;36168.457473137394;37010;35716;35984;36637.81681091578;36725;37020.81489592643;35132.47301290432;35322.29355412929;35343.64656353506;35600;36245.81877090598;26952.730472695806;28788.568171477862;30190.849045754632;32369.51445728269;32639.34721305513;24105.75894241035;24262;24282.63576046396;24597.63103553484;24818.875905620356 17:13:39 INFO - PROCESS | 1665 | |2;jquery.html;322.90312906128156;349.3258012036769;351.83639607582484;364.4023800966417;372.26477706529624;18406.815931840676;19069.80930190696;19760;20169.899150504247;20796.68804967923;12065.698357541065;14563.053401528894;20054.799452005474;20744.89627551864;20942.581148377023;5192.688438693681;5407.891842163154;5411.296531450906;5432.293801805759;5435.9943410468995;4482.372467854503;5023.171176755831;5379.623426360156;5448;5462.9726851365685;5431;5442.727863606824;5451.182322651594;5458.918116228259;5460.563154947595;5228.372595288571;5337.119375303089;5395.10980688186;5396.244525766396;5415.891682166354;5283.9471605284225;5297.708626025567;5303.416624171338;5304.602154838402;5310.973445132789;13066.954643628582;13078.673033174151;13303.933480332633;13318.200907945555;13529.985251106107;2590.8575028373434;2634.617980392832;2692.192342297303;2693.3266683329166;2702.3244188952763;8497.95751021247;9983.908102889143;9993.500324983794;10211.438370889598;10631.415272160028;1833.1659095111693;1836.2930271845303;1870.6258748250405;1894.2139012309874;1914.8563857710587;121437.39281303625;124209.13686294622;132845.0073248902;135652;138616;10254.230932680079;12013.699657508632;12110.333931633844;12297.139200256075;12393.380330983415;15404.229788510755;15681.529554113395;15690.372385104696;15703.057816530816;15707.528774136794;8508;8701.477911325213;8732.650693972297;8788.736337909873;8804.779880503038;8479.19447652472;8491.787705307293;8493.320534357237;8609.139086091342;8668.696595619123;4840.636952228597;4869.610431165498;4879.536444037811;4894.653970158235;4894.853154405374;1941.4563922101834;1960.6470835249793;2044.9386518404472;2078.7089807426973;2090.226616152003;1015.1827778638119;1017.3438132404558;1024.2983556263982;1035.7048241251207;1065.3607835298915;20199.4950126248;21641;21739.45651358697;21800.34598962034;21806.127754889945;912.7672443526991;1047.1831971062584;1053.3416614615865;1081.1729027294127;1082.480409403475;8936.910630893737;9311.161995420445;11209.271397359145;11292;11364.318140911571;625094;627166;635985;705574;766719;94424;109009.36485952717;134357;143713;156325;902.7517432706059;990.5393991793851;1043.222799014739;1053.8629978102797;1054.715226888751;18011.72982405239;19035;19290.7106393407;19294.90352548228;19325.130369133705;43561;45605.08789824119;52033.7398313006;55537.444625553224;59075;85178;86580;86894;87422.5628871877;89257;8090.6359213836695;8202.26179643835;8295.83408331818;8453.915460845314;8458.661653533789;12098.5855036583;12921.741565168832;13200.669983250496;13202.141860779018;13259.602211933658;8744.431611945203;10791.946040269748;11055.834162487408;11132.220744547803;11406.54373825071;10621;10714.196435267542;10768.407737574194;11031.944840275748;11041.33751974884;10846.67459976202;10934.289271197347;11147.72130696739;11262.605808796652;11400;7165;8029.11361568638;8265.793355166168;8446.704365347183;8478.618462169341;10850.403227822546;10899.564017439214;11051.060659844003;11233.606823761129;11294.435278235891 17:13:39 INFO - PROCESS | 1665 | |3;mootools.html;1261.8296529968454;1410.6825964158058;1419.3683810704229;1432.047688287289;1444.4872070415;7581.77254682359;7803.063632364124;7980.680772769089;8422.620982055807;8447.957760211199;8036.839263214747;8263.46287491314;8285.42002059856;8456.112108228639;8456.957715211416;2301.3786277705008;2355.6702061711376;2356.4108972756812;2361.2325994051916;2369.1589485732575;2078.6050650376455;2146.592147491979;2323.3262353917344;2368.27767530903;2372.110458578033;2246.809021233189;2324.5815753164425;2327.6043072677685;2333.4749681321737;2335.8131349492087;2321.071571371448;2323.2101085630884;2337.228714524203;2337.801286890608;2339.3683705399617;2306.811991824212;2307.653851922225;2361.5985282502015;2364.6689463475127;2381.011880069769;8440.409171358007;8445.662173513052;8491.363147763943;8496.490210587384;8505.404621676485;5111.693298402108;5257.947420525784;5270.49930256625;5272.261883336336;5277.736113194325;3315.7181639560426;3499.0902365384927;3544.929101417983;3560.3266464761778;3569.6787289144104;945.8035584984999;1090.1605763562093;1158.2529268621777;1176.2942234659222;1195.647284051207;10798.946005270001;10912.61805836792;10918.672439826738;10924.126069914388;10977.780444391068;3748.6438788315068;4669.299605059268;4695.81216751333;4742.762861856893;4743.217369134123;8036.919630803617;9606;9636;9636.132748052709;9641.903580964241;5203.531682148625;5261.3686357637325;5283.630145889751;5284.471552844685;5289.444608316148;4726.787294571684;4776.904461910743;4836.540528649773;4837;4850.029994001214;3882.650561449483;3889;3949.6840252780285;3960.7029472789654;4029.6776257899296;1181.6277872470143;1223.8714934931882;1251.1054595963928;1287.8003909394058;1288.7358091591202;827.0241115483786;839.5508403004363;848.1052489623506;853.2406158518924;872.3239489395769;5248.160294352885;5314.415414304423;5603.299587551556;5610.046292130348;5631.63394379364;929.5770424456856;953.4994128082674;962.5476026267643;966.3863446711389;975.0882924465506;3584.9603614951893;3635.8183590333247;3691.9630803692157;3721.9441708374397;3736.0286325555553;9809.754756131153;10122.139618132394;10124.190064794946;10127.645532406477;10133.949330253448;10073.24450666203;10088.899111008943;10099.899001009895;10105.747356316004;10106.898931010743;7779.8833017504785;7814.3748500119855;7882.09355924076;7968.840623187504;7986.041674999037;5271.1039123348355;5371.939900364755;5377.650452720561;5415.864603384947;5485.890282194414;9290.62837486493;9416.670416535388;9419;9420.717378478657;9422.775039245129;7847.882281765892;9136.908630913606;9250.259979201513;9420;9454.858177127211;6756.054152418764;6806;6806.55757375769;6844.794656160323;6897.3447522485285;7862.213778622092;7921.009873765779;7932.801679958047;7952.6421311042295;7953.721619743281;6957.8956315654295;7173.354398104196;7205.675744591401;7261.38278246355;7276.8908466374105;5990.281166260077;6913.032175495334;6952.826179345557;7102.928970710227;7122.430205583644;6243.125962365181;6272.780452684134;6345.2702939160745;6350.618962862243;6350.872982540231;4840.854774356775;4883.487233840538;4898.069366820293;4951.72765497901;4964.131277026434;4521.819127234874;4889.559939605452;4909.4845041270155;4991.301217829434;4993.525615066563 17:13:39 INFO - PROCESS | 1665 | |4;prototype.html;339.3569186391788;356.2732026665602;363.34960420846676;369.0975564744202;375.2251600445079;3520.6303338149446;4393.736375817453;5041.747912604374;5213.374395072592;5461.481159289871;4132.7226320757945;4671;5307.283516725241;5314.123169676998;5316.3354580677415;3830.7701537907815;4208.831646734127;4211.768352740613;4218.704690671654;4233.534311225762;3913.0825895311236;4050.7367021143677;4067.491563554556;4223.450951376317;4234.724742891717;4153.460050193471;4166.791660416982;4174.478190226222;4175.31107367284;4193.0984838259765;3118.3763247350394;4169.808588307546;4177.268977928866;4193.622573968342;4211.410402543646;3415.590129184489;3702.648248416396;3707.9629203707887;3741.401375779862;3745.569259535161;4497.605742219922;4850.369451971256;5131.743412829381;5201.531862132426;5272.551833094191;4825.734584597846;4829.855104346875;4835.975820120912;4850.757462126915;4867.537583929521;5192.636515443883;5198.246254293144;5230.555402790729;5690.207584610835;5702.6293290935955;3914.549826769901;4068.206699693561;4093.6520395766097;4111.280525907984;4113.280175969194;5115.948840511584;5683.346415162227;5904.498117660004;5964.343922168558;5983.222181116427;3673.559172899269;4193.22425351311;4204.159168166379;4227.830886764495;4229.217594744982;3570.732195085379;4045.91908161841;4140.275451795984;4230.8519201827785;4291.82832686689;4091.6112969267874;4687.179743544866;4823.662343635982;4854.203944540543;4856.417229932431;4757.857264282077;5439;5659.320881494247;5712.143178523172;5712.7717540728945;1272.7072773262016;1310.9803352949714;1361.5574938145141;1380.42712274405;1391.8538553451945;851.5188918261163;908.7364664247426;921.944683319003;971.6016433262329;973.9172170365457;4311.784410779448;4901.166801643729;4964.478729733398;4987.775550100254;5004;4976.950230497649;5339.172428273624;5482.780688772485;5591.245181900392;5597.468240517144;4177.728447650893;4413.845515406945;4487.282034874404;4566.95433045672;5035.136999310205;2852.301186209392;2903.433830403051;2906.7674586033067;2922.225610213295;2924.947019073132;5009.674371165863;5115.7953681852305;5332.4137793170285;5750.5112065474905;5812.82561523155;4408.823647054082;5014.295139652463;5630.270572718936;5691.4877661010705;5741.799037033684;4434.41264007353;5025.3718285214345;5111.875387414762;5290.947090529123;5787.218725472091;4797.808087676453;4904.675737550912;5147.9227811582105;5549.279723285795;5569.470900264469;4375.9935214900115;5059.88816877625;5277;5401.540869026177;5462.235287059894;5062.114594680997;5327;5352.411234764095;5480.314960629921;5768.480836724715;3099.6361600895534;3403.6596340365763;3564.928701426009;3996.780177090288;4017.437558741837;4772.570468657837;5070.518300761421;5322.175062865262;5505.43095217861;5550.4449555044175;4761.785719642694;4904.779284932115;5416.375087473821;5442.510174084351;5621.437856214346;4660.533946605312;5449.583108391767;5592.328920529562;5613.186088017296;5652.491275785199;4365.607095361433;4426.380306757121;4912.042151780369;5336.985972665181;5366.421788210067;4274.401583778212;4624.7687615618415;5016.673916195436;5575.4424557543925;5613.859653508695;4117.649999749935;4651.2557990721325;4712.905741885212;5327.600429967845;5420.945790542044 17:13:39 INFO - PROCESS | 1665 | |5;yui.html;699.1505321034941;705.2630001648283;759.7378904278022;817.2113910076774;822.3298012120122;14548.490802821903;15328.386864525433;15362.001469904462;15362.462313819018;16619.584510387245;14883.511648835138;15316.387344506235;16149.950253233561;16709.91645041776;16743.66512669746;663.4427081251747;830.2361827119065;859.4198915731887;860.1226748716306;860.7073594977707;683.9008343790148;820.1429506166041;832.5878690048435;851.0298259983624;852.6333676519125;888.7244954064229;902.4855832175663;902.9909700902973;904.1275169461468;906.1436942089728;729.8503806719609;904.3307952115453;904.8506996345628;905.2622112977934;906.0350726476281;670.4100391655361;671.7850287907871;674.1842370731421;676.4115219758792;678.592844293425;15195.100612423446;15388.384464621402;15456.381744730197;15550.533483995498;15770.448034318744;11721.648350549498;12471.189372690837;12992.935035324763;13662.497125316208;13743.793843092362;9247.26021918245;9254.86117708235;10890.945545272223;11214.719632009184;12042.337671428068;3543.3090547343277;3609.1157666371646;3619.0771353305004;3619.49327094207;3763.34141525232;105284.47357763162;107271.85456290831;107765.46117269441;110371;111536;10291.125254353465;10498.317609355367;10504.579816807242;10560.102391296672;10573.101286390589;19424;19739.013049347475;21913.780862191492;21985;22022.229221977155;7474.775756727198;7488.9625551871895;7559.342483784029;7603.4297427693145;7680.3471704905705;4079.6940229482316;4167.10407262434;4233.364995250737;4255.297875850512;4259.87220383389;3195.9360812783616;3270.117068391521;3375.915602109967;3452.620211776753;3460.705840003628;560.2968274815163;643.1927930447258;666.620026584842;685.0854109763422;685.7531288736051;650.612885333226;664.7141729056456;674.1573033707865;688.8174633722068;709.3367701199395;9653.90346096544;9841.753956151153;9996.450195239331;10063.245256605784;10151.543180556893;638.2149955554694;661.6162625677096;692.6155983429145;694.5624256718336;718.8418547919449;4706.623470122382;4882.609391248691;4908.134519980997;4916;4937.629677774181;80740;92089.07910920805;98822;99064;100478.49760751295;83791.16208837955;83936.16063839283;84011.57994210112;85908.57045714857;90310;54624.72687636536;68926;71670.64164679144;72064.27935720576;72653;10370.740731481774;10540.683779486628;10647.787044259227;10814.976878325107;10953.233273671085;41729;45738.77130614326;48958;50318.24522632237;51011.74494127506;59983.700081499315;60492.69753651204;70315.64842175756;71368;72064;12440.19138755978;12531.310777907303;12669.619911402673;12713.36433178356;12817.871821281668;14065.156090634186;14148.929255353658;14288.642783930485;14324.283785810876;14337.78493322622;12858.035647326675;13283.867161328262;13375.331233438485;13711;13984.021118521607;12841.544950363641;12910.806337905127;13518.662033449242;13757.10578812374;14056.437742490594;12626.621201363974;13267.006591219997;13322.533711320057;13341.399637016551;13677.589672309847;10483.58065677395;10746.677599672023;10761.461926903467;10910.672679819618;11011.61459348919;10095.495225238856;10264;10679.679609611723;10831.2959657622;10853.34879907208 17:13:39 INFO - PROCESS | 1665 | __end_tp_report 17:13:39 INFO - PROCESS | 1665 | __start_cc_report 17:13:39 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,388 17:13:39 INFO - PROCESS | 1665 | __end_cc_report 17:13:39 INFO - PROCESS | 1665 | __startTimestamp1488330819654__endTimestamp 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | ------- Summary: start ------- 17:13:39 INFO - PROCESS | 1665 | Number of tests: 6 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5752.54 Median:5929.47 stddev:636.33 (10.7%) stddev-sans-first:609.39 17:13:39 INFO - PROCESS | 1665 | Values: 3335.9 3373.1 3387.5 3388.9 3402.3 5601.4 5618.1 5638.9 5700.1 5714.4 4658.2 5690.3 5710.0 5746.5 5760.2 5208.7 5265.6 5267.8 5280.0 5322.4 5324.5 5331.4 5331.4 5347.1 5394.0 5171.7 5198.2 5338.3 5339.0 5341.6 5275.0 5275.3 5317.7 5322.0 5368.0 5165.1 5244.6 5244.8 5274.0 5301.5 4395.0 5583.6 5723.3 5842.3 5860.1 5900.9 6178.2 6202.4 6246.7 6284.7 6274.4 6286.6 6289.3 6296.6 6299.8 5875.3 5878.4 5902.8 5908.5 5949.2 5469.0 6082.4 6272.7 6332.4 6351.2 5046.4 5888.7 6121.7 6189.0 6209.2 6213.7 6263.9 6288.2 6313.7 6341.0 6110.0 6114.2 6124.6 6146.2 6285.8 6153.4 6176.1 6179.3 6183.8 6208.7 5038.5 5046.5 5060.6 5063.9 5089.4 4413.0 4445.2 4453.7 4503.3 4531.8 5817.9 5841.3 5880.7 5912.8 5929.5 6210.4 6210.4 6210.9 6229.1 6248.2 5685.9 5731.5 5796.5 5830.7 5872.3 5493.4 5497.2 5502.9 5510.4 5533.8 6383.4 6385.1 6406.3 6411.9 6420.9 6113.9 6124.0 6180.8 6204.6 6230.7 5319.4 6333.5 6354.6 6360.7 6362.8 6189.2 6209.0 6215.3 6243.7 6249.0 6163.4 6200.5 6217.4 6292.4 6306.1 6076.4 6135.1 6143.1 6151.1 6163.0 6129.6 6145.1 6154.9 6159.3 6164.1 5806.0 5819.1 5829.3 5925.3 6030.9 6084.3 6087.1 6137.8 6173.8 6179.0 5953.0 5997.5 6006.7 6013.1 6016.2 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:66411.16 Median:35850.00 stddev:142224.11 (396.7%) stddev-sans-first:142536.77 17:13:39 INFO - PROCESS | 1665 | Values: 415.7 445.7 472.4 485.2 516.3 38334.0 41544.8 41641.4 41699.8 41717.8 42148.4 42664.4 42883.1 42920.4 43589.9 7837.6 8584.4 8797.6 9234.9 9516.4 11166.3 11433.0 11471.7 11567.0 11576.8 11447.9 11473.7 11499.4 11521.9 11550.7 11570.4 11614.4 11627.0 11633.4 11681.8 11481.9 11546.4 11567.5 11567.8 11572.8 41501.2 41624.4 41856.2 41893.0 42011.4 3875.9 3935.9 3966.3 3989.4 3994.8 27710.3 28890.9 29333.0 29520.4 29583.6 3105.9 3152.1 3220.7 3318.7 3326.1 397130.0 469687.0 476036.0 476354.9 483074.6 57257.7 57580.7 57719.1 57740.6 58031.0 61689.7 62062.7 62075.0 62139.7 62508.7 15554.2 15694.8 15933.6 16103.4 16118.7 10240.6 11101.5 11431.5 12296.9 12534.7 14131.6 18375.4 18397.4 18471.4 18540.4 7456.5 7484.1 8030.5 8114.9 8227.3 858.2 869.6 875.3 876.3 903.7 25460.2 31045.4 31173.2 31210.8 31557.4 998.1 1046.6 1083.2 1087.8 1105.5 15423.8 16020.9 16101.0 16173.4 16636.5 495692.0 601820.0 605260.0 605697.0 607941.0 47174.5 47320.0 47379.0 47380.8 47670.8 1426.0 1436.4 1468.5 1470.8 1474.8 27775.9 29143.4 30482.4 30840.2 30959.0 52281.0 52733.7 52765.2 52873.7 52965.5 543624.0 543901.0 544723.0 547265.0 549957.0 25338.9 26147.3 26304.5 26925.6 27281.0 43560.0 43807.3 44427.0 44704.0 44846.3 28797.6 35284.6 36103.8 36168.5 37010.0 35716.0 35984.0 36637.8 36725.0 37020.8 35132.5 35322.3 35343.6 35600.0 36245.8 26952.7 28788.6 30190.8 32369.5 32639.3 24105.8 24262.0 24282.6 24597.6 24818.9 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:37191.89 Median:21291.79 stddev:112435.81 (528.1%) stddev-sans-first:112717.14 17:13:39 INFO - PROCESS | 1665 | Values: 322.9 349.3 351.8 364.4 372.3 18406.8 19069.8 19760.0 20169.9 20796.7 12065.7 14563.1 20054.8 20744.9 20942.6 5192.7 5407.9 5411.3 5432.3 5436.0 4482.4 5023.2 5379.6 5448.0 5463.0 5431.0 5442.7 5451.2 5458.9 5460.6 5228.4 5337.1 5395.1 5396.2 5415.9 5283.9 5297.7 5303.4 5304.6 5311.0 13067.0 13078.7 13303.9 13318.2 13530.0 2590.9 2634.6 2692.2 2693.3 2702.3 8498.0 9983.9 9993.5 10211.4 10631.4 1833.2 1836.3 1870.6 1894.2 1914.9 121437.4 124209.1 132845.0 135652.0 138616.0 10254.2 12013.7 12110.3 12297.1 12393.4 15404.2 15681.5 15690.4 15703.1 15707.5 8508.0 8701.5 8732.7 8788.7 8804.8 8479.2 8491.8 8493.3 8609.1 8668.7 4840.6 4869.6 4879.5 4894.7 4894.9 1941.5 1960.6 2044.9 2078.7 2090.2 1015.2 1017.3 1024.3 1035.7 1065.4 20199.5 21641.0 21739.5 21800.3 21806.1 912.8 1047.2 1053.3 1081.2 1082.5 8936.9 9311.2 11209.3 11292.0 11364.3 625094.0 627166.0 635985.0 705574.0 766719.0 94424.0 109009.4 134357.0 143713.0 156325.0 902.8 990.5 1043.2 1053.9 1054.7 18011.7 19035.0 19290.7 19294.9 19325.1 43561.0 45605.1 52033.7 55537.4 59075.0 85178.0 86580.0 86894.0 87422.6 89257.0 8090.6 8202.3 8295.8 8453.9 8458.7 12098.6 12921.7 13200.7 13202.1 13259.6 8744.4 10791.9 11055.8 11132.2 11406.5 10621.0 10714.2 10768.4 11031.9 11041.3 10846.7 10934.3 11147.7 11262.6 11400.0 7165.0 8029.1 8265.8 8446.7 8478.6 10850.4 10899.6 11051.1 11233.6 11294.4 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5424.56 Median:5253.05 stddev:2967.84 (56.5%) stddev-sans-first:2959.68 17:13:39 INFO - PROCESS | 1665 | Values: 1261.8 1410.7 1419.4 1432.0 1444.5 7581.8 7803.1 7980.7 8422.6 8448.0 8036.8 8263.5 8285.4 8456.1 8457.0 2301.4 2355.7 2356.4 2361.2 2369.2 2078.6 2146.6 2323.3 2368.3 2372.1 2246.8 2324.6 2327.6 2333.5 2335.8 2321.1 2323.2 2337.2 2337.8 2339.4 2306.8 2307.7 2361.6 2364.7 2381.0 8440.4 8445.7 8491.4 8496.5 8505.4 5111.7 5257.9 5270.5 5272.3 5277.7 3315.7 3499.1 3544.9 3560.3 3569.7 945.8 1090.2 1158.3 1176.3 1195.6 10798.9 10912.6 10918.7 10924.1 10977.8 3748.6 4669.3 4695.8 4742.8 4743.2 8036.9 9606.0 9636.0 9636.1 9641.9 5203.5 5261.4 5283.6 5284.5 5289.4 4726.8 4776.9 4836.5 4837.0 4850.0 3882.7 3889.0 3949.7 3960.7 4029.7 1181.6 1223.9 1251.1 1287.8 1288.7 827.0 839.6 848.1 853.2 872.3 5248.2 5314.4 5603.3 5610.0 5631.6 929.6 953.5 962.5 966.4 975.1 3585.0 3635.8 3692.0 3721.9 3736.0 9809.8 10122.1 10124.2 10127.6 10133.9 10073.2 10088.9 10099.9 10105.7 10106.9 7779.9 7814.4 7882.1 7968.8 7986.0 5271.1 5371.9 5377.7 5415.9 5485.9 9290.6 9416.7 9419.0 9420.7 9422.8 7847.9 9136.9 9250.3 9420.0 9454.9 6756.1 6806.0 6806.6 6844.8 6897.3 7862.2 7921.0 7932.8 7952.6 7953.7 6957.9 7173.4 7205.7 7261.4 7276.9 5990.3 6913.0 6952.8 7102.9 7122.4 6243.1 6272.8 6345.3 6350.6 6350.9 4840.9 4883.5 4898.1 4951.7 4964.1 4521.8 4889.6 4909.5 4991.3 4993.5 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4419.42 Median:4843.17 stddev:1288.04 (26.6%) stddev-sans-first:1254.72 17:13:39 INFO - PROCESS | 1665 | Values: 339.4 356.3 363.3 369.1 375.2 3520.6 4393.7 5041.7 5213.4 5461.5 4132.7 4671.0 5307.3 5314.1 5316.3 3830.8 4208.8 4211.8 4218.7 4233.5 3913.1 4050.7 4067.5 4223.5 4234.7 4153.5 4166.8 4174.5 4175.3 4193.1 3118.4 4169.8 4177.3 4193.6 4211.4 3415.6 3702.6 3708.0 3741.4 3745.6 4497.6 4850.4 5131.7 5201.5 5272.6 4825.7 4829.9 4836.0 4850.8 4867.5 5192.6 5198.2 5230.6 5690.2 5702.6 3914.5 4068.2 4093.7 4111.3 4113.3 5115.9 5683.3 5904.5 5964.3 5983.2 3673.6 4193.2 4204.2 4227.8 4229.2 3570.7 4045.9 4140.3 4230.9 4291.8 4091.6 4687.2 4823.7 4854.2 4856.4 4757.9 5439.0 5659.3 5712.1 5712.8 1272.7 1311.0 1361.6 1380.4 1391.9 851.5 908.7 921.9 971.6 973.9 4311.8 4901.2 4964.5 4987.8 5004.0 4977.0 5339.2 5482.8 5591.2 5597.5 4177.7 4413.8 4487.3 4567.0 5035.1 2852.3 2903.4 2906.8 2922.2 2924.9 5009.7 5115.8 5332.4 5750.5 5812.8 4408.8 5014.3 5630.3 5691.5 5741.8 4434.4 5025.4 5111.9 5290.9 5787.2 4797.8 4904.7 5147.9 5549.3 5569.5 4376.0 5059.9 5277.0 5401.5 5462.2 5062.1 5327.0 5352.4 5480.3 5768.5 3099.6 3403.7 3564.9 3996.8 4017.4 4772.6 5070.5 5322.2 5505.4 5550.4 4761.8 4904.8 5416.4 5442.5 5621.4 4660.5 5449.6 5592.3 5613.2 5652.5 4365.6 4426.4 4912.0 5337.0 5366.4 4274.4 4624.8 5016.7 5575.4 5613.9 4117.6 4651.3 4712.9 5327.6 5420.9 17:13:39 INFO - PROCESS | 1665 | 17:13:39 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:19773.44 Median:3921.52 stddev:28180.28 (718.6%) stddev-sans-first:28222.94 17:13:39 INFO - PROCESS | 1665 | Values: 699.2 705.3 759.7 817.2 822.3 14548.5 15328.4 15362.0 15362.5 16619.6 14883.5 15316.4 16150.0 16709.9 16743.7 663.4 830.2 859.4 860.1 860.7 683.9 820.1 832.6 851.0 852.6 888.7 902.5 903.0 904.1 906.1 729.9 904.3 904.9 905.3 906.0 670.4 671.8 674.2 676.4 678.6 15195.1 15388.4 15456.4 15550.5 15770.4 11721.6 12471.2 12992.9 13662.5 13743.8 9247.3 9254.9 10890.9 11214.7 12042.3 3543.3 3609.1 3619.1 3619.5 3763.3 105284.5 107271.9 107765.5 110371.0 111536.0 10291.1 10498.3 10504.6 10560.1 10573.1 19424.0 19739.0 21913.8 21985.0 22022.2 7474.8 7489.0 7559.3 7603.4 7680.3 4079.7 4167.1 4233.4 4255.3 4259.9 3195.9 3270.1 3375.9 3452.6 3460.7 560.3 643.2 666.6 685.1 685.8 650.6 664.7 674.2 688.8 709.3 9653.9 9841.8 9996.5 10063.2 10151.5 638.2 661.6 692.6 694.6 718.8 4706.6 4882.6 4908.1 4916.0 4937.6 80740.0 92089.1 98822.0 99064.0 100478.5 83791.2 83936.2 84011.6 85908.6 90310.0 54624.7 68926.0 71670.6 72064.3 72653.0 10370.7 10540.7 10647.8 10815.0 10953.2 41729.0 45738.8 48958.0 50318.2 51011.7 59983.7 60492.7 70315.6 71368.0 72064.0 12440.2 12531.3 12669.6 12713.4 12817.9 14065.2 14148.9 14288.6 14324.3 14337.8 12858.0 13283.9 13375.3 13711.0 13984.0 12841.5 12910.8 13518.7 13757.1 14056.4 12626.6 13267.0 13322.5 13341.4 13677.6 10483.6 10746.7 10761.5 10910.7 11011.6 10095.5 10264.0 10679.7 10831.3 10853.3 17:13:39 INFO - PROCESS | 1665 | -------- Summary: end -------- 17:13:39 INFO - PROCESS | 1665 | 17:13:40 INFO - TEST-INFO | 1665: exit 0 17:13:40 INFO - TEST-OK | dromaeo_css | took 1115347ms 17:13:40 INFO - TEST-START | kraken 17:13:40 INFO - operating with platform_type : mac_ 17:13:40 INFO - Initialising browser for kraken test... 17:13:40 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpvwvvtE/profile http://localhost:49271/getInfo.html) 17:13:43 INFO - PROCESS | 1672 | 2017-02-28 17:13:43.026 plugin-container[1673:16572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 17:13:43 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:43 INFO - PROCESS | 1672 | 2017-02-28 17:13:43.029 plugin-container[1673:16572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 17:13:43 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:43 INFO - PROCESS | 1672 | 2017-02-28 17:13:43.029 plugin-container[1673:16572] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:13:43 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 17:13:43 INFO - PROCESS | 1672 | colorDepth:24 17:13:43 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 17:13:43 INFO - PROCESS | 1672 | __metrics 17:13:43 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 17:13:43 INFO - TEST-INFO | 1672: exit 0 17:13:43 INFO - Browser initialized. 17:13:43 INFO - Running cycle 1/1 for kraken test... 17:13:43 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpvwvvtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:46 INFO - PROCESS | 1674 | 2017-02-28 17:13:46.420 plugin-container[1675:16698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 17:13:46 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:46 INFO - PROCESS | 1674 | 2017-02-28 17:13:46.422 plugin-container[1675:16698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.CFPasteboardClient' 17:13:46 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:46 INFO - PROCESS | 1674 | 2017-02-28 17:13:46.422 plugin-container[1675:16698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:13:56 INFO - PROCESS | 1674 | RSS: Main: 218681344 17:13:56 INFO - PROCESS | 1674 | 17:13:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:00 INFO - PROCESS | 1674 | RSS: Main: 233062400 17:14:00 INFO - PROCESS | 1674 | 17:14:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 17:14:03 INFO - PROCESS | 1674 | RSS: Main: 241041408 17:14:03 INFO - PROCESS | 1674 | 17:14:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 17:14:07 INFO - PROCESS | 1674 | RSS: Main: 244744192 17:14:07 INFO - PROCESS | 1674 | 17:14:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 17:14:10 INFO - PROCESS | 1674 | RSS: Main: 245149696 17:14:10 INFO - PROCESS | 1674 | 17:14:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:12 INFO - PROCESS | 1674 | RSS: Main: 246464512 17:14:12 INFO - PROCESS | 1674 | 17:14:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:16 INFO - PROCESS | 1674 | RSS: Main: 250867712 17:14:16 INFO - PROCESS | 1674 | 17:14:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:20 INFO - PROCESS | 1674 | RSS: Main: 249937920 17:14:20 INFO - PROCESS | 1674 | 17:14:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 17:14:23 INFO - PROCESS | 1674 | RSS: Main: 249741312 17:14:23 INFO - PROCESS | 1674 | 17:14:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:26 INFO - PROCESS | 1674 | RSS: Main: 249307136 17:14:26 INFO - PROCESS | 1674 | 17:14:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:28 INFO - PROCESS | 1674 | RSS: Main: 249503744 17:14:28 INFO - PROCESS | 1674 | 17:14:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:31 INFO - PROCESS | 1674 | RSS: Main: 249409536 17:14:31 INFO - PROCESS | 1674 | 17:14:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:35 INFO - PROCESS | 1674 | RSS: Main: 249618432 17:14:35 INFO - PROCESS | 1674 | 17:14:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:38 INFO - PROCESS | 1674 | RSS: Main: 249438208 17:14:38 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 17:14:40 INFO - PROCESS | 1674 | RSS: Main: 251355136 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | __start_tp_report 17:14:40 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 17:14:40 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 17:14:40 INFO - PROCESS | 1674 | |i|pagename|runs| 17:14:40 INFO - PROCESS | 1674 | |0;ai-astar;106;119;121;121;124;119;119;119;120;122 17:14:40 INFO - PROCESS | 1674 | |1;audio-beat-detection;143;143;100;177;103;130;100;149;117;137 17:14:40 INFO - PROCESS | 1674 | |2;audio-dft;201;195;195;202;198;194;200;234;277;197 17:14:40 INFO - PROCESS | 1674 | |3;audio-fft;83;59;72;99;58;52;68;81;97;84 17:14:40 INFO - PROCESS | 1674 | |4;audio-oscillator;78;73;69;99;103;105;116;101;70;83 17:14:40 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;90;106;136;129;92;88;93;92;138;114 17:14:40 INFO - PROCESS | 1674 | |6;imaging-darkroom;102;102;138;102;105;101;134;177;135;178 17:14:40 INFO - PROCESS | 1674 | |7;imaging-desaturate;98;130;92;94;95;93;92;92;97;141 17:14:40 INFO - PROCESS | 1674 | |8;json-parse-financial;59;59;58;63;63;61;63;63;62;63 17:14:40 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;69;76;68;78;74;73;70;72;73;76 17:14:40 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;83;84;88;95;87;75;88;107;105;83 17:14:40 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;139;143;139;146;160;148;151;156;194;167 17:14:40 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;168;170;232;184;166;166;171;172;168;168 17:14:40 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;67;67;67;68;73;83;64;61;88 17:14:40 INFO - PROCESS | 1674 | __end_tp_report 17:14:40 INFO - PROCESS | 1674 | __start_cc_report 17:14:40 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,963 17:14:40 INFO - PROCESS | 1674 | __end_cc_report 17:14:40 INFO - PROCESS | 1674 | __startTimestamp1488330880790__endTimestamp 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | ------- Summary: start ------- 17:14:40 INFO - PROCESS | 1674 | Number of tests: 14 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:119.00 Median:120.50 stddev:4.85 (4.0%) stddev-sans-first:1.74 17:14:40 INFO - PROCESS | 1674 | Values: 106.0 119.0 121.0 121.0 124.0 119.0 119.0 119.0 120.0 122.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:140.00 stddev:25.07 (17.9%) stddev-sans-first:26.13 17:14:40 INFO - PROCESS | 1674 | Values: 143.0 143.0 100.0 177.0 103.0 130.0 100.0 149.0 117.0 137.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:209.30 Median:200.50 stddev:26.51 (13.2%) stddev-sans-first:27.95 17:14:40 INFO - PROCESS | 1674 | Values: 201.0 195.0 195.0 202.0 198.0 194.0 200.0 234.0 277.0 197.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:75.30 Median:82.00 stddev:16.23 (19.8%) stddev-sans-first:16.98 17:14:40 INFO - PROCESS | 1674 | Values: 83.0 59.0 72.0 99.0 58.0 52.0 68.0 81.0 97.0 84.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:71.50 stddev:16.98 (23.7%) stddev-sans-first:17.47 17:14:40 INFO - PROCESS | 1674 | Values: 78.0 73.0 69.0 99.0 103.0 105.0 116.0 101.0 70.0 83.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:107.80 Median:89.00 stddev:20.07 (22.6%) stddev-sans-first:20.23 17:14:40 INFO - PROCESS | 1674 | Values: 90.0 106.0 136.0 129.0 92.0 88.0 93.0 92.0 138.0 114.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:127.40 Median:134.50 stddev:30.49 (22.7%) stddev-sans-first:30.93 17:14:40 INFO - PROCESS | 1674 | Values: 102.0 102.0 138.0 102.0 105.0 101.0 134.0 177.0 135.0 178.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:93.50 stddev:17.76 (19.0%) stddev-sans-first:18.76 17:14:40 INFO - PROCESS | 1674 | Values: 98.0 130.0 92.0 94.0 95.0 93.0 92.0 92.0 97.0 141.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:63.00 stddev:2.01 (3.2%) stddev-sans-first:1.94 17:14:40 INFO - PROCESS | 1674 | Values: 59.0 59.0 58.0 63.0 63.0 61.0 63.0 63.0 62.0 63.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:73.50 stddev:3.25 (4.4%) stddev-sans-first:3.12 17:14:40 INFO - PROCESS | 1674 | Values: 69.0 76.0 68.0 78.0 74.0 73.0 70.0 72.0 73.0 76.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:85.50 stddev:10.07 (11.8%) stddev-sans-first:10.40 17:14:40 INFO - PROCESS | 1674 | Values: 83.0 84.0 88.0 95.0 87.0 75.0 88.0 107.0 105.0 83.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:153.50 stddev:16.63 (10.8%) stddev-sans-first:16.69 17:14:40 INFO - PROCESS | 1674 | Values: 139.0 143.0 139.0 146.0 160.0 148.0 151.0 156.0 194.0 167.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:170.50 stddev:20.18 (11.8%) stddev-sans-first:21.17 17:14:40 INFO - PROCESS | 1674 | Values: 168.0 170.0 232.0 184.0 166.0 166.0 171.0 172.0 168.0 168.0 17:14:40 INFO - PROCESS | 1674 | 17:14:40 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:67.50 stddev:8.54 (12.7%) stddev-sans-first:8.96 17:14:40 INFO - PROCESS | 1674 | Values: 67.0 67.0 67.0 67.0 68.0 73.0 83.0 64.0 61.0 88.0 17:14:40 INFO - PROCESS | 1674 | -------- Summary: end -------- 17:14:40 INFO - PROCESS | 1674 | 17:14:41 INFO - TEST-INFO | 1674: exit 0 17:14:41 INFO - TEST-OK | kraken | took 61360ms 17:14:41 INFO - SUITE-END | took 1176s 17:14:41 INFO - Completed test suite (00:19:36) 17:14:41 INFO - javascript benchmark 17:14:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7206.107315358063, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.866565337385, 3373.0555444475544, 3387.5426817379653, 3388.932486266824, 3402.3365443738467, 5601.3558440779325, 5618.101103823389, 5638.887222255553, 5700.116481945295, 5714.371419143901, 4658.231391820345, 5690.2887139107615, 5710.0, 5746.540276777858, 5760.164776107473, 5208.739563021843, 5265.631405801595, 5267.789288428458, 5279.973600132013, 5322.361316642008, 5324.494173053554, 5331.386890507583, 5331.440198779131, 5347.1177255752755, 5393.973030134844, 5171.689698618076, 5198.220266959948, 5338.332708411449, 5338.958903013914, 5341.599380046493, 5275.0, 5275.28783614211, 5317.654352467077, 5321.988822123784, 5368.033753924292, 5165.147750621143, 5244.580433565344, 5244.763985620656, 5273.973630131824, 5301.469853014668, 4394.978025109854, 5583.637063590853, 5723.341815691208, 5842.298924129089, 5860.062390017577, 5900.911486327708, 6178.227721534809, 6202.41077097675, 6246.6876656167005, 6284.7486100555925, 6274.372562743734, 6286.559940804145, 6289.276733175698, 6296.622202667854, 6299.842503937438, 5875.265591801025, 5878.382769809194, 5902.76388944446, 5908.497777688902, 5949.196858424058, 5469.0, 6082.391760823883, 6272.749090036439, 6332.398422149889, 6351.174347334817, 5046.394432668103, 5888.705564721747, 6121.663308518075, 6189.0097584386285, 6209.223847019122, 6213.689315534205, 6263.872502949422, 6288.213973253343, 6313.715882785285, 6341.0, 6109.981658125326, 6114.175715401326, 6124.594542075475, 6146.200993870768, 6285.779997700059, 6153.446189842935, 6176.135341052256, 6179.3202747697715, 6183.81448556544, 6208.689565521796, 5038.521340472649, 5046.495350464924, 5060.5951523878, 5063.87340316495, 5089.389273287155, 4412.955870441255, 4445.17764213615, 4453.710508816916, 4503.301988191835, 4531.796069176895, 5817.912731309034, 5841.328247251536, 5880.676562789002, 5912.76348946046, 5929.466348028698, 6210.378962103844, 6210.4100110489435, 6210.937890621126, 6229.065640154013, 6248.187735594343, 5685.914711279334, 5731.484166425042, 5796.536277097822, 5830.679312637761, 5872.29532456108, 5493.368262649847, 5497.202905578669, 5502.889942201134, 5510.366307874566, 5533.7786488540005, 6383.425491705769, 6385.106085148083, 6406.263279722892, 6411.935880641134, 6420.871582568416, 6113.871604717183, 6124.045297608125, 6180.81457556274, 6204.5967012144065, 6230.719617617308, 5319.38827034896, 6333.461655759312, 6354.586951848115, 6360.713767880549, 6362.809115726535, 6189.226346706661, 6208.9689551551955, 6215.285242197205, 6243.656598887105, 6249.0, 6163.3836616338, 6200.503959683305, 6217.378262173927, 6292.370762923671, 6306.054091886071, 6076.361981992004, 6135.110408990582, 6143.143438301211, 6151.0773383992755, 6162.952298109242, 6129.601575897553, 6145.0782382642965, 6154.861350650144, 6159.322474527888, 6164.137020817179, 5806.0, 5819.098039803837, 5829.300483941955, 5925.259342582177, 6030.8793824122395, 6084.269887613515, 6087.086936959315, 6137.815865524041, 6173.783917562864, 6179.011358182669, 5953.0, 5997.460228579449, 6006.669633170043, 6013.128096426081, 6016.157737916607], "value": 5713.757441110629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.6716194206577, 445.6791110400512, 472.3623108803116, 485.2163755534812, 516.2926790297294, 38334.0, 41544.79227603865, 41641.37537936933, 41699.791501042455, 41717.791411042905, 42148.36777448333, 42664.36003459951, 42883.07026183821, 42920.356194657026, 43589.91025224371, 7837.647305871221, 8584.442011269279, 8797.648094076229, 9234.861477077866, 9516.429014259133, 11166.274192177523, 11433.028192603597, 11471.713207169845, 11566.958973692366, 11576.826347604792, 11447.942760286229, 11473.713157171096, 11499.367534785584, 11521.884781152206, 11550.653480395602, 11570.421478926062, 11614.4192790361, 11627.0, 11633.418329083512, 11681.824772628417, 11481.942590287079, 11546.36494992775, 11567.53729850805, 11567.826482602684, 11572.768544629145, 41501.1699766006, 41624.37563436551, 41856.1628767426, 41892.952676183035, 42011.36982945258, 3875.8643447479485, 3935.940960885589, 3966.2662407454714, 3989.3816458448987, 3994.7802870842092, 27710.3072423189, 28890.85554572235, 29332.97334593279, 29520.409591808257, 29583.556246656317, 3105.8757649693985, 3152.0701393089093, 3220.6940340667597, 3318.7179089777396, 3326.135204846733, 397130.0, 469687.0, 476036.0, 476354.9458021675, 483074.5846270746, 57257.71371143118, 57580.71209643925, 57719.134212986835, 57740.55648608734, 58031.0, 61689.691551542855, 62062.689686551275, 62075.0, 62139.689301554106, 62508.687456562424, 15554.222288885736, 15694.76457853133, 15933.601659958595, 16103.355865765237, 16118.677626447405, 10240.590376384862, 11101.500432480558, 11431.542738290542, 12296.877031229573, 12534.686632834251, 14131.576052718436, 18375.356862509747, 18397.3560925367, 18471.445856624323, 18540.44378668642, 7456.51532650376, 7484.101907771103, 8030.478018928751, 8114.890128566497, 8227.300679442194, 858.1890113842484, 869.6260607938647, 875.3085062800444, 876.3117322325635, 903.6882275614902, 25460.236192914243, 31045.379092418025, 31173.22066948299, 31210.7515699374, 31557.368852622818, 998.12048669503, 1046.6493724602192, 1083.2038451737967, 1087.798757229915, 1105.4638500327335, 15423.845761542465, 16020.919895400448, 16101.044796064163, 16173.353065877232, 16636.50090497287, 495692.0, 601819.9909000514, 605260.0, 605697.0, 607941.0, 47174.5282547177, 47320.0, 47379.0, 47380.81547961329, 47670.761646191546, 1425.950091746784, 1436.3751767980962, 1468.544751127154, 1470.801441805364, 1474.800901878254, 27775.888964441197, 29143.417131657672, 30482.390352193277, 30840.228994275323, 30959.0, 52281.0, 52733.7363313181, 52765.20852187297, 52873.7356313216, 52965.470345297595, 543624.0, 543901.0, 544723.0, 547265.0, 549957.0, 25338.873305633355, 26147.346316342242, 26304.4739105213, 26925.596116057885, 27281.0, 43560.0, 43807.34288985732, 44427.0, 44704.0, 44846.3273050898, 28797.56803647905, 35284.647153529164, 36103.81948090243, 36168.457473137394, 37010.0, 35716.0, 35984.0, 36637.81681091578, 36725.0, 37020.81489592643, 35132.47301290432, 35322.29355412929, 35343.64656353506, 35600.0, 36245.81877090598, 26952.730472695806, 28788.568171477862, 30190.849045754632, 32369.51445728269, 32639.34721305513, 24105.75894241035, 24262.0, 24282.63576046396, 24597.63103553484, 24818.875905620356], "value": 19820.402807216524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.90312906128156, 349.3258012036769, 351.83639607582484, 364.4023800966417, 372.26477706529624, 18406.815931840676, 19069.80930190696, 19760.0, 20169.899150504247, 20796.68804967923, 12065.698357541065, 14563.053401528894, 20054.799452005474, 20744.89627551864, 20942.581148377023, 5192.688438693681, 5407.891842163154, 5411.296531450906, 5432.293801805759, 5435.9943410468995, 4482.372467854503, 5023.171176755831, 5379.623426360156, 5448.0, 5462.9726851365685, 5431.0, 5442.727863606824, 5451.182322651594, 5458.918116228259, 5460.563154947595, 5228.372595288571, 5337.119375303089, 5395.10980688186, 5396.244525766396, 5415.891682166354, 5283.9471605284225, 5297.708626025567, 5303.416624171338, 5304.602154838402, 5310.973445132789, 13066.954643628582, 13078.673033174151, 13303.933480332633, 13318.200907945555, 13529.985251106107, 2590.8575028373434, 2634.617980392832, 2692.192342297303, 2693.3266683329166, 2702.3244188952763, 8497.95751021247, 9983.908102889143, 9993.500324983794, 10211.438370889598, 10631.415272160028, 1833.1659095111693, 1836.2930271845303, 1870.6258748250405, 1894.2139012309874, 1914.8563857710587, 121437.39281303625, 124209.13686294622, 132845.0073248902, 135652.0, 138616.0, 10254.230932680079, 12013.699657508632, 12110.333931633844, 12297.139200256075, 12393.380330983415, 15404.229788510755, 15681.529554113395, 15690.372385104696, 15703.057816530816, 15707.528774136794, 8508.0, 8701.477911325213, 8732.650693972297, 8788.736337909873, 8804.779880503038, 8479.19447652472, 8491.787705307293, 8493.320534357237, 8609.139086091342, 8668.696595619123, 4840.636952228597, 4869.610431165498, 4879.536444037811, 4894.653970158235, 4894.853154405374, 1941.4563922101834, 1960.6470835249793, 2044.9386518404472, 2078.7089807426973, 2090.226616152003, 1015.1827778638119, 1017.3438132404558, 1024.2983556263982, 1035.7048241251207, 1065.3607835298915, 20199.4950126248, 21641.0, 21739.45651358697, 21800.34598962034, 21806.127754889945, 912.7672443526991, 1047.1831971062584, 1053.3416614615865, 1081.1729027294127, 1082.480409403475, 8936.910630893737, 9311.161995420445, 11209.271397359145, 11292.0, 11364.318140911571, 625094.0, 627166.0, 635985.0, 705574.0, 766719.0, 94424.0, 109009.36485952717, 134357.0, 143713.0, 156325.0, 902.7517432706059, 990.5393991793851, 1043.222799014739, 1053.8629978102797, 1054.715226888751, 18011.72982405239, 19035.0, 19290.7106393407, 19294.90352548228, 19325.130369133705, 43561.0, 45605.08789824119, 52033.7398313006, 55537.444625553224, 59075.0, 85178.0, 86580.0, 86894.0, 87422.5628871877, 89257.0, 8090.6359213836695, 8202.26179643835, 8295.83408331818, 8453.915460845314, 8458.661653533789, 12098.5855036583, 12921.741565168832, 13200.669983250496, 13202.141860779018, 13259.602211933658, 8744.431611945203, 10791.946040269748, 11055.834162487408, 11132.220744547803, 11406.54373825071, 10621.0, 10714.196435267542, 10768.407737574194, 11031.944840275748, 11041.33751974884, 10846.67459976202, 10934.289271197347, 11147.72130696739, 11262.605808796652, 11400.0, 7165.0, 8029.11361568638, 8265.793355166168, 8446.704365347183, 8478.618462169341, 10850.403227822546, 10899.564017439214, 11051.060659844003, 11233.606823761129, 11294.435278235891], "value": 9450.089183635375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.8296529968454, 1410.6825964158058, 1419.3683810704229, 1432.047688287289, 1444.4872070415, 7581.77254682359, 7803.063632364124, 7980.680772769089, 8422.620982055807, 8447.957760211199, 8036.839263214747, 8263.46287491314, 8285.42002059856, 8456.112108228639, 8456.957715211416, 2301.3786277705008, 2355.6702061711376, 2356.4108972756812, 2361.2325994051916, 2369.1589485732575, 2078.6050650376455, 2146.592147491979, 2323.3262353917344, 2368.27767530903, 2372.110458578033, 2246.809021233189, 2324.5815753164425, 2327.6043072677685, 2333.4749681321737, 2335.8131349492087, 2321.071571371448, 2323.2101085630884, 2337.228714524203, 2337.801286890608, 2339.3683705399617, 2306.811991824212, 2307.653851922225, 2361.5985282502015, 2364.6689463475127, 2381.011880069769, 8440.409171358007, 8445.662173513052, 8491.363147763943, 8496.490210587384, 8505.404621676485, 5111.693298402108, 5257.947420525784, 5270.49930256625, 5272.261883336336, 5277.736113194325, 3315.7181639560426, 3499.0902365384927, 3544.929101417983, 3560.3266464761778, 3569.6787289144104, 945.8035584984999, 1090.1605763562093, 1158.2529268621777, 1176.2942234659222, 1195.647284051207, 10798.946005270001, 10912.61805836792, 10918.672439826738, 10924.126069914388, 10977.780444391068, 3748.6438788315068, 4669.299605059268, 4695.81216751333, 4742.762861856893, 4743.217369134123, 8036.919630803617, 9606.0, 9636.0, 9636.132748052709, 9641.903580964241, 5203.531682148625, 5261.3686357637325, 5283.630145889751, 5284.471552844685, 5289.444608316148, 4726.787294571684, 4776.904461910743, 4836.540528649773, 4837.0, 4850.029994001214, 3882.650561449483, 3889.0, 3949.6840252780285, 3960.7029472789654, 4029.6776257899296, 1181.6277872470143, 1223.8714934931882, 1251.1054595963928, 1287.8003909394058, 1288.7358091591202, 827.0241115483786, 839.5508403004363, 848.1052489623506, 853.2406158518924, 872.3239489395769, 5248.160294352885, 5314.415414304423, 5603.299587551556, 5610.046292130348, 5631.63394379364, 929.5770424456856, 953.4994128082674, 962.5476026267643, 966.3863446711389, 975.0882924465506, 3584.9603614951893, 3635.8183590333247, 3691.9630803692157, 3721.9441708374397, 3736.0286325555553, 9809.754756131153, 10122.139618132394, 10124.190064794946, 10127.645532406477, 10133.949330253448, 10073.24450666203, 10088.899111008943, 10099.899001009895, 10105.747356316004, 10106.898931010743, 7779.8833017504785, 7814.3748500119855, 7882.09355924076, 7968.840623187504, 7986.041674999037, 5271.1039123348355, 5371.939900364755, 5377.650452720561, 5415.864603384947, 5485.890282194414, 9290.62837486493, 9416.670416535388, 9419.0, 9420.717378478657, 9422.775039245129, 7847.882281765892, 9136.908630913606, 9250.259979201513, 9420.0, 9454.858177127211, 6756.054152418764, 6806.0, 6806.55757375769, 6844.794656160323, 6897.3447522485285, 7862.213778622092, 7921.009873765779, 7932.801679958047, 7952.6421311042295, 7953.721619743281, 6957.8956315654295, 7173.354398104196, 7205.675744591401, 7261.38278246355, 7276.8908466374105, 5990.281166260077, 6913.032175495334, 6952.826179345557, 7102.928970710227, 7122.430205583644, 6243.125962365181, 6272.780452684134, 6345.2702939160745, 6350.618962862243, 6350.872982540231, 4840.854774356775, 4883.487233840538, 4898.069366820293, 4951.72765497901, 4964.131277026434, 4521.819127234874, 4889.559939605452, 4909.4845041270155, 4991.301217829434, 4993.525615066563], "value": 4400.89426219372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3569186391788, 356.2732026665602, 363.34960420846676, 369.0975564744202, 375.2251600445079, 3520.6303338149446, 4393.736375817453, 5041.747912604374, 5213.374395072592, 5461.481159289871, 4132.7226320757945, 4671.0, 5307.283516725241, 5314.123169676998, 5316.3354580677415, 3830.7701537907815, 4208.831646734127, 4211.768352740613, 4218.704690671654, 4233.534311225762, 3913.0825895311236, 4050.7367021143677, 4067.491563554556, 4223.450951376317, 4234.724742891717, 4153.460050193471, 4166.791660416982, 4174.478190226222, 4175.31107367284, 4193.0984838259765, 3118.3763247350394, 4169.808588307546, 4177.268977928866, 4193.622573968342, 4211.410402543646, 3415.590129184489, 3702.648248416396, 3707.9629203707887, 3741.401375779862, 3745.569259535161, 4497.605742219922, 4850.369451971256, 5131.743412829381, 5201.531862132426, 5272.551833094191, 4825.734584597846, 4829.855104346875, 4835.975820120912, 4850.757462126915, 4867.537583929521, 5192.636515443883, 5198.246254293144, 5230.555402790729, 5690.207584610835, 5702.6293290935955, 3914.549826769901, 4068.206699693561, 4093.6520395766097, 4111.280525907984, 4113.280175969194, 5115.948840511584, 5683.346415162227, 5904.498117660004, 5964.343922168558, 5983.222181116427, 3673.559172899269, 4193.22425351311, 4204.159168166379, 4227.830886764495, 4229.217594744982, 3570.732195085379, 4045.91908161841, 4140.275451795984, 4230.8519201827785, 4291.82832686689, 4091.6112969267874, 4687.179743544866, 4823.662343635982, 4854.203944540543, 4856.417229932431, 4757.857264282077, 5439.0, 5659.320881494247, 5712.143178523172, 5712.7717540728945, 1272.7072773262016, 1310.9803352949714, 1361.5574938145141, 1380.42712274405, 1391.8538553451945, 851.5188918261163, 908.7364664247426, 921.944683319003, 971.6016433262329, 973.9172170365457, 4311.784410779448, 4901.166801643729, 4964.478729733398, 4987.775550100254, 5004.0, 4976.950230497649, 5339.172428273624, 5482.780688772485, 5591.245181900392, 5597.468240517144, 4177.728447650893, 4413.845515406945, 4487.282034874404, 4566.95433045672, 5035.136999310205, 2852.301186209392, 2903.433830403051, 2906.7674586033067, 2922.225610213295, 2924.947019073132, 5009.674371165863, 5115.7953681852305, 5332.4137793170285, 5750.5112065474905, 5812.82561523155, 4408.823647054082, 5014.295139652463, 5630.270572718936, 5691.4877661010705, 5741.799037033684, 4434.41264007353, 5025.3718285214345, 5111.875387414762, 5290.947090529123, 5787.218725472091, 4797.808087676453, 4904.675737550912, 5147.9227811582105, 5549.279723285795, 5569.470900264469, 4375.9935214900115, 5059.88816877625, 5277.0, 5401.540869026177, 5462.235287059894, 5062.114594680997, 5327.0, 5352.411234764095, 5480.314960629921, 5768.480836724715, 3099.6361600895534, 3403.6596340365763, 3564.928701426009, 3996.780177090288, 4017.437558741837, 4772.570468657837, 5070.518300761421, 5322.175062865262, 5505.43095217861, 5550.4449555044175, 4761.785719642694, 4904.779284932115, 5416.375087473821, 5442.510174084351, 5621.437856214346, 4660.533946605312, 5449.583108391767, 5592.328920529562, 5613.186088017296, 5652.491275785199, 4365.607095361433, 4426.380306757121, 4912.042151780369, 5336.985972665181, 5366.421788210067, 4274.401583778212, 4624.7687615618415, 5016.673916195436, 5575.4424557543925, 5613.859653508695, 4117.649999749935, 4651.2557990721325, 4712.905741885212, 5327.600429967845, 5420.945790542044], "value": 4034.1101292669223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.1505321034941, 705.2630001648283, 759.7378904278022, 817.2113910076774, 822.3298012120122, 14548.490802821903, 15328.386864525433, 15362.001469904462, 15362.462313819018, 16619.584510387245, 14883.511648835138, 15316.387344506235, 16149.950253233561, 16709.91645041776, 16743.66512669746, 663.4427081251747, 830.2361827119065, 859.4198915731887, 860.1226748716306, 860.7073594977707, 683.9008343790148, 820.1429506166041, 832.5878690048435, 851.0298259983624, 852.6333676519125, 888.7244954064229, 902.4855832175663, 902.9909700902973, 904.1275169461468, 906.1436942089728, 729.8503806719609, 904.3307952115453, 904.8506996345628, 905.2622112977934, 906.0350726476281, 670.4100391655361, 671.7850287907871, 674.1842370731421, 676.4115219758792, 678.592844293425, 15195.100612423446, 15388.384464621402, 15456.381744730197, 15550.533483995498, 15770.448034318744, 11721.648350549498, 12471.189372690837, 12992.935035324763, 13662.497125316208, 13743.793843092362, 9247.26021918245, 9254.86117708235, 10890.945545272223, 11214.719632009184, 12042.337671428068, 3543.3090547343277, 3609.1157666371646, 3619.0771353305004, 3619.49327094207, 3763.34141525232, 105284.47357763162, 107271.85456290831, 107765.46117269441, 110371.0, 111536.0, 10291.125254353465, 10498.317609355367, 10504.579816807242, 10560.102391296672, 10573.101286390589, 19424.0, 19739.013049347475, 21913.780862191492, 21985.0, 22022.229221977155, 7474.775756727198, 7488.9625551871895, 7559.342483784029, 7603.4297427693145, 7680.3471704905705, 4079.6940229482316, 4167.10407262434, 4233.364995250737, 4255.297875850512, 4259.87220383389, 3195.9360812783616, 3270.117068391521, 3375.915602109967, 3452.620211776753, 3460.705840003628, 560.2968274815163, 643.1927930447258, 666.620026584842, 685.0854109763422, 685.7531288736051, 650.612885333226, 664.7141729056456, 674.1573033707865, 688.8174633722068, 709.3367701199395, 9653.90346096544, 9841.753956151153, 9996.450195239331, 10063.245256605784, 10151.543180556893, 638.2149955554694, 661.6162625677096, 692.6155983429145, 694.5624256718336, 718.8418547919449, 4706.623470122382, 4882.609391248691, 4908.134519980997, 4916.0, 4937.629677774181, 80740.0, 92089.07910920805, 98822.0, 99064.0, 100478.49760751295, 83791.16208837955, 83936.16063839283, 84011.57994210112, 85908.57045714857, 90310.0, 54624.72687636536, 68926.0, 71670.64164679144, 72064.27935720576, 72653.0, 10370.740731481774, 10540.683779486628, 10647.787044259227, 10814.976878325107, 10953.233273671085, 41729.0, 45738.77130614326, 48958.0, 50318.24522632237, 51011.74494127506, 59983.700081499315, 60492.69753651204, 70315.64842175756, 71368.0, 72064.0, 12440.19138755978, 12531.310777907303, 12669.619911402673, 12713.36433178356, 12817.871821281668, 14065.156090634186, 14148.929255353658, 14288.642783930485, 14324.283785810876, 14337.78493322622, 12858.035647326675, 13283.867161328262, 13375.331233438485, 13711.0, 13984.021118521607, 12841.544950363641, 12910.806337905127, 13518.662033449242, 13757.10578812374, 14056.437742490594, 12626.621201363974, 13267.006591219997, 13322.533711320057, 13341.399637016551, 13677.589672309847, 10483.58065677395, 10746.677599672023, 10761.461926903467, 10910.672679819618, 11011.61459348919, 10095.495225238856, 10264.0, 10679.679609611723, 10831.2959657622, 10853.34879907208], "value": 7368.820057289394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 121.0, 121.0, 124.0, 119.0, 119.0, 119.0, 120.0, 122.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 100.0, 177.0, 103.0, 130.0, 100.0, 149.0, 117.0, 137.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 195.0, 195.0, 202.0, 198.0, 194.0, 200.0, 234.0, 277.0, 197.0], "value": 209.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 72.0, 99.0, 58.0, 52.0, 68.0, 81.0, 97.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 69.0, 99.0, 103.0, 105.0, 116.0, 101.0, 70.0, 83.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 106.0, 136.0, 129.0, 92.0, 88.0, 93.0, 92.0, 138.0, 114.0], "value": 107.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 138.0, 102.0, 105.0, 101.0, 134.0, 177.0, 135.0, 178.0], "value": 127.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 130.0, 92.0, 94.0, 95.0, 93.0, 92.0, 92.0, 97.0, 141.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 63.0, 63.0, 61.0, 63.0, 63.0, 62.0, 63.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 68.0, 78.0, 74.0, 73.0, 70.0, 72.0, 73.0, 76.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 88.0, 95.0, 87.0, 75.0, 88.0, 107.0, 105.0, 83.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 143.0, 139.0, 146.0, 160.0, 148.0, 151.0, 156.0, 194.0, 167.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 232.0, 184.0, 166.0, 166.0, 171.0, 172.0, 168.0, 168.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 73.0, 83.0, 64.0, 61.0, 88.0], "value": 70.5, "unit": "score"}]}]} 17:14:42 INFO - Return code: 0 17:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:42 ERROR - # TBPL SUCCESS # 17:14:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:42 INFO - 2017-02-28 17:14:42.087 screenresolution[1679:17085] starting screenresolution argv=screenresolution get 17:14:42 INFO - 2017-02-28 17:14:42.089 screenresolution[1679:17085] Display 0: 1600x1200x32@60 17:14:42 INFO - 2017-02-28 17:14:42.095 screenresolution[1680:17088] starting screenresolution argv=screenresolution list 17:14:42 INFO - Available Modes on Display 0 17:14:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:42 INFO - Intel Iris: 17:14:42 INFO - Chipset Model: Intel Iris 17:14:42 INFO - Type: GPU 17:14:42 INFO - Bus: Built-In 17:14:42 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:42 INFO - Vendor: Intel (0x8086) 17:14:42 INFO - Device ID: 0x0a2e 17:14:42 INFO - Revision ID: 0x0009 17:14:42 INFO - Displays: 17:14:42 INFO - Display: 17:14:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:42 INFO - Display Serial Number: 1600x1200 60 17:14:42 INFO - Main Display: Yes 17:14:42 INFO - Mirror: Off 17:14:42 INFO - Online: Yes 17:14:42 INFO - Rotation: Supported 17:14:42 INFO - Return code: 0 17:14:42 INFO - Running post-action listener: _resource_record_post_action 17:14:42 INFO - [mozharness: 2017-03-01 01:14:42.339052Z] Finished run-tests step (success) 17:14:42 INFO - Running post-run listener: _resource_record_post_run 17:14:42 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 33387008; Write bytes: 511029760; Read time: 198; Write time: 1606 17:14:42 INFO - TinderboxPrint: CPU usage
54.3% 17:14:42 INFO - TinderboxPrint: I/O read bytes / time
33,387,008 / 198 17:14:42 INFO - TinderboxPrint: I/O write bytes / time
511,029,760 / 1,606 17:14:42 INFO - TinderboxPrint: CPU idle
2,189.5 (45.7%) 17:14:42 INFO - TinderboxPrint: CPU system
963.4 (20.1%) 17:14:42 INFO - TinderboxPrint: CPU user
1,636.8 (34.2%) 17:14:42 INFO - TinderboxPrint: Swap in / out
237,137,920 / 0 17:14:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203549184; Write bytes: 202151936; Read time: 15525; Write time: 424 17:14:42 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31412736; Write bytes: 298121728; Read time: 179; Write time: 1147 17:14:42 INFO - Running post-run listener: _upload_blobber_files 17:14:42 INFO - Blob upload gear active. 17:14:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:42 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 17:14:42 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:14:42 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:14:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:14:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:44 INFO - (blobuploader) - INFO - Done attempting. 17:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:45 INFO - (blobuploader) - INFO - Done attempting. 17:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:46 INFO - (blobuploader) - INFO - Done attempting. 17:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:48 INFO - (blobuploader) - INFO - Done attempting. 17:14:48 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:48 INFO - Return code: 0 17:14:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5282f9a0e8f51f5025cda441e6a6ad1da2589417f83d0d82b9c19d7b1cc80f04b18dc1c071d43c471bc4a0c221fee3455d2745268b5b7389e5ef82fe43e8c826", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc9161b088ff70c1759395817ff14467010356f79afa65457980bdea94745d14bc9034baad2eadc8ee43c7f740a303fbe276e9bb26482c4ab266ddce230842", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fb6e70d161e7882fa769d1fdf96799a7b842ad2ba7f9a21a58c278501d34bd9e6db6a9d58139f703eb54d63be5bf8bf0d4c857255acacedec6c6a8bfa9290df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71a82518826f737bc4ff5ce3579f3fc7a5979ed9d8fca90beb9ba6ea1dba8b425506141dc972ac1df1812a3d28f4bd27b9bfceb277f2fe8f793314654d468061"} 17:14:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:48 INFO - Contents: 17:14:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5282f9a0e8f51f5025cda441e6a6ad1da2589417f83d0d82b9c19d7b1cc80f04b18dc1c071d43c471bc4a0c221fee3455d2745268b5b7389e5ef82fe43e8c826", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc9161b088ff70c1759395817ff14467010356f79afa65457980bdea94745d14bc9034baad2eadc8ee43c7f740a303fbe276e9bb26482c4ab266ddce230842", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fb6e70d161e7882fa769d1fdf96799a7b842ad2ba7f9a21a58c278501d34bd9e6db6a9d58139f703eb54d63be5bf8bf0d4c857255acacedec6c6a8bfa9290df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71a82518826f737bc4ff5ce3579f3fc7a5979ed9d8fca90beb9ba6ea1dba8b425506141dc972ac1df1812a3d28f4bd27b9bfceb277f2fe8f793314654d468061"} 17:14:48 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:48 INFO - Copying logs to upload dir... 17:14:48 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.775725 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-28 17:14:48.457613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:48.460739) ========= 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.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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/Mozilla-Aurora/sha512/5282f9a0e8f51f5025cda441e6a6ad1da2589417f83d0d82b9c19d7b1cc80f04b18dc1c071d43c471bc4a0c221fee3455d2745268b5b7389e5ef82fe43e8c826", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc9161b088ff70c1759395817ff14467010356f79afa65457980bdea94745d14bc9034baad2eadc8ee43c7f740a303fbe276e9bb26482c4ab266ddce230842", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fb6e70d161e7882fa769d1fdf96799a7b842ad2ba7f9a21a58c278501d34bd9e6db6a9d58139f703eb54d63be5bf8bf0d4c857255acacedec6c6a8bfa9290df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71a82518826f737bc4ff5ce3579f3fc7a5979ed9d8fca90beb9ba6ea1dba8b425506141dc972ac1df1812a3d28f4bd27b9bfceb277f2fe8f793314654d468061"} build_url:https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010951 build_url: 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5282f9a0e8f51f5025cda441e6a6ad1da2589417f83d0d82b9c19d7b1cc80f04b18dc1c071d43c471bc4a0c221fee3455d2745268b5b7389e5ef82fe43e8c826", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc9161b088ff70c1759395817ff14467010356f79afa65457980bdea94745d14bc9034baad2eadc8ee43c7f740a303fbe276e9bb26482c4ab266ddce230842", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fb6e70d161e7882fa769d1fdf96799a7b842ad2ba7f9a21a58c278501d34bd9e6db6a9d58139f703eb54d63be5bf8bf0d4c857255acacedec6c6a8bfa9290df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71a82518826f737bc4ff5ce3579f3fc7a5979ed9d8fca90beb9ba6ea1dba8b425506141dc972ac1df1812a3d28f4bd27b9bfceb277f2fe8f793314654d468061"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:48.495555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:48.495910) ========= 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.34EkB3LTcO/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.UyAL4JgR8K/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.005116 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:48.547424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 17:14:48.548294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 17:14:48.549086) ========= ========= Total master_lag: 0.19 =========