builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0167 starttime: 1489852104.98 results: success (0) buildid: 20170318080120 builduid: 2c43c6e1bd7f4a088265dab0e9cfa14c revision: 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:24.983028) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:24.983560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:24.983916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:25.065683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:25.066388) ========= 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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-18 08:48:25-- 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% 19.2M=0.001s 2017-03-18 08:48:25 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.214791 ========= master_lag: 0.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:25.916070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:25.916450) ========= 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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.032503 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:25.974566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-18 08:48:25.975359) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 --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 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-18 08:48:26,081 truncating revision to first 12 chars 2017-03-18 08:48:26,081 Setting DEBUG logging. 2017-03-18 08:48:26,081 attempt 1/10 2017-03-18 08:48:26,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9df61b09aa1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-18 08:48:27,229 unpacking tar archive at: mozilla-aurora-9df61b09aa1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.421238 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-18 08:48:27.422296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:27.422657) ========= script_repo_revision: 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:27.423155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:27.423500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-18 08:48:27.446784) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-18 08:48:27.447121) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:48:27 INFO - MultiFileLogger online at 20170318 08:48:27 in /builds/slave/test 08:48:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:27 INFO - {'append_to_log': False, 08:48:27 INFO - 'base_work_dir': '/builds/slave/test', 08:48:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:27 INFO - 'branch': 'Mozilla-Aurora', 08:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:27 INFO - 'config_files': ('talos/mac_config.py',), 08:48:27 INFO - 'default_actions': ('clobber', 08:48:27 INFO - 'read-buildbot-config', 08:48:27 INFO - 'download-and-extract', 08:48:27 INFO - 'populate-webroot', 08:48:27 INFO - 'create-virtualenv', 08:48:27 INFO - 'install', 08:48:27 INFO - 'run-tests'), 08:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:27 INFO - 'download_minidump_stackwalk': True, 08:48:27 INFO - 'download_symbols': 'ondemand', 08:48:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:27 INFO - 'gecko_profile': False, 08:48:27 INFO - 'gecko_profile_interval': 0, 08:48:27 INFO - 'installer_path': 'installer.exe', 08:48:27 INFO - 'log_level': 'info', 08:48:27 INFO - 'log_name': 'talos', 08:48:27 INFO - 'log_to_console': True, 08:48:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:27 INFO - 'opt_config_files': (), 08:48:27 INFO - 'pip_index': False, 08:48:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:27 INFO - 'cmd': ('bash', 08:48:27 INFO - '-c', 08:48:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:27 INFO - 'enabled': True, 08:48:27 INFO - 'halt_on_failure': False, 08:48:27 INFO - 'name': 'check_screen_resolution'},), 08:48:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:27 INFO - 'cmd': ('bash', 08:48:27 INFO - '-c', 08:48:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:27 INFO - 'enabled': True, 08:48:27 INFO - 'halt_on_failure': False, 08:48:27 INFO - 'name': 'check_screen_resolution'},), 08:48:27 INFO - 'run_cmd_checks_enabled': True, 08:48:27 INFO - 'suite': 'dromaeojs', 08:48:27 INFO - 'system_bits': '32', 08:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:27 INFO - 'title': 't-yosemite-r7-0167', 08:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:27 INFO - 'use_talos_json': True, 08:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:27 INFO - 'work_dir': 'build'} 08:48:27 INFO - [mozharness: 2017-03-18 15:48:27.666001Z] Running clobber step. 08:48:27 INFO - Running pre-action listener: _resource_record_pre_action 08:48:27 INFO - Running main action method: clobber 08:48:27 INFO - rmtree: /builds/slave/test/build 08:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - [mozharness: 2017-03-18 15:48:30.350637Z] Finished clobber step (success) 08:48:30 INFO - [mozharness: 2017-03-18 15:48:30.350778Z] Running read-buildbot-config step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: read_buildbot_config 08:48:30 INFO - Using buildbot properties: 08:48:30 INFO - { 08:48:30 INFO - "project": "", 08:48:30 INFO - "product": "firefox", 08:48:30 INFO - "script_repo_revision": "production", 08:48:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:48:30 INFO - "repository": "", 08:48:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:48:30 INFO - "buildid": "20170318080120", 08:48:30 INFO - "pgo_build": "False", 08:48:30 INFO - "basedir": "/builds/slave/test", 08:48:30 INFO - "buildnumber": 9, 08:48:30 INFO - "slavename": "t-yosemite-r7-0167", 08:48:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:48:30 INFO - "platform": "yosemite_r7", 08:48:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:48:30 INFO - "branch": "mozilla-aurora", 08:48:30 INFO - "repo_path": "releases/mozilla-aurora", 08:48:30 INFO - "revision": "9df61b09aa1ce0b26486bb30c6ca63e89ac06100", 08:48:30 INFO - "stage_platform": "macosx64", 08:48:30 INFO - "builduid": "2c43c6e1bd7f4a088265dab0e9cfa14c", 08:48:30 INFO - "slavebuilddir": "test" 08:48:30 INFO - } 08:48:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - [mozharness: 2017-03-18 15:48:30.354266Z] Finished read-buildbot-config step (success) 08:48:30 INFO - [mozharness: 2017-03-18 15:48:30.354377Z] Running download-and-extract step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: download_and_extract 08:48:30 INFO - mkdir: /builds/slave/test/build/tests 08:48:30 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')]} 08:48:30 INFO - trying https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 08:48:30 INFO - Downloading https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 08:48:31 INFO - Downloaded 1199 bytes. 08:48:31 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:48:31 INFO - Using the following test package requirements: 08:48:31 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:48:31 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 08:48:31 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 08:48:31 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'jsshell-mac.zip'], 08:48:31 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 08:48:31 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:48:31 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 08:48:31 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 08:48:31 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 08:48:31 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:48:31 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 08:48:31 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:48:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:48:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:48:31 INFO - Fetch https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:48:33 INFO - Expected file size: 51781823 08:48:33 INFO - Obtained file size: 51781823 08:48:49 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:48:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:48:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:48:49 INFO - Fetch https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:48:50 INFO - Expected file size: 51781823 08:48:50 INFO - Obtained file size: 51781823 08:49:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 08:49:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:49:05 INFO - Fetch https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 08:49:07 INFO - Expected file size: 14404424 08:49:07 INFO - Obtained file size: 14404424 08:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:07 INFO - trying https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:49:07 INFO - Downloading https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 08:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 08:49:09 INFO - Downloaded 74623399 bytes. 08:49:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:49:09 INFO - mkdir: /builds/slave/test/properties 08:49:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:09 INFO - Contents: 08:49:09 INFO - build_url:https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:49:10 INFO - Running post-action listener: _resource_record_post_action 08:49:10 INFO - Running post-action listener: set_extra_try_arguments 08:49:10 INFO - [mozharness: 2017-03-18 15:49:10.168759Z] Finished download-and-extract step (success) 08:49:10 INFO - [mozharness: 2017-03-18 15:49:10.168906Z] Running populate-webroot step. 08:49:10 INFO - Running pre-action listener: _resource_record_pre_action 08:49:10 INFO - Running main action method: populate_webroot 08:49:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:10 INFO - '--tppagecycles', 08:49:10 INFO - '7'], 08:49:10 INFO - 'tests': ['tsvgm']}}, 08:49:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['damp', 'tps']}, 08:49:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'tests': ['damp', 'tps']}, 08:49:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['dromaeo_dom']}, 08:49:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['basic_compositor_video']}, 08:49:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['a11yr', 08:49:10 INFO - 'ts_paint', 08:49:10 INFO - 'tpaint', 08:49:10 INFO - 'sessionrestore', 08:49:10 INFO - 'sessionrestore_no_auto_restore', 08:49:10 INFO - 'tabpaint']}, 08:49:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['tsvgx', 08:49:10 INFO - 'tsvgr_opacity', 08:49:10 INFO - 'tart', 08:49:10 INFO - 'tscrollx', 08:49:10 INFO - 'cart', 08:49:10 INFO - 'tsvg_static']}, 08:49:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:10 INFO - 'tsvgr_opacity', 08:49:10 INFO - 'tart', 08:49:10 INFO - 'tscrollx', 08:49:10 INFO - 'cart', 08:49:10 INFO - 'tsvg_static']}, 08:49:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'talos_options': ['--disable-e10s'], 08:49:10 INFO - 'tests': ['tp5o']}, 08:49:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:49:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'talos_options': ['--disable-e10s', 08:49:10 INFO - '--xperf_path', 08:49:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:10 INFO - 'tests': ['tp5n']}, 08:49:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:49:10 INFO - 'talos_options': ['--xperf_path', 08:49:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:10 INFO - 'tests': ['tp5n']}}, 08:49:10 INFO - 'talos.zip': {'path': '', 08:49:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:10 INFO - Running post-action listener: _resource_record_post_action 08:49:10 INFO - [mozharness: 2017-03-18 15:49:10.187362Z] Finished populate-webroot step (success) 08:49:10 INFO - [mozharness: 2017-03-18 15:49:10.187493Z] Running create-virtualenv step. 08:49:10 INFO - Running pre-action listener: _resource_record_pre_action 08:49:10 INFO - Running main action method: create_virtualenv 08:49:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:10 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 08:49:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:10 INFO - Using real prefix '/tools/python27' 08:49:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:13 INFO - Installing pip.................done. 08:49:13 INFO - Return code: 0 08:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:49:14 INFO - Reading from file tmpfile_stdout 08:49:14 INFO - Output received: 08:49:14 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) 08:49:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:14 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')]} 08:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 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')]} 08:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:14 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 08:49:14 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 08:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:14 INFO - 'HOME': '/Users/cltbld', 08:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:14 INFO - 'LOGNAME': 'cltbld', 08:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:14 INFO - 'MOZ_NO_REMOTE': '1', 08:49:14 INFO - 'NO_EM_RESTART': '1', 08:49:14 INFO - 'PAGER': '/bin/cat', 08:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:14 INFO - 'PWD': '/builds/slave/test', 08:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:14 INFO - 'SHELL': '/bin/bash', 08:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:14 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:14 INFO - 'USER': 'cltbld', 08:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:14 INFO - 'XPC_FLAGS': '0x0', 08:49:14 INFO - 'XPC_SERVICE_NAME': '0', 08:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:14 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 08:49:14 INFO - Cleaning up... 08:49:14 INFO - Return code: 0 08:49:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:14 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')]} 08:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 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')]} 08:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:14 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 08:49:14 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 08:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:14 INFO - 'HOME': '/Users/cltbld', 08:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:14 INFO - 'LOGNAME': 'cltbld', 08:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:14 INFO - 'MOZ_NO_REMOTE': '1', 08:49:14 INFO - 'NO_EM_RESTART': '1', 08:49:14 INFO - 'PAGER': '/bin/cat', 08:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:14 INFO - 'PWD': '/builds/slave/test', 08:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:14 INFO - 'SHELL': '/bin/bash', 08:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:14 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:14 INFO - 'USER': 'cltbld', 08:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:14 INFO - 'XPC_FLAGS': '0x0', 08:49:14 INFO - 'XPC_SERVICE_NAME': '0', 08:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:14 INFO - Downloading/unpacking psutil>=3.1.1 08:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:18 INFO - Installing collected packages: psutil 08:49:18 INFO - Running setup.py install for psutil 08:49:18 INFO - building 'psutil._psutil_osx' extension 08:49:18 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 08:49:19 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 08:49:19 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 08:49:19 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 08:49:19 INFO - building 'psutil._psutil_posix' extension 08:49:19 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 08:49:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:19 INFO - ^ 08:49:19 INFO - 1 warning generated. 08:49:19 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 08:49:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:19 INFO - Successfully installed psutil 08:49:19 INFO - Cleaning up... 08:49:19 INFO - Return code: 0 08:49:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:19 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')]} 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 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')]} 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:19 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 08:49:19 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 08:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:19 INFO - 'HOME': '/Users/cltbld', 08:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:19 INFO - 'LOGNAME': 'cltbld', 08:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:19 INFO - 'MOZ_NO_REMOTE': '1', 08:49:19 INFO - 'NO_EM_RESTART': '1', 08:49:19 INFO - 'PAGER': '/bin/cat', 08:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:19 INFO - 'PWD': '/builds/slave/test', 08:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:19 INFO - 'SHELL': '/bin/bash', 08:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:19 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:19 INFO - 'USER': 'cltbld', 08:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:19 INFO - 'XPC_FLAGS': '0x0', 08:49:19 INFO - 'XPC_SERVICE_NAME': '0', 08:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:20 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 08:49:20 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 08:49:20 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 08:49:20 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 08:49:20 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 08:49:20 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 08:49:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:22 INFO - Installing collected packages: mozsystemmonitor 08:49:22 INFO - Running setup.py install for mozsystemmonitor 08:49:23 INFO - Successfully installed mozsystemmonitor 08:49:23 INFO - Cleaning up... 08:49:23 INFO - Return code: 0 08:49:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49:23 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')]} 08:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:23 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')]} 08:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:23 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:23 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 08:49:23 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 08:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:23 INFO - 'HOME': '/Users/cltbld', 08:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:23 INFO - 'LOGNAME': 'cltbld', 08:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:23 INFO - 'MOZ_NO_REMOTE': '1', 08:49:23 INFO - 'NO_EM_RESTART': '1', 08:49:23 INFO - 'PAGER': '/bin/cat', 08:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:23 INFO - 'PWD': '/builds/slave/test', 08:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:23 INFO - 'SHELL': '/bin/bash', 08:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:23 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:23 INFO - 'USER': 'cltbld', 08:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:23 INFO - 'XPC_FLAGS': '0x0', 08:49:23 INFO - 'XPC_SERVICE_NAME': '0', 08:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:23 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 08:49:23 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 08:49:23 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 08:49:23 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 08:49:23 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 08:49:23 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 08:49:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:26 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 08:49:26 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 08:49:26 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 08:49:26 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 08:49:26 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 08:49:26 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 08:49:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:26 INFO - warning: no files found matching '*.txt' 08:49:26 INFO - no previously-included directories found matching 'build' 08:49:26 INFO - no previously-included directories found matching 'dist' 08:49:26 INFO - no previously-included directories found matching '.git*' 08:49:26 INFO - Installing collected packages: jsonschema, functools32 08:49:26 INFO - Running setup.py install for functools32 08:49:26 INFO - warning: no files found matching '*.txt' 08:49:26 INFO - no previously-included directories found matching 'build' 08:49:26 INFO - no previously-included directories found matching 'dist' 08:49:26 INFO - no previously-included directories found matching '.git*' 08:49:26 INFO - Successfully installed jsonschema functools32 08:49:26 INFO - Cleaning up... 08:49:26 INFO - Return code: 0 08:49:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49:26 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')]} 08:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:26 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')]} 08:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:26 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:26 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 08:49:26 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 08:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:26 INFO - 'HOME': '/Users/cltbld', 08:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:26 INFO - 'LOGNAME': 'cltbld', 08:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:26 INFO - 'MOZ_NO_REMOTE': '1', 08:49:26 INFO - 'NO_EM_RESTART': '1', 08:49:26 INFO - 'PAGER': '/bin/cat', 08:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:26 INFO - 'PWD': '/builds/slave/test', 08:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:26 INFO - 'SHELL': '/bin/bash', 08:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:26 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:26 INFO - 'USER': 'cltbld', 08:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:26 INFO - 'XPC_FLAGS': '0x0', 08:49:26 INFO - 'XPC_SERVICE_NAME': '0', 08:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:27 INFO - Cleaning up... 08:49:27 INFO - Return code: 0 08:49:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', '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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49: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 blobuploader==1.2.4 08:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:27 INFO - 'HOME': '/Users/cltbld', 08:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:27 INFO - 'LOGNAME': 'cltbld', 08:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:27 INFO - 'MOZ_NO_REMOTE': '1', 08:49:27 INFO - 'NO_EM_RESTART': '1', 08:49:27 INFO - 'PAGER': '/bin/cat', 08:49:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:27 INFO - 'PWD': '/builds/slave/test', 08:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:27 INFO - 'SHELL': '/bin/bash', 08:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:27 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:27 INFO - 'USER': 'cltbld', 08:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:27 INFO - 'XPC_FLAGS': '0x0', 08:49:27 INFO - 'XPC_SERVICE_NAME': '0', 08:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:30 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 08:49:31 INFO - Downloading docopt-0.6.1.tar.gz 08:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:31 INFO - Running setup.py install for blobuploader 08:49:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:31 INFO - Running setup.py install for requests 08:49:31 INFO - Running setup.py install for docopt 08:49:32 INFO - Successfully installed blobuploader requests docopt 08:49:32 INFO - Cleaning up... 08:49:32 INFO - Return code: 0 08:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:32 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:32 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 08:49:32 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 08:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:32 INFO - 'HOME': '/Users/cltbld', 08:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:32 INFO - 'LOGNAME': 'cltbld', 08:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:32 INFO - 'MOZ_NO_REMOTE': '1', 08:49:32 INFO - 'NO_EM_RESTART': '1', 08:49:32 INFO - 'PAGER': '/bin/cat', 08:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:32 INFO - 'PWD': '/builds/slave/test', 08:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:32 INFO - 'SHELL': '/bin/bash', 08:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:32 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:32 INFO - 'USER': 'cltbld', 08:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:32 INFO - 'XPC_FLAGS': '0x0', 08:49:32 INFO - 'XPC_SERVICE_NAME': '0', 08:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:32 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SAri3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:32 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-TbX7Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:32 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Yukgpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:32 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LRRhS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:32 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-z03YU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Z4Q1DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-5UiEre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gpFq9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-JqJ8kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-EQ8xXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-OOceTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-iKOH2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nVH1Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:33 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VK8uSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:34 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Dv7VPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:34 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-3huPjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:34 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-kFJhtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:34 INFO - Running setup.py install for manifestparser 08:49:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:34 INFO - Running setup.py install for mozcrash 08:49:34 INFO - Running setup.py install for mozdebug 08:49:34 INFO - Running setup.py install for mozdevice 08:49:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:34 INFO - Running setup.py install for mozfile 08:49:35 INFO - Running setup.py install for mozhttpd 08:49:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Running setup.py install for mozinfo 08:49:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Running setup.py install for mozInstall 08:49:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Running setup.py install for mozleak 08:49:35 INFO - Running setup.py install for mozlog 08:49:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Running setup.py install for moznetwork 08:49:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:35 INFO - Running setup.py install for mozprocess 08:49:36 INFO - Running setup.py install for mozprofile 08:49:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:36 INFO - Running setup.py install for mozrunner 08:49:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:36 INFO - Running setup.py install for mozscreenshot 08:49:36 INFO - Running setup.py install for moztest 08:49:36 INFO - Running setup.py install for mozversion 08:49:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:36 INFO - Cleaning up... 08:49:36 INFO - Return code: 0 08:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:36 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')]} 08:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:36 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')]} 08:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:36 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:36 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 08:49:36 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 08:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:36 INFO - 'HOME': '/Users/cltbld', 08:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:36 INFO - 'LOGNAME': 'cltbld', 08:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:36 INFO - 'MOZ_NO_REMOTE': '1', 08:49:36 INFO - 'NO_EM_RESTART': '1', 08:49:36 INFO - 'PAGER': '/bin/cat', 08:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:36 INFO - 'PWD': '/builds/slave/test', 08:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:36 INFO - 'SHELL': '/bin/bash', 08:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:36 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:36 INFO - 'USER': 'cltbld', 08:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:36 INFO - 'XPC_FLAGS': '0x0', 08:49:36 INFO - 'XPC_SERVICE_NAME': '0', 08:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-pg5pMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nLizwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-enfqfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-THj4D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-jIA4Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Aune4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PO24h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:37 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)) 08:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hLfiox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-MJ0Pkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-C6AW9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-KfYEA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7_xQpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FYpyon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-IwtD1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ghtF3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-iK2Wf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:38 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)) 08:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9iU1I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:38 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)) 08:49:38 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)) 08:49:38 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)) 08:49:38 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)) 08:49:38 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)) 08:49:38 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)) 08:49:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:41 INFO - Downloading blessings-1.6.tar.gz 08:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:41 INFO - Installing collected packages: blessings 08:49:41 INFO - Running setup.py install for blessings 08:49:41 INFO - Successfully installed blessings 08:49:41 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:42 INFO - Reading from file tmpfile_stdout 08:49:42 INFO - Current package versions: 08:49:42 INFO - blessings == 1.6 08:49:42 INFO - blobuploader == 1.2.4 08:49:42 INFO - docopt == 0.6.1 08:49:42 INFO - functools32 == 3.2.3-2 08:49:42 INFO - jsonschema == 2.5.1 08:49:42 INFO - manifestparser == 1.1 08:49:42 INFO - mozInstall == 1.12 08:49:42 INFO - mozcrash == 1.0 08:49:42 INFO - mozdebug == 0.1 08:49:42 INFO - mozdevice == 0.49 08:49:42 INFO - mozfile == 1.2 08:49:42 INFO - mozhttpd == 0.7 08:49:42 INFO - mozinfo == 0.9 08:49:42 INFO - mozleak == 0.1 08:49:42 INFO - mozlog == 3.4 08:49:42 INFO - moznetwork == 0.27 08:49:42 INFO - mozprocess == 0.25 08:49:42 INFO - mozprofile == 0.28 08:49:42 INFO - mozrunner == 6.13 08:49:42 INFO - mozscreenshot == 0.1 08:49:42 INFO - mozsystemmonitor == 0.3 08:49:42 INFO - moztest == 0.8 08:49:42 INFO - mozversion == 1.4 08:49:42 INFO - psutil == 3.1.1 08:49:42 INFO - requests == 1.2.3 08:49:42 INFO - wsgiref == 0.1.2 08:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:42 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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:42 INFO - 'HOME': '/Users/cltbld', 08:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PAGER': '/bin/cat', 08:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:42 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - 'XPC_FLAGS': '0x0', 08:49:42 INFO - 'XPC_SERVICE_NAME': '0', 08:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 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)) 08:49:42 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:42 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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x105776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c8dda2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, '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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:42 INFO - 'HOME': '/Users/cltbld', 08:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PAGER': '/bin/cat', 08:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:49:42 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - 'XPC_FLAGS': '0x0', 08:49:42 INFO - 'XPC_SERVICE_NAME': '0', 08:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:42 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Running post-action listener: _resource_record_post_action 08:49:42 INFO - Running post-action listener: _start_resource_monitoring 08:49:42 INFO - Starting resource monitoring. 08:49:42 INFO - [mozharness: 2017-03-18 15:49:42.894367Z] Finished create-virtualenv step (success) 08:49:42 INFO - [mozharness: 2017-03-18 15:49:42.895315Z] Running install step. 08:49:42 INFO - Running pre-action listener: _resource_record_pre_action 08:49:42 INFO - Running main action method: install 08:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:43 INFO - Reading from file tmpfile_stdout 08:49:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:43 INFO - Reading from file tmpfile_stdout 08:49:43 INFO - Output received: 08:49:43 INFO - Usage: mozinstall [options] installer 08:49:43 INFO - Options: 08:49:43 INFO - -h, --help show this help message and exit 08:49:43 INFO - -d DEST, --destination=DEST 08:49:43 INFO - Directory to install application into. [default: 08:49:43 INFO - "/builds/slave/test"] 08:49:43 INFO - --app=APP Application being installed. [default: firefox] 08:49:43 INFO - mkdir: /builds/slave/test/build/application 08:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:04 INFO - Reading from file tmpfile_stdout 08:50:04 INFO - Output received: 08:50:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:50:04 INFO - Running post-action listener: _resource_record_post_action 08:50:04 INFO - [mozharness: 2017-03-18 15:50:04.204850Z] Finished install step (success) 08:50:04 INFO - [mozharness: 2017-03-18 15:50:04.204982Z] Running run-tests step. 08:50:04 INFO - Running pre-action listener: _resource_record_pre_action 08:50:04 INFO - Running main action method: run_tests 08:50:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:04 INFO - 2017-03-18 08:50:04.219 screenresolution[1631:7593] starting screenresolution argv=screenresolution get 08:50:04 INFO - 2017-03-18 08:50:04.222 screenresolution[1631:7593] Display 0: 1600x1200x32@60 08:50:04 INFO - 2017-03-18 08:50:04.228 screenresolution[1632:7595] starting screenresolution argv=screenresolution list 08:50:04 INFO - Available Modes on Display 0 08:50:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:04 INFO - Intel Iris: 08:50:04 INFO - Chipset Model: Intel Iris 08:50:04 INFO - Type: GPU 08:50:04 INFO - Bus: Built-In 08:50:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:04 INFO - Vendor: Intel (0x8086) 08:50:04 INFO - Device ID: 0x0a2e 08:50:04 INFO - Revision ID: 0x0009 08:50:04 INFO - Displays: 08:50:04 INFO - Display: 08:50:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:04 INFO - Display Serial Number: 1600x1200 60 08:50:04 INFO - Main Display: Yes 08:50:04 INFO - Mirror: Off 08:50:04 INFO - Online: Yes 08:50:04 INFO - Rotation: Supported 08:50:04 INFO - Return code: 0 08:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:04 INFO - Python 2.7.3 08:50:04 INFO - Return code: 0 08:50:04 INFO - grabbing minidump binary from tooltool 08:50: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')]} 08:50: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 0x105554d30>, '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 0x10547bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50: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 08:50: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 08:50: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 08:50:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:04 INFO - Return code: 0 08:50:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:04 INFO - ENV: RUST_BACKTRACE is now 1 08:50:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50: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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:50: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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RzS6BJwXkw/Render', 08:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:04 INFO - 'HOME': '/Users/cltbld', 08:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:04 INFO - 'LOGNAME': 'cltbld', 08:50:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:04 INFO - 'MOZ_NO_REMOTE': '1', 08:50:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:04 INFO - 'NO_EM_RESTART': '1', 08:50:04 INFO - 'PAGER': '/bin/cat', 08:50:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:04 INFO - 'PWD': '/builds/slave/test', 08:50:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:04 INFO - 'RUST_BACKTRACE': '1', 08:50:04 INFO - 'SHELL': '/bin/bash', 08:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqbQ1XlrKp/Listeners', 08:50:04 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:04 INFO - 'USER': 'cltbld', 08:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:04 INFO - 'XPC_FLAGS': '0x0', 08:50:04 INFO - 'XPC_SERVICE_NAME': '0', 08:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50: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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:50:04 INFO - mozversion application_buildid: 20170318080120 08:50:04 INFO - mozversion application_changeset: 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 08:50:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:50:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:04 INFO - mozversion application_name: Firefox 08:50:04 INFO - mozversion application_remotingname: firefox-dev 08:50:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:04 INFO - mozversion application_vendor: Mozilla 08:50:04 INFO - mozversion application_version: 54.0a2 08:50:04 INFO - mozversion platform_buildid: 20170318080120 08:50:04 INFO - mozversion platform_changeset: 9df61b09aa1ce0b26486bb30c6ca63e89ac06100 08:50:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:04 INFO - mozversion platform_version: 54.0a2 08:50:04 INFO - using testdate: 1489852204 08:50:04 INFO - actual date: 1489852204 08:50:04 INFO - starting webserver on 'localhost:49241' 08:50:04 INFO - SUITE-START | Running 2 tests 08:50:04 INFO - TEST-START | dromaeo_css 08:50:04 INFO - operating with platform_type : mac_ 08:50:04 INFO - Initialising browser for dromaeo_css test... 08:50:04 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmprvoROH/profile http://localhost:49241/getInfo.html) 08:50:07 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 08:50:07 INFO - PROCESS | 1642 | colorDepth:24 08:50:07 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 08:50:07 INFO - PROCESS | 1642 | __metrics 08:50:07 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:50:07 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:08 INFO - TEST-INFO | 1642: exit 0 08:50:08 INFO - Browser initialized. 08:50:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:08 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmprvoROH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:20 INFO - PROCESS | 1644 | RSS: Main: 227889152 08:50:20 INFO - PROCESS | 1644 | 08:53:24 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:53:27 INFO - PROCESS | 1644 | RSS: Main: 440946688 08:53:27 INFO - PROCESS | 1644 | 08:55:10 INFO - PROCESS | 1644 | ************************* 08:55:10 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 08:55:10 INFO - PROCESS | 1644 | 08:55:10 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:10 INFO - PROCESS | 1644 | Full stack: 08:55:10 INFO - PROCESS | 1644 | ************************* 08:56:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:56:30 INFO - PROCESS | 1644 | RSS: Main: 362332160 08:56:30 INFO - PROCESS | 1644 | 08:59:33 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:59:34 INFO - PROCESS | 1644 | RSS: Main: 343392256 08:59:34 INFO - PROCESS | 1644 | 09:02:36 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:02:37 INFO - PROCESS | 1644 | RSS: Main: 330817536 09:02:37 INFO - PROCESS | 1644 | 09:05:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:05:41 INFO - PROCESS | 1644 | RSS: Main: 330919936 09:05:41 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:08:45 INFO - PROCESS | 1644 | RSS: Main: 538124288 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | __start_tp_report 09:08:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 09:08:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 09:08:45 INFO - PROCESS | 1644 | |i|pagename|runs| 09:08:45 INFO - PROCESS | 1644 | |0;dojo.html;3153.6057992750902;3403.3023230237786;3417.794932304062;3421.1960189355514;3437.948430773539;4982.676126051813;5997.850053748659;6021.45806877381;6043.879122417549;6047.213862197919;6020.698965051752;6112.969435152818;6113.847153821145;6114.082887566868;6120.296165940918;5388.973055134728;5410.675359478424;5435.918461223085;5488.231647569323;5507.889842203153;5310.62825602208;5313.442088580701;5508.4491550845;5563.554915606742;5579.888402231953;5344.4922732340365;5438.8912221755545;5453.427390124039;5504.504594586487;5540.612157149001;5481.150421684625;5504.256925315111;5510.91733623996;5513.972430137864;5527.889442211133;5362.410134885159;5426.050441172819;5454.400015998237;5464.9180262296095;5481.972590137024;5816.709164541799;5861.941380586182;5868.383819698955;5885.440883116097;5911.733971971272;6274.0902569127675;6275.780347687809;6287;6295;6311.589746666452;5928.525717942597;6307.716152773136;6395.904061439082;6418.358164183591;6418.582792118497;5146.614003949681;6079.331273559905;6172.88245086593;6212.658303793244;6226.5641405101205;5100.974495127575;5166.811633324356;6635.900461493082;6669.699863506154;6669.866602667919;6105.709757709155;6127.264728232641;6166.537509686791;6234.9688251558455;6382.393672601095;6054.636721796706;6463.353664633593;6477.805665830033;6481.027845823164;6503.187101612299;5851.444112809277;6409.198850143732;6426.196725409324;6429.903551446732;6431.324710905381;6179.81460556184;6280.905786413207;6284.937150628527;6351.4283714465;6419.261784894704;5179.145441002268;5190.844274671766;5192.273081768555;5192.532672059533;5212.504812042926;4604.424446944132;4631.3516107744945;4634.58288754007;4636.327732478771;4660.953390466119;5916.556258280646;5924.7926322578505;5959.67221802805;6137.877242455126;6148.44663980235;6313.779017734358;6322.178116844781;6327.114204011442;6329.303776584572;6335.334789847;5979.312379076462;6020;6027.095935609694;6038.667873266924;6045.546584006217;5599.664020158803;5619.634723742944;5637.154426835926;5637.46444087811;5639.407862174413;6461.676916154268;6473.579217350857;6480.416762491398;6560.114384558024;6567.605943643397;6488.545801794018;6501.08984742127;6504.089427480251;6508.707108180238;6514.348565143638;6666.100076489805;6676.165479315086;6692.6988285526295;6693.364130407604;6710.396064354231;6168.629882207082;6283.183186185766;6379.649119298483;6393.680315984275;6398.264199617103;6271.905921411091;6274.090256912813;6278.309385967631;6304.085907543472;6399.424051835357;6278.937210627835;6296.6851657417865;6297.622142671455;6302.527310451643;6350.396712312323;5311.893762124813;6289.654069026247;6314.179156709598;6323.272823625342;6333.714982825876;6123.050927106306;6125.908111378244;6268.811935641938;6269.529785266032;6285.654289014148;6145.955187618027;6215.502759779117;6222.439980401605;6265.216847894013;6300.905486417799;6161.383861613803;6209.875802484015;6226.40849119333;6230.657313847782;6244.094606282155 09:08:45 INFO - PROCESS | 1644 | |1;ext.html;788.5387048576582;808.7250334886139;875.2604049578105;895.1719659315132;897.8922529296482;39706.40440393393;40443.98890027751;42456.57543424565;42464.15071698572;42645.573544264545;42028.579714202846;42105.73682789513;42201.15597688044;42209.36685949706;42214;7414.925850741504;7581.090269167707;9208.447493150416;9382.624695012191;9383.296252781034;7420.591867447289;7501.362384197322;7502.849943001137;11081;11357.204995650307;10129.290949633529;10778.784424311509;11266.830997535044;11305.773884522305;11383.601573944914;11183.496742646601;11225.607103751412;11254.324740515513;11266.549338026469;11271.098312135091;7321.633918304064;7493.66278517468;7532.359749421305;10961.506732196991;11018.724531886686;27961.720382796117;28136;39453;39949.80025099885;41631.58368416338;3824.978267168933;3867.3425517661785;3868.439076333944;3909.138407185342;3916.09929716164;27453.31366715828;27756.583651245248;28490.430191396263;29108.854455727796;29696.812127514873;3115.081051089934;3117.1116231873807;3126.2028182813237;3138.3409484008157;3188.075458117143;430538;438533.9999999968;512964;517441;517902;41401.378979315334;42331.94170145771;42394.57605423968;42584.78707606504;42607.78696106562;36012.279754404764;36715.26569468596;37893;43207.35188972105;43294;12249;12322.507099716091;13335.73328533424;13569.321533923265;13796.241206733726;11841.467133978991;11844.822327665092;11858.881411185777;11860.822087668692;11863.288202707865;11001.669949901516;11035.006849383593;11092.889071109346;11150.944245278723;11214.046806021417;5222.503862133091;5230.92153617696;5262.710550919736;5276.314079169683;5286.709230992333;1144.5822274869613;1152.8904754048351;1159.0322081062407;1167.871534131245;1225.4240506961714;26793.19620411391;26820.731792682214;27226.863865680545;27359.905603775627;27516.862415688192;1056.5087234436023;1250.3873102179866;1259.8551166615773;1311.1543054729646;1314.9408276627576;13751.449942002408;13776.448942042407;13821.723565528835;14053.859461405254;14113.506027288995;456789;456994;459321;459591;460819.69590151834;57197;57582;57590.560235993595;57693.71153144291;57729.13406298909;1436.8706816386366;1479.6670749081802;1495.9102453852804;1497.0792962328308;1499.6700725840299;24624.384390390383;25082.122125725513;26504.204873853814;26570.202893913214;26607.20178394651;42614;42659;42711;42712.572874272104;42781.716548503595;484050;493134;493996;503173;585026;31501.8424907874;31539.684603154594;31652.36695266128;31659.84170079135;31677;39751;42135;42840.57159428366;42858.357124642534;43570;29074.418511629225;34763.304733904675;35017.824910875286;35378.823105885334;35946.64053359433;33350.499742503394;35211.64788352186;36171.63828361683;36655.45016824803;37002.44496332611;30776.846115769276;35633.82183089068;36281.63718362888;36285.45571816372;36491.45262821007;29832;31017.8449107753;31200.375992480476;31249.218769530944;31297.530537042418;23065.423364416023;23756.762432375453;23852.880735596213;24240.393990150387;24309.635355470036 09:08:45 INFO - PROCESS | 1644 | |2;jquery.html;381.15003542101095;427.69206171556476;428.9359420553499;433.2137171034572;440.7399634215812;15542.222888855555;20646.38060858173;22280.108795648193;22359.77640223599;22514.43713907149;20179.394618161477;21168.364949051516;21280.574388512257;21810.563788724216;21846.344609661697;6538.934610653892;6682.064510968468;6752.696128674197;7257.927420725804;7570.242975702441;4080.9387859182134;7614.923850761477;7660.310572048515;7670.117936437326;7671.501352412075;4176.561461046576;7247.528910620793;7599.278068583503;7745.186755390688;7753.689852405925;7465.216152303984;7588.886166707503;7677;7687.2697093776005;7700.653470593808;7204.603746793924;7376.889346659805;7453.6273186341;7458.664360103754;7461.589612571306;24589.754102458926;25632.231033069038;26035.869820650965;26277.211683649522;26697.46605067907;3251.235959549504;3256.430124728187;3385.1875549867855;3387.6951074403423;3396.9660303396895;15470;15497.302621382065;15499.612509687235;15572.532824015185;16126.467985541354;1857.8885266883894;2014.3352693611073;2016.1129103194548;2071.6685330347223;2073.150008496524;140596.29701851527;144933.99999999895;156866;157806;159797;14502.694757471878;17110.326972480743;17816.020118893586;18864.528386790167;19502.122404491547;21112.894435528033;24561.631575526382;27215;29897.551536726965;31177;9810.117089461983;10162.745931351776;10226.335288206243;10289.53697083633;10434.321769084985;7314.451416143704;8346.374021948379;8553.700620478254;8557.48655080697;8711.39020268575;7883.172266912006;9103.453792772454;9117.353058776409;9188.173064424234;9272.953635231781;3607.7474576779373;3789.5452545694693;3797.7911214883447;3807.828647710804;3822.808859557011;959.9712008639752;971.5725080964353;986.3736527305213;987.5852142100191;1010.7927874785652;20858.47853803667;20868.89565552193;20928.686069708965;20957.161713531288;20979.895100524704;975.1564896364594;985.4973963278779;996.6163027234567;1000.1298869983016;1003.242551873331;10240.436775977243;10692.679219623424;10710.839337409945;10779.191560632984;10805.783884322269;687879;716967;752834;764529;793892;139374;153128;161533.19233403992;163358;167529.16235418746;1165.3765235598914;1170.455738081796;1203.0315595945349;1203.9036877049814;1209.1535924852815;17655;18411.81588184101;18419.447416577525;18420.631587368447;18464.907675461538;37801;61597.69201153966;66042.34894127493;66199.66900165468;66453;88338.116618833;88608.5569572148;89013.55493222493;89715;90313.54843225742;10948.288361256493;11449.313041217554;11658.358790266617;11796.233244839059;11910.464029118537;12882.871171288542;12912.612621621367;13262.668433289246;13314;13333.266670333225;10978.725531861768;11216.943915280372;11330.206885517935;11404.315741055563;11487.19589628718;9968.750781230527;10195.082442580204;10292.948535257276;10312.896871031193;10624.256302058782;11378.772424551627;11594.594189203337;11744.060475162138;11785.292882427082;11902.047836173258;11473;11496.310221386744;11761;11791.29252244868;11861.940690296493;11009.779804404026;11051.115910726961;11289.37908415045;11303.434828258718;11357.54569817198 09:08:45 INFO - PROCESS | 1644 | |3;mootools.html;1520.7642815363608;1534.8718691761553;1565.0296815974098;1573.874090072794;1578.1793467396953;10502.212334074946;11096.334219946808;11100.833487497694;11104.777904441906;11136.443177841096;10486.213533984943;10904.291221070625;11023.61417350393;11041.944790276037;11043.447827608628;2361.929142125735;2393.1743548475833;2397.724261709908;2399.2442380650127;2402.615581506959;1156.9016633586155;2346.425125844162;2373.264288070695;2382.0352757133387;2386.4153282445827;1665.883388162829;2248.8875556222206;2270.489139943508;2277.6128058230056;2279.680844681746;1951.443838506019;2182.854001649131;2328.906843726249;2330.1960823515947;2337.2403968710237;2304.412374844404;2364.2198074635503;2366.6568347589505;2367.857928524294;2370.7036620422446;10926;11053.502592383362;11060.557577696882;11067.944660276728;11140.888591114148;5037.168867136918;5669.489745922887;5870.11948207768;5871.14868344092;5875.1187321901625;3251.1709514073996;3438.9312213755584;3638.3632864248916;3639.836207370675;3643.8542458301636;1129.9661010169707;1147;1183.3255044624568;1191.7318603314272;1221.258275172244;11969.94015029928;13540.390682419216;13955.58133256004;15189.544313670496;15243.16162611056;3560.964390356115;4155.812988415529;4268.679849011337;4273.786310684453;4473.932891006638;9359.672411465566;11003.449827508593;11042.227044106836;11049.33703977764;11070.501827417786;5601.663900165921;5602.523785478198;5609.495145436848;5615.578831587565;5620.353659329147;4829.058333624909;4950.455449900508;5200.531952124327;5208.609354298367;5215.035218484592;3677.963220367762;3771.641694039062;3812.3328417526823;3846;3867.2458870519977;1000.8448690452991;1005.7636455432968;1011.8785745710414;1018.0379541333517;1018.6485662446444;761.7638532055081;772.7140957845633;797.4537441852234;803.2008151888908;804.3042768005633;6246.562740608114;6270;6350.777722779773;6383.872322553523;6419.646919419477;943.2548286853446;949.2453499467939;969.3892847506027;979.3976704326788;987.2821290953689;3926.842926282917;3942.586028467027;3958;4058.431819545266;4058.5332686740812;13095.541656041993;13587.048906576643;13591.388387522586;13604.591862244148;13627.25050122233;12974;13190.340482975813;13533.796993045113;13541.796873046913;13558.11872228302;8289.544075075928;9835;9930.453825039547;10072.345297555781;10096.39421634719;6215.06773983906;6241.563090583615;6318.747250109944;6335.334789847;6420.6789660517725;11822.231554948901;12080.697982550155;12160.270383777002;12174.086943479097;12189.024878009915;11184.94407527957;11337.659870203906;11592.188546801643;12277.877221227673;12455.252684838939;7900.525968441912;7996.160403157817;8039.557824319485;8042;8128.349732021542;10117.19062475015;10202;10332.91504392028;10336.12142967826;10336.948315258376;9134.817303654023;9179.908200917906;9189.310801690033;9291.907080929104;9409.529523523934;8586.441881277948;8593.269572086443;8768.430052046597;8824.294056475339;8984.146506081912;7147.2852714728115;7418.851622967619;7758.61206939662;7883.605819708877;7890.092639346549;5779.7110144493445;5789.768409263751;5851.64890106578;5922.437368449991;5939.07944268639;4771.5467030632035;5632.042552766122;5632.464915832989;5634.380218176079;5729.169270455844 09:08:45 INFO - PROCESS | 1644 | |4;prototype.html;375.4499658001028;377.94897688812034;378.5400738103204;387.4227401172253;388.097672910483;5094.580074464632;5134.332536770224;5163.192882491131;5173.465002148948;5184.818531351403;4059.6955228357842;4485.035717320784;4527.864164075075;4635.351050852883;5093.312402825627;3238.6437491875877;3301.5873015873017;3356.5636467259224;3386.560711697531;3998.9800050999706;3493.7729047611824;3881.4760007398922;4018.97990510047;4022.3363145081025;4065.105676751125;3425.2293234022272;3855.9203423041595;3943.842246310144;4019.673507742438;4058.6516124197506;3884.941725874114;3897.5128108986237;3983.960160398388;3989.840406383741;4008.5347511280643;3124.7343975762087;3344.063662174595;3363.2432702641954;3575.302815950891;3578.8568457261676;4693.906121877578;4720.881977950545;4880.902381952341;4975;5041.2355675513645;4030.996907304048;4238.597333253367;4243.639290660298;4247.341662042358;4426.955730442686;4604.3784089147875;4879.487653796371;5099.847004589868;5365.436629153922;5383.496674046548;3542.574891013069;3655.323765103438;3930.567637559866;3982.3030969580495;4041.312976793952;4593.554833874594;5181.4300426953005;5530.976769297693;5656.349519805234;5925.08161235005;3465.913352166216;4045.7977101144825;4147.709660323809;4588.151192029485;4806.866095158161;4915.255084444971;4928.236123400879;4932.396970984372;4937.481564435682;4954.950450495449;4223.809928553223;4505.81976720934;5120.692758434506;5161.664491808096;5211.661242019257;5000.299958005882;5261.263423120766;5384.6769193848495;5574.777008919679;5619.550435965113;1498.3107770425509;1603.006136195543;1640.917954102314;1681.8065922419078;1694.1533728236282;1168.4975460552043;1254.4731212890608;1299.4347601171253;1363.9727205456034;1367.3710093356967;4491.708038977456;4774.427068751772;4983.377077865267;5130.7178105204575;5151.304573882478;5035.949640503622;5280.339957505312;5710.65736055838;5711.685857277889;5725.5133313667975;4500.572445617727;4518.864434066983;5120.769565369567;5126.333576635088;5142.897142057138;2947.204254851178;2973.3012742005612;2974.4384198296066;2988.6999155367484;2991.880324786984;5196.064708352457;5442.00689620707;5867.650440398732;5909.409059094142;5914.610066634424;5155.757245598177;5251.6061295403;5312.814051508179;5415.756290966916;5812.244408226903;4772.821488684746;4794.400699912511;5101.566366858859;5652.982463156589;5754.338251101093;3867.911327882912;4710.8351207707565;4724.503927087606;5127.359409903977;5753.884922301614;5369.248305237192;5598.472962033892;5627.774889004394;5631.521320687787;5632.5493960482245;5350.464953504618;5573.637713548606;5689.459501347365;5842.474177324061;5860.743613708668;4580.954190458053;4789.521047895182;4830.4444988826735;4846.5638092571835;4876.536729010881;4853;5133.897322053613;5151.922721159111;5745.454181852718;5747.683877386617;4775.403074615673;5009.874753131201;5346.3535549903045;5429.809956651498;5528.369131106414;5336.67979921206;5498.80754173602;5507.5680323115475;5515.944840551543;5531.557475401878;4752.405949256343;4906.386701662293;4980.088398757245;5090;5272.920906186334;4688.859334219979;5130.460422091089;5131.358580177478;5401.972990135024;5483.561315094703;5015.673981191211;5186.066508028591;5328.733563321896;5422.728863556886;5431.632387919515 09:08:45 INFO - PROCESS | 1644 | |5;yui.html;687.2817905288972;720.945929055321;738.5088915870942;822.6668199379252;845.4251109245714;15282.159481228528;16140.677186456263;16145.677086458278;16159.353625854952;16161.353545858181;14180.50368237112;14188.006839521238;14189.503367382144;14191.148531088116;14204.218767967757;898.716904175186;924.3714274293478;940.8165407745493;952.4856577448204;956.0726095687172;951.5813042261417;952.3999880075577;953.752024473635;953.752024473635;959.740869965109;1000.2348203624233;1001.8897921228659;1001.9098281154695;1003.1723827842023;1004.0311099788703;996.0736515041009;998.3510718033264;998.6804222648719;999.7250756042074;1001.6293971230618;734.0787311923502;734.6216698400328;734.8199691075721;734.9522281051715;735.2720806401677;15772.369105235777;16040.278187481592;16059.116748578823;16180.919095404566;16483.258253378626;14040.85959140416;14069.577912662637;14132.646683832883;14227;14231;11477.827832582434;11660.475278612483;11675.474603642857;11793.528258869635;12224.580052753714;3612.422012477991;3666.1018050577513;3693.9630603693886;3738.2336620992633;3811.0472381904524;117531;118631.4068429661;119102;120182;122227.55544889142;9940.304178707422;10057.346272492265;10081.747956301004;10109.241806864515;10165.898341016644;20264.392068237976;20341.79658203399;20604;20636.79363206379;20654.07056682453;6323.27282362525;6396.712147953353;7505.737299194502;7876.763697089096;7944.642491087915;4276.2516559601945;4373.475182978063;4441.600255976913;4450.5104438511735;4527.222906159383;3470.722342212617;3476.756627036083;3538.57537095545;3595.173110184672;3639.3631114554846;624.4754406298731;642.9389208025231;650.5868773328971;651.7360469010058;656.9967150164218;674.2818897873749;674.4016680467324;694.7915625312386;707.8938159276149;714.9418860087101;8656.740297791077;9971.30200885931;10370.637027703995;10426.374417534973;10522.789544209072;655.3970347280514;660.6168422315046;678.2166597579704;693.434850596762;701.5439964023426;5006.974965125224;5040.823571175065;5054.1407960646775;5073.315102461194;5078.13671675816;93360.53319733359;94218;95929;98604;109716.90283097226;65340.67329663321;69950;77032.61483692657;77428.22571774323;86931.56534217288;64651.35348646547;69862.3013769866;74192.88710669453;75069;77308.61345693236;11054.889451105386;11063.502142403771;11134.3876086816;11252.943735281271;11327.546898123983;48500.02248841779;48879.75560122319;50139.49860501348;51159.2326115116;54765;52911;53164.46835531595;56127.71936140293;61133.94330283379;62998;12409.689757755767;12566.937165314115;12651.304178270284;12810.615681529569;13124.540641077516;14237.572872813833;14347.713045739236;14484.493042743454;14997.850021499646;15152.469663561722;13275.66810829737;13666.09620652333;14839.629009274855;14857.18285494265;15299;13872;14581.635459113608;14709.190994494977;14800.333984970917;15377.69244615079;13508.324583770576;13981.930090349482;14475.710485790436;14931.552053438414;15302.923485382502;10959.616413425492;11390.601328953448;11443.256188348063;11484.655460336204;11698.590549330733;10077.294589378673;11009;11145.387003714874;11269.887301126884;11725.41372931367 09:08:45 INFO - PROCESS | 1644 | __end_tp_report 09:08:45 INFO - PROCESS | 1644 | __start_cc_report 09:08:45 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2477 09:08:45 INFO - PROCESS | 1644 | __end_cc_report 09:08:45 INFO - PROCESS | 1644 | __startTimestamp1489853325294__endTimestamp 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | ------- Summary: start ------- 09:08:45 INFO - PROCESS | 1644 | Number of tests: 6 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5924.02 Median:6148.45 stddev:660.01 (10.7%) stddev-sans-first:625.23 09:08:45 INFO - PROCESS | 1644 | Values: 3153.6 3403.3 3417.8 3421.2 3437.9 4982.7 5997.9 6021.5 6043.9 6047.2 6020.7 6113.0 6113.8 6114.1 6120.3 5389.0 5410.7 5435.9 5488.2 5507.9 5310.6 5313.4 5508.4 5563.6 5579.9 5344.5 5438.9 5453.4 5504.5 5540.6 5481.2 5504.3 5510.9 5514.0 5527.9 5362.4 5426.1 5454.4 5464.9 5482.0 5816.7 5861.9 5868.4 5885.4 5911.7 6274.1 6275.8 6287.0 6295.0 6311.6 5928.5 6307.7 6395.9 6418.4 6418.6 5146.6 6079.3 6172.9 6212.7 6226.6 5101.0 5166.8 6635.9 6669.7 6669.9 6105.7 6127.3 6166.5 6235.0 6382.4 6054.6 6463.4 6477.8 6481.0 6503.2 5851.4 6409.2 6426.2 6429.9 6431.3 6179.8 6280.9 6284.9 6351.4 6419.3 5179.1 5190.8 5192.3 5192.5 5212.5 4604.4 4631.4 4634.6 4636.3 4661.0 5916.6 5924.8 5959.7 6137.9 6148.4 6313.8 6322.2 6327.1 6329.3 6335.3 5979.3 6020.0 6027.1 6038.7 6045.5 5599.7 5619.6 5637.2 5637.5 5639.4 6461.7 6473.6 6480.4 6560.1 6567.6 6488.5 6501.1 6504.1 6508.7 6514.3 6666.1 6676.2 6692.7 6693.4 6710.4 6168.6 6283.2 6379.6 6393.7 6398.3 6271.9 6274.1 6278.3 6304.1 6399.4 6278.9 6296.7 6297.6 6302.5 6350.4 5311.9 6289.7 6314.2 6323.3 6333.7 6123.1 6125.9 6268.8 6269.5 6285.7 6146.0 6215.5 6222.4 6265.2 6300.9 6161.4 6209.9 6226.4 6230.7 6244.1 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:60711.68 Median:35114.74 stddev:129580.94 (369.0%) stddev-sans-first:129866.34 09:08:45 INFO - PROCESS | 1644 | Values: 788.5 808.7 875.3 895.2 897.9 39706.4 40444.0 42456.6 42464.2 42645.6 42028.6 42105.7 42201.2 42209.4 42214.0 7414.9 7581.1 9208.4 9382.6 9383.3 7420.6 7501.4 7502.8 11081.0 11357.2 10129.3 10778.8 11266.8 11305.8 11383.6 11183.5 11225.6 11254.3 11266.5 11271.1 7321.6 7493.7 7532.4 10961.5 11018.7 27961.7 28136.0 39453.0 39949.8 41631.6 3825.0 3867.3 3868.4 3909.1 3916.1 27453.3 27756.6 28490.4 29108.9 29696.8 3115.1 3117.1 3126.2 3138.3 3188.1 430538.0 438534.0 512964.0 517441.0 517902.0 41401.4 42331.9 42394.6 42584.8 42607.8 36012.3 36715.3 37893.0 43207.4 43294.0 12249.0 12322.5 13335.7 13569.3 13796.2 11841.5 11844.8 11858.9 11860.8 11863.3 11001.7 11035.0 11092.9 11150.9 11214.0 5222.5 5230.9 5262.7 5276.3 5286.7 1144.6 1152.9 1159.0 1167.9 1225.4 26793.2 26820.7 27226.9 27359.9 27516.9 1056.5 1250.4 1259.9 1311.2 1314.9 13751.4 13776.4 13821.7 14053.9 14113.5 456789.0 456994.0 459321.0 459591.0 460819.7 57197.0 57582.0 57590.6 57693.7 57729.1 1436.9 1479.7 1495.9 1497.1 1499.7 24624.4 25082.1 26504.2 26570.2 26607.2 42614.0 42659.0 42711.0 42712.6 42781.7 484050.0 493134.0 493996.0 503173.0 585026.0 31501.8 31539.7 31652.4 31659.8 31677.0 39751.0 42135.0 42840.6 42858.4 43570.0 29074.4 34763.3 35017.8 35378.8 35946.6 33350.5 35211.6 36171.6 36655.5 37002.4 30776.8 35633.8 36281.6 36285.5 36491.5 29832.0 31017.8 31200.4 31249.2 31297.5 23065.4 23756.8 23852.9 24240.4 24309.6 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:42648.38 Median:21224.47 stddev:124288.08 (585.6%) stddev-sans-first:124596.22 09:08:45 INFO - PROCESS | 1644 | Values: 381.2 427.7 428.9 433.2 440.7 15542.2 20646.4 22280.1 22359.8 22514.4 20179.4 21168.4 21280.6 21810.6 21846.3 6538.9 6682.1 6752.7 7257.9 7570.2 4080.9 7614.9 7660.3 7670.1 7671.5 4176.6 7247.5 7599.3 7745.2 7753.7 7465.2 7588.9 7677.0 7687.3 7700.7 7204.6 7376.9 7453.6 7458.7 7461.6 24589.8 25632.2 26035.9 26277.2 26697.5 3251.2 3256.4 3385.2 3387.7 3397.0 15470.0 15497.3 15499.6 15572.5 16126.5 1857.9 2014.3 2016.1 2071.7 2073.2 140596.3 144934.0 156866.0 157806.0 159797.0 14502.7 17110.3 17816.0 18864.5 19502.1 21112.9 24561.6 27215.0 29897.6 31177.0 9810.1 10162.7 10226.3 10289.5 10434.3 7314.5 8346.4 8553.7 8557.5 8711.4 7883.2 9103.5 9117.4 9188.2 9273.0 3607.7 3789.5 3797.8 3807.8 3822.8 960.0 971.6 986.4 987.6 1010.8 20858.5 20868.9 20928.7 20957.2 20979.9 975.2 985.5 996.6 1000.1 1003.2 10240.4 10692.7 10710.8 10779.2 10805.8 687879.0 716967.0 752834.0 764529.0 793892.0 139374.0 153128.0 161533.2 163358.0 167529.2 1165.4 1170.5 1203.0 1203.9 1209.2 17655.0 18411.8 18419.4 18420.6 18464.9 37801.0 61597.7 66042.3 66199.7 66453.0 88338.1 88608.6 89013.6 89715.0 90313.5 10948.3 11449.3 11658.4 11796.2 11910.5 12882.9 12912.6 13262.7 13314.0 13333.3 10978.7 11216.9 11330.2 11404.3 11487.2 9968.8 10195.1 10292.9 10312.9 10624.3 11378.8 11594.6 11744.1 11785.3 11902.0 11473.0 11496.3 11761.0 11791.3 11861.9 11009.8 11051.1 11289.4 11303.4 11357.5 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6511.38 Median:2826.89 stddev:4102.11 (145.1%) stddev-sans-first:4096.48 09:08:45 INFO - PROCESS | 1644 | Values: 1520.8 1534.9 1565.0 1573.9 1578.2 10502.2 11096.3 11100.8 11104.8 11136.4 10486.2 10904.3 11023.6 11041.9 11043.4 2361.9 2393.2 2397.7 2399.2 2402.6 1156.9 2346.4 2373.3 2382.0 2386.4 1665.9 2248.9 2270.5 2277.6 2279.7 1951.4 2182.9 2328.9 2330.2 2337.2 2304.4 2364.2 2366.7 2367.9 2370.7 10926.0 11053.5 11060.6 11067.9 11140.9 5037.2 5669.5 5870.1 5871.1 5875.1 3251.2 3438.9 3638.4 3639.8 3643.9 1130.0 1147.0 1183.3 1191.7 1221.3 11969.9 13540.4 13955.6 15189.5 15243.2 3561.0 4155.8 4268.7 4273.8 4473.9 9359.7 11003.4 11042.2 11049.3 11070.5 5601.7 5602.5 5609.5 5615.6 5620.4 4829.1 4950.5 5200.5 5208.6 5215.0 3678.0 3771.6 3812.3 3846.0 3867.2 1000.8 1005.8 1011.9 1018.0 1018.6 761.8 772.7 797.5 803.2 804.3 6246.6 6270.0 6350.8 6383.9 6419.6 943.3 949.2 969.4 979.4 987.3 3926.8 3942.6 3958.0 4058.4 4058.5 13095.5 13587.0 13591.4 13604.6 13627.3 12974.0 13190.3 13533.8 13541.8 13558.1 8289.5 9835.0 9930.5 10072.3 10096.4 6215.1 6241.6 6318.7 6335.3 6420.7 11822.2 12080.7 12160.3 12174.1 12189.0 11184.9 11337.7 11592.2 12277.9 12455.3 7900.5 7996.2 8039.6 8042.0 8128.3 10117.2 10202.0 10332.9 10336.1 10336.9 9134.8 9179.9 9189.3 9291.9 9409.5 8586.4 8593.3 8768.4 8824.3 8984.1 7147.3 7418.9 7758.6 7883.6 7890.1 5779.7 5789.8 5851.6 5922.4 5939.1 4771.5 5632.0 5632.5 5634.4 5729.2 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4476.46 Median:4910.82 stddev:1262.84 (25.7%) stddev-sans-first:1228.29 09:08:45 INFO - PROCESS | 1644 | Values: 375.4 377.9 378.5 387.4 388.1 5094.6 5134.3 5163.2 5173.5 5184.8 4059.7 4485.0 4527.9 4635.4 5093.3 3238.6 3301.6 3356.6 3386.6 3999.0 3493.8 3881.5 4019.0 4022.3 4065.1 3425.2 3855.9 3943.8 4019.7 4058.7 3884.9 3897.5 3984.0 3989.8 4008.5 3124.7 3344.1 3363.2 3575.3 3578.9 4693.9 4720.9 4880.9 4975.0 5041.2 4031.0 4238.6 4243.6 4247.3 4427.0 4604.4 4879.5 5099.8 5365.4 5383.5 3542.6 3655.3 3930.6 3982.3 4041.3 4593.6 5181.4 5531.0 5656.3 5925.1 3465.9 4045.8 4147.7 4588.2 4806.9 4915.3 4928.2 4932.4 4937.5 4955.0 4223.8 4505.8 5120.7 5161.7 5211.7 5000.3 5261.3 5384.7 5574.8 5619.6 1498.3 1603.0 1640.9 1681.8 1694.2 1168.5 1254.5 1299.4 1364.0 1367.4 4491.7 4774.4 4983.4 5130.7 5151.3 5035.9 5280.3 5710.7 5711.7 5725.5 4500.6 4518.9 5120.8 5126.3 5142.9 2947.2 2973.3 2974.4 2988.7 2991.9 5196.1 5442.0 5867.7 5909.4 5914.6 5155.8 5251.6 5312.8 5415.8 5812.2 4772.8 4794.4 5101.6 5653.0 5754.3 3867.9 4710.8 4724.5 5127.4 5753.9 5369.2 5598.5 5627.8 5631.5 5632.5 5350.5 5573.6 5689.5 5842.5 5860.7 4581.0 4789.5 4830.4 4846.6 4876.5 4853.0 5133.9 5151.9 5745.5 5747.7 4775.4 5009.9 5346.4 5429.8 5528.4 5336.7 5498.8 5507.6 5515.9 5531.6 4752.4 4906.4 4980.1 5090.0 5272.9 4688.9 5130.5 5131.4 5402.0 5483.6 5015.7 5186.1 5328.7 5422.7 5431.6 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20053.86 Median:3507.67 stddev:28731.35 (819.1%) stddev-sans-first:28775.15 09:08:45 INFO - PROCESS | 1644 | Values: 687.3 720.9 738.5 822.7 845.4 15282.2 16140.7 16145.7 16159.4 16161.4 14180.5 14188.0 14189.5 14191.1 14204.2 898.7 924.4 940.8 952.5 956.1 951.6 952.4 953.8 953.8 959.7 1000.2 1001.9 1001.9 1003.2 1004.0 996.1 998.4 998.7 999.7 1001.6 734.1 734.6 734.8 735.0 735.3 15772.4 16040.3 16059.1 16180.9 16483.3 14040.9 14069.6 14132.6 14227.0 14231.0 11477.8 11660.5 11675.5 11793.5 12224.6 3612.4 3666.1 3694.0 3738.2 3811.0 117531.0 118631.4 119102.0 120182.0 122227.6 9940.3 10057.3 10081.7 10109.2 10165.9 20264.4 20341.8 20604.0 20636.8 20654.1 6323.3 6396.7 7505.7 7876.8 7944.6 4276.3 4373.5 4441.6 4450.5 4527.2 3470.7 3476.8 3538.6 3595.2 3639.4 624.5 642.9 650.6 651.7 657.0 674.3 674.4 694.8 707.9 714.9 8656.7 9971.3 10370.6 10426.4 10522.8 655.4 660.6 678.2 693.4 701.5 5007.0 5040.8 5054.1 5073.3 5078.1 93360.5 94218.0 95929.0 98604.0 109716.9 65340.7 69950.0 77032.6 77428.2 86931.6 64651.4 69862.3 74192.9 75069.0 77308.6 11054.9 11063.5 11134.4 11252.9 11327.5 48500.0 48879.8 50139.5 51159.2 54765.0 52911.0 53164.5 56127.7 61133.9 62998.0 12409.7 12566.9 12651.3 12810.6 13124.5 14237.6 14347.7 14484.5 14997.9 15152.5 13275.7 13666.1 14839.6 14857.2 15299.0 13872.0 14581.6 14709.2 14800.3 15377.7 13508.3 13981.9 14475.7 14931.6 15302.9 10959.6 11390.6 11443.3 11484.7 11698.6 10077.3 11009.0 11145.4 11269.9 11725.4 09:08:45 INFO - PROCESS | 1644 | -------- Summary: end -------- 09:08:45 INFO - PROCESS | 1644 | 09:08:45 INFO - TEST-INFO | 1644: exit 0 09:08:46 INFO - TEST-OK | dromaeo_css | took 1121195ms 09:08:46 INFO - TEST-START | kraken 09:08:46 INFO - operating with platform_type : mac_ 09:08:46 INFO - Initialising browser for kraken test... 09:08:46 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpSU_D6b/profile http://localhost:49241/getInfo.html) 09:08:48 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 09:08:48 INFO - PROCESS | 1650 | colorDepth:24 09:08:48 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 09:08:48 INFO - PROCESS | 1650 | __metrics 09:08:48 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:08:48 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:49 INFO - TEST-INFO | 1650: exit 0 09:08:49 INFO - Browser initialized. 09:08:49 INFO - Running cycle 1/1 for kraken test... 09:08:49 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpSU_D6b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:01 INFO - PROCESS | 1651 | RSS: Main: 232427520 09:09:01 INFO - PROCESS | 1651 | 09:09:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:05 INFO - PROCESS | 1651 | RSS: Main: 282554368 09:09:05 INFO - PROCESS | 1651 | 09:09:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:09:08 INFO - PROCESS | 1651 | RSS: Main: 294150144 09:09:08 INFO - PROCESS | 1651 | 09:09:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:09:12 INFO - PROCESS | 1651 | RSS: Main: 388521984 09:09:12 INFO - PROCESS | 1651 | 09:09:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:09:14 INFO - PROCESS | 1651 | RSS: Main: 292306944 09:09:14 INFO - PROCESS | 1651 | 09:09:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:17 INFO - PROCESS | 1651 | RSS: Main: 293871616 09:09:17 INFO - PROCESS | 1651 | 09:09:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:20 INFO - PROCESS | 1651 | RSS: Main: 333115392 09:09:20 INFO - PROCESS | 1651 | 09:09:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:24 INFO - PROCESS | 1651 | RSS: Main: 335208448 09:09:24 INFO - PROCESS | 1651 | 09:09:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:09:28 INFO - PROCESS | 1651 | RSS: Main: 332136448 09:09:28 INFO - PROCESS | 1651 | 09:09:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:30 INFO - PROCESS | 1651 | RSS: Main: 308211712 09:09:30 INFO - PROCESS | 1651 | 09:09:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:32 INFO - PROCESS | 1651 | RSS: Main: 310919168 09:09:32 INFO - PROCESS | 1651 | 09:09:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:35 INFO - PROCESS | 1651 | RSS: Main: 319029248 09:09:35 INFO - PROCESS | 1651 | 09:09:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:39 INFO - PROCESS | 1651 | RSS: Main: 333848576 09:09:39 INFO - PROCESS | 1651 | 09:09:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:42 INFO - PROCESS | 1651 | RSS: Main: 327471104 09:09:42 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:09:44 INFO - PROCESS | 1651 | RSS: Main: 371949568 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | __start_tp_report 09:09:44 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 09:09:44 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 09:09:44 INFO - PROCESS | 1651 | |i|pagename|runs| 09:09:44 INFO - PROCESS | 1651 | |0;ai-astar;116;116;116;114;114;121;169;177;116;115 09:09:44 INFO - PROCESS | 1651 | |1;audio-beat-detection;141;109;112;169;133;129;107;107;131;108 09:09:44 INFO - PROCESS | 1651 | |2;audio-dft;187;183;185;185;185;183;185;188;185;186 09:09:44 INFO - PROCESS | 1651 | |3;audio-fft;82;62;61;91;62;59;60;60;76;59 09:09:44 INFO - PROCESS | 1651 | |4;audio-oscillator;90;71;87;68;69;67;81;68;67;82 09:09:44 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;90;90;89;90;89;91;89;89;90 09:09:44 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;96;96;97;95;95;97;96;96;96 09:09:44 INFO - PROCESS | 1651 | |7;imaging-desaturate;87;86;82;85;84;83;83;83;83;83 09:09:44 INFO - PROCESS | 1651 | |8;json-parse-financial;66;63;64;62;67;65;65;63;64;63 09:09:44 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;54;65;55;70;62;59;57;57;59;59 09:09:44 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;87;83;86;83;86;82;86;88;86;83 09:09:44 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;136;137;138;137;134;140;142;190;144 09:09:44 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;163;171;167;166;166;173;213;145;155;198 09:09:44 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;66;63;64;64;65;64;64;64 09:09:44 INFO - PROCESS | 1651 | __end_tp_report 09:09:44 INFO - PROCESS | 1651 | __start_cc_report 09:09:44 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2174 09:09:44 INFO - PROCESS | 1651 | __end_cc_report 09:09:44 INFO - PROCESS | 1651 | __startTimestamp1489853384784__endTimestamp 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | ------- Summary: start ------- 09:09:44 INFO - PROCESS | 1651 | Number of tests: 14 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:127.40 Median:116.00 stddev:24.19 (20.8%) stddev-sans-first:25.30 09:09:44 INFO - PROCESS | 1651 | Values: 116.0 116.0 116.0 114.0 114.0 121.0 169.0 177.0 116.0 115.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:130.00 stddev:20.19 (15.5%) stddev-sans-first:20.52 09:09:44 INFO - PROCESS | 1651 | Values: 141.0 109.0 112.0 169.0 133.0 129.0 107.0 107.0 131.0 108.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.00 stddev:1.55 (0.8%) stddev-sans-first:1.50 09:09:44 INFO - PROCESS | 1651 | Values: 187.0 183.0 185.0 185.0 185.0 183.0 185.0 188.0 185.0 186.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:67.20 Median:62.00 stddev:11.52 (18.6%) stddev-sans-first:10.90 09:09:44 INFO - PROCESS | 1651 | Values: 82.0 62.0 61.0 91.0 62.0 59.0 60.0 60.0 76.0 59.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:9.02 (11.9%) stddev-sans-first:7.76 09:09:44 INFO - PROCESS | 1651 | Values: 90.0 71.0 87.0 68.0 69.0 67.0 81.0 68.0 67.0 82.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:90.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:09:44 INFO - PROCESS | 1651 | Values: 90.0 90.0 90.0 89.0 90.0 89.0 91.0 89.0 89.0 90.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 09:09:44 INFO - PROCESS | 1651 | Values: 95.0 96.0 96.0 97.0 95.0 95.0 97.0 96.0 96.0 96.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:83.50 stddev:1.60 (1.9%) stddev-sans-first:1.24 09:09:44 INFO - PROCESS | 1651 | Values: 87.0 86.0 82.0 85.0 84.0 83.0 83.0 83.0 83.0 83.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:1.55 (2.4%) stddev-sans-first:1.50 09:09:44 INFO - PROCESS | 1651 | Values: 66.0 63.0 64.0 62.0 67.0 65.0 65.0 63.0 64.0 63.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:4.83 (8.2%) stddev-sans-first:4.66 09:09:44 INFO - PROCESS | 1651 | Values: 54.0 65.0 55.0 70.0 62.0 59.0 57.0 57.0 59.0 59.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:86.00 stddev:2.05 (2.4%) stddev-sans-first:2.05 09:09:44 INFO - PROCESS | 1651 | Values: 87.0 83.0 86.0 83.0 86.0 82.0 86.0 88.0 86.0 83.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:139.50 stddev:16.53 (11.8%) stddev-sans-first:17.44 09:09:44 INFO - PROCESS | 1651 | Values: 139.0 136.0 137.0 138.0 137.0 134.0 140.0 142.0 190.0 144.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:169.00 stddev:19.87 (11.8%) stddev-sans-first:20.83 09:09:44 INFO - PROCESS | 1651 | Values: 163.0 171.0 167.0 166.0 166.0 173.0 213.0 145.0 155.0 198.0 09:09:44 INFO - PROCESS | 1651 | 09:09:44 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:1.01 09:09:44 INFO - PROCESS | 1651 | Values: 66.0 66.0 66.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 09:09:44 INFO - PROCESS | 1651 | -------- Summary: end -------- 09:09:44 INFO - PROCESS | 1651 | 09:09:45 INFO - TEST-INFO | 1651: exit 0 09:09:45 INFO - TEST-OK | kraken | took 59829ms 09:09:45 INFO - SUITE-END | took 1181s 09:09:45 INFO - Completed test suite (00:19:41) 09:09:45 INFO - javascript benchmark 09:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.622993800431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.6057992750902, 3403.3023230237786, 3417.794932304062, 3421.1960189355514, 3437.948430773539, 4982.676126051813, 5997.850053748659, 6021.45806877381, 6043.879122417549, 6047.213862197919, 6020.698965051752, 6112.969435152818, 6113.847153821145, 6114.082887566868, 6120.296165940918, 5388.973055134728, 5410.675359478424, 5435.918461223085, 5488.231647569323, 5507.889842203153, 5310.62825602208, 5313.442088580701, 5508.4491550845, 5563.554915606742, 5579.888402231953, 5344.4922732340365, 5438.8912221755545, 5453.427390124039, 5504.504594586487, 5540.612157149001, 5481.150421684625, 5504.256925315111, 5510.91733623996, 5513.972430137864, 5527.889442211133, 5362.410134885159, 5426.050441172819, 5454.400015998237, 5464.9180262296095, 5481.972590137024, 5816.709164541799, 5861.941380586182, 5868.383819698955, 5885.440883116097, 5911.733971971272, 6274.0902569127675, 6275.780347687809, 6287.0, 6295.0, 6311.589746666452, 5928.525717942597, 6307.716152773136, 6395.904061439082, 6418.358164183591, 6418.582792118497, 5146.614003949681, 6079.331273559905, 6172.88245086593, 6212.658303793244, 6226.5641405101205, 5100.974495127575, 5166.811633324356, 6635.900461493082, 6669.699863506154, 6669.866602667919, 6105.709757709155, 6127.264728232641, 6166.537509686791, 6234.9688251558455, 6382.393672601095, 6054.636721796706, 6463.353664633593, 6477.805665830033, 6481.027845823164, 6503.187101612299, 5851.444112809277, 6409.198850143732, 6426.196725409324, 6429.903551446732, 6431.324710905381, 6179.81460556184, 6280.905786413207, 6284.937150628527, 6351.4283714465, 6419.261784894704, 5179.145441002268, 5190.844274671766, 5192.273081768555, 5192.532672059533, 5212.504812042926, 4604.424446944132, 4631.3516107744945, 4634.58288754007, 4636.327732478771, 4660.953390466119, 5916.556258280646, 5924.7926322578505, 5959.67221802805, 6137.877242455126, 6148.44663980235, 6313.779017734358, 6322.178116844781, 6327.114204011442, 6329.303776584572, 6335.334789847, 5979.312379076462, 6020.0, 6027.095935609694, 6038.667873266924, 6045.546584006217, 5599.664020158803, 5619.634723742944, 5637.154426835926, 5637.46444087811, 5639.407862174413, 6461.676916154268, 6473.579217350857, 6480.416762491398, 6560.114384558024, 6567.605943643397, 6488.545801794018, 6501.08984742127, 6504.089427480251, 6508.707108180238, 6514.348565143638, 6666.100076489805, 6676.165479315086, 6692.6988285526295, 6693.364130407604, 6710.396064354231, 6168.629882207082, 6283.183186185766, 6379.649119298483, 6393.680315984275, 6398.264199617103, 6271.905921411091, 6274.090256912813, 6278.309385967631, 6304.085907543472, 6399.424051835357, 6278.937210627835, 6296.6851657417865, 6297.622142671455, 6302.527310451643, 6350.396712312323, 5311.893762124813, 6289.654069026247, 6314.179156709598, 6323.272823625342, 6333.714982825876, 6123.050927106306, 6125.908111378244, 6268.811935641938, 6269.529785266032, 6285.654289014148, 6145.955187618027, 6215.502759779117, 6222.439980401605, 6265.216847894013, 6300.905486417799, 6161.383861613803, 6209.875802484015, 6226.40849119333, 6230.657313847782, 6244.094606282155], "value": 5883.041303345401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.5387048576582, 808.7250334886139, 875.2604049578105, 895.1719659315132, 897.8922529296482, 39706.40440393393, 40443.98890027751, 42456.57543424565, 42464.15071698572, 42645.573544264545, 42028.579714202846, 42105.73682789513, 42201.15597688044, 42209.36685949706, 42214.0, 7414.925850741504, 7581.090269167707, 9208.447493150416, 9382.624695012191, 9383.296252781034, 7420.591867447289, 7501.362384197322, 7502.849943001137, 11081.0, 11357.204995650307, 10129.290949633529, 10778.784424311509, 11266.830997535044, 11305.773884522305, 11383.601573944914, 11183.496742646601, 11225.607103751412, 11254.324740515513, 11266.549338026469, 11271.098312135091, 7321.633918304064, 7493.66278517468, 7532.359749421305, 10961.506732196991, 11018.724531886686, 27961.720382796117, 28136.0, 39453.0, 39949.80025099885, 41631.58368416338, 3824.978267168933, 3867.3425517661785, 3868.439076333944, 3909.138407185342, 3916.09929716164, 27453.31366715828, 27756.583651245248, 28490.430191396263, 29108.854455727796, 29696.812127514873, 3115.081051089934, 3117.1116231873807, 3126.2028182813237, 3138.3409484008157, 3188.075458117143, 430538.0, 438533.9999999968, 512964.0, 517441.0, 517902.0, 41401.378979315334, 42331.94170145771, 42394.57605423968, 42584.78707606504, 42607.78696106562, 36012.279754404764, 36715.26569468596, 37893.0, 43207.35188972105, 43294.0, 12249.0, 12322.507099716091, 13335.73328533424, 13569.321533923265, 13796.241206733726, 11841.467133978991, 11844.822327665092, 11858.881411185777, 11860.822087668692, 11863.288202707865, 11001.669949901516, 11035.006849383593, 11092.889071109346, 11150.944245278723, 11214.046806021417, 5222.503862133091, 5230.92153617696, 5262.710550919736, 5276.314079169683, 5286.709230992333, 1144.5822274869613, 1152.8904754048351, 1159.0322081062407, 1167.871534131245, 1225.4240506961714, 26793.19620411391, 26820.731792682214, 27226.863865680545, 27359.905603775627, 27516.862415688192, 1056.5087234436023, 1250.3873102179866, 1259.8551166615773, 1311.1543054729646, 1314.9408276627576, 13751.449942002408, 13776.448942042407, 13821.723565528835, 14053.859461405254, 14113.506027288995, 456789.0, 456994.0, 459321.0, 459591.0, 460819.69590151834, 57197.0, 57582.0, 57590.560235993595, 57693.71153144291, 57729.13406298909, 1436.8706816386366, 1479.6670749081802, 1495.9102453852804, 1497.0792962328308, 1499.6700725840299, 24624.384390390383, 25082.122125725513, 26504.204873853814, 26570.202893913214, 26607.20178394651, 42614.0, 42659.0, 42711.0, 42712.572874272104, 42781.716548503595, 484050.0, 493134.0, 493996.0, 503173.0, 585026.0, 31501.8424907874, 31539.684603154594, 31652.36695266128, 31659.84170079135, 31677.0, 39751.0, 42135.0, 42840.57159428366, 42858.357124642534, 43570.0, 29074.418511629225, 34763.304733904675, 35017.824910875286, 35378.823105885334, 35946.64053359433, 33350.499742503394, 35211.64788352186, 36171.63828361683, 36655.45016824803, 37002.44496332611, 30776.846115769276, 35633.82183089068, 36281.63718362888, 36285.45571816372, 36491.45262821007, 29832.0, 31017.8449107753, 31200.375992480476, 31249.218769530944, 31297.530537042418, 23065.423364416023, 23756.762432375453, 23852.880735596213, 24240.393990150387, 24309.635355470036], "value": 18666.32840528109, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.15003542101095, 427.69206171556476, 428.9359420553499, 433.2137171034572, 440.7399634215812, 15542.222888855555, 20646.38060858173, 22280.108795648193, 22359.77640223599, 22514.43713907149, 20179.394618161477, 21168.364949051516, 21280.574388512257, 21810.563788724216, 21846.344609661697, 6538.934610653892, 6682.064510968468, 6752.696128674197, 7257.927420725804, 7570.242975702441, 4080.9387859182134, 7614.923850761477, 7660.310572048515, 7670.117936437326, 7671.501352412075, 4176.561461046576, 7247.528910620793, 7599.278068583503, 7745.186755390688, 7753.689852405925, 7465.216152303984, 7588.886166707503, 7677.0, 7687.2697093776005, 7700.653470593808, 7204.603746793924, 7376.889346659805, 7453.6273186341, 7458.664360103754, 7461.589612571306, 24589.754102458926, 25632.231033069038, 26035.869820650965, 26277.211683649522, 26697.46605067907, 3251.235959549504, 3256.430124728187, 3385.1875549867855, 3387.6951074403423, 3396.9660303396895, 15470.0, 15497.302621382065, 15499.612509687235, 15572.532824015185, 16126.467985541354, 1857.8885266883894, 2014.3352693611073, 2016.1129103194548, 2071.6685330347223, 2073.150008496524, 140596.29701851527, 144933.99999999895, 156866.0, 157806.0, 159797.0, 14502.694757471878, 17110.326972480743, 17816.020118893586, 18864.528386790167, 19502.122404491547, 21112.894435528033, 24561.631575526382, 27215.0, 29897.551536726965, 31177.0, 9810.117089461983, 10162.745931351776, 10226.335288206243, 10289.53697083633, 10434.321769084985, 7314.451416143704, 8346.374021948379, 8553.700620478254, 8557.48655080697, 8711.39020268575, 7883.172266912006, 9103.453792772454, 9117.353058776409, 9188.173064424234, 9272.953635231781, 3607.7474576779373, 3789.5452545694693, 3797.7911214883447, 3807.828647710804, 3822.808859557011, 959.9712008639752, 971.5725080964353, 986.3736527305213, 987.5852142100191, 1010.7927874785652, 20858.47853803667, 20868.89565552193, 20928.686069708965, 20957.161713531288, 20979.895100524704, 975.1564896364594, 985.4973963278779, 996.6163027234567, 1000.1298869983016, 1003.242551873331, 10240.436775977243, 10692.679219623424, 10710.839337409945, 10779.191560632984, 10805.783884322269, 687879.0, 716967.0, 752834.0, 764529.0, 793892.0, 139374.0, 153128.0, 161533.19233403992, 163358.0, 167529.16235418746, 1165.3765235598914, 1170.455738081796, 1203.0315595945349, 1203.9036877049814, 1209.1535924852815, 17655.0, 18411.81588184101, 18419.447416577525, 18420.631587368447, 18464.907675461538, 37801.0, 61597.69201153966, 66042.34894127493, 66199.66900165468, 66453.0, 88338.116618833, 88608.5569572148, 89013.55493222493, 89715.0, 90313.54843225742, 10948.288361256493, 11449.313041217554, 11658.358790266617, 11796.233244839059, 11910.464029118537, 12882.871171288542, 12912.612621621367, 13262.668433289246, 13314.0, 13333.266670333225, 10978.725531861768, 11216.943915280372, 11330.206885517935, 11404.315741055563, 11487.19589628718, 9968.750781230527, 10195.082442580204, 10292.948535257276, 10312.896871031193, 10624.256302058782, 11378.772424551627, 11594.594189203337, 11744.060475162138, 11785.292882427082, 11902.047836173258, 11473.0, 11496.310221386744, 11761.0, 11791.29252244868, 11861.940690296493, 11009.779804404026, 11051.115910726961, 11289.37908415045, 11303.434828258718, 11357.54569817198], "value": 11496.860167299994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.7642815363608, 1534.8718691761553, 1565.0296815974098, 1573.874090072794, 1578.1793467396953, 10502.212334074946, 11096.334219946808, 11100.833487497694, 11104.777904441906, 11136.443177841096, 10486.213533984943, 10904.291221070625, 11023.61417350393, 11041.944790276037, 11043.447827608628, 2361.929142125735, 2393.1743548475833, 2397.724261709908, 2399.2442380650127, 2402.615581506959, 1156.9016633586155, 2346.425125844162, 2373.264288070695, 2382.0352757133387, 2386.4153282445827, 1665.883388162829, 2248.8875556222206, 2270.489139943508, 2277.6128058230056, 2279.680844681746, 1951.443838506019, 2182.854001649131, 2328.906843726249, 2330.1960823515947, 2337.2403968710237, 2304.412374844404, 2364.2198074635503, 2366.6568347589505, 2367.857928524294, 2370.7036620422446, 10926.0, 11053.502592383362, 11060.557577696882, 11067.944660276728, 11140.888591114148, 5037.168867136918, 5669.489745922887, 5870.11948207768, 5871.14868344092, 5875.1187321901625, 3251.1709514073996, 3438.9312213755584, 3638.3632864248916, 3639.836207370675, 3643.8542458301636, 1129.9661010169707, 1147.0, 1183.3255044624568, 1191.7318603314272, 1221.258275172244, 11969.94015029928, 13540.390682419216, 13955.58133256004, 15189.544313670496, 15243.16162611056, 3560.964390356115, 4155.812988415529, 4268.679849011337, 4273.786310684453, 4473.932891006638, 9359.672411465566, 11003.449827508593, 11042.227044106836, 11049.33703977764, 11070.501827417786, 5601.663900165921, 5602.523785478198, 5609.495145436848, 5615.578831587565, 5620.353659329147, 4829.058333624909, 4950.455449900508, 5200.531952124327, 5208.609354298367, 5215.035218484592, 3677.963220367762, 3771.641694039062, 3812.3328417526823, 3846.0, 3867.2458870519977, 1000.8448690452991, 1005.7636455432968, 1011.8785745710414, 1018.0379541333517, 1018.6485662446444, 761.7638532055081, 772.7140957845633, 797.4537441852234, 803.2008151888908, 804.3042768005633, 6246.562740608114, 6270.0, 6350.777722779773, 6383.872322553523, 6419.646919419477, 943.2548286853446, 949.2453499467939, 969.3892847506027, 979.3976704326788, 987.2821290953689, 3926.842926282917, 3942.586028467027, 3958.0, 4058.431819545266, 4058.5332686740812, 13095.541656041993, 13587.048906576643, 13591.388387522586, 13604.591862244148, 13627.25050122233, 12974.0, 13190.340482975813, 13533.796993045113, 13541.796873046913, 13558.11872228302, 8289.544075075928, 9835.0, 9930.453825039547, 10072.345297555781, 10096.39421634719, 6215.06773983906, 6241.563090583615, 6318.747250109944, 6335.334789847, 6420.6789660517725, 11822.231554948901, 12080.697982550155, 12160.270383777002, 12174.086943479097, 12189.024878009915, 11184.94407527957, 11337.659870203906, 11592.188546801643, 12277.877221227673, 12455.252684838939, 7900.525968441912, 7996.160403157817, 8039.557824319485, 8042.0, 8128.349732021542, 10117.19062475015, 10202.0, 10332.91504392028, 10336.12142967826, 10336.948315258376, 9134.817303654023, 9179.908200917906, 9189.310801690033, 9291.907080929104, 9409.529523523934, 8586.441881277948, 8593.269572086443, 8768.430052046597, 8824.294056475339, 8984.146506081912, 7147.2852714728115, 7418.851622967619, 7758.61206939662, 7883.605819708877, 7890.092639346549, 5779.7110144493445, 5789.768409263751, 5851.64890106578, 5922.437368449991, 5939.07944268639, 4771.5467030632035, 5632.042552766122, 5632.464915832989, 5634.380218176079, 5729.169270455844], "value": 4936.659376582552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4499658001028, 377.94897688812034, 378.5400738103204, 387.4227401172253, 388.097672910483, 5094.580074464632, 5134.332536770224, 5163.192882491131, 5173.465002148948, 5184.818531351403, 4059.6955228357842, 4485.035717320784, 4527.864164075075, 4635.351050852883, 5093.312402825627, 3238.6437491875877, 3301.5873015873017, 3356.5636467259224, 3386.560711697531, 3998.9800050999706, 3493.7729047611824, 3881.4760007398922, 4018.97990510047, 4022.3363145081025, 4065.105676751125, 3425.2293234022272, 3855.9203423041595, 3943.842246310144, 4019.673507742438, 4058.6516124197506, 3884.941725874114, 3897.5128108986237, 3983.960160398388, 3989.840406383741, 4008.5347511280643, 3124.7343975762087, 3344.063662174595, 3363.2432702641954, 3575.302815950891, 3578.8568457261676, 4693.906121877578, 4720.881977950545, 4880.902381952341, 4975.0, 5041.2355675513645, 4030.996907304048, 4238.597333253367, 4243.639290660298, 4247.341662042358, 4426.955730442686, 4604.3784089147875, 4879.487653796371, 5099.847004589868, 5365.436629153922, 5383.496674046548, 3542.574891013069, 3655.323765103438, 3930.567637559866, 3982.3030969580495, 4041.312976793952, 4593.554833874594, 5181.4300426953005, 5530.976769297693, 5656.349519805234, 5925.08161235005, 3465.913352166216, 4045.7977101144825, 4147.709660323809, 4588.151192029485, 4806.866095158161, 4915.255084444971, 4928.236123400879, 4932.396970984372, 4937.481564435682, 4954.950450495449, 4223.809928553223, 4505.81976720934, 5120.692758434506, 5161.664491808096, 5211.661242019257, 5000.299958005882, 5261.263423120766, 5384.6769193848495, 5574.777008919679, 5619.550435965113, 1498.3107770425509, 1603.006136195543, 1640.917954102314, 1681.8065922419078, 1694.1533728236282, 1168.4975460552043, 1254.4731212890608, 1299.4347601171253, 1363.9727205456034, 1367.3710093356967, 4491.708038977456, 4774.427068751772, 4983.377077865267, 5130.7178105204575, 5151.304573882478, 5035.949640503622, 5280.339957505312, 5710.65736055838, 5711.685857277889, 5725.5133313667975, 4500.572445617727, 4518.864434066983, 5120.769565369567, 5126.333576635088, 5142.897142057138, 2947.204254851178, 2973.3012742005612, 2974.4384198296066, 2988.6999155367484, 2991.880324786984, 5196.064708352457, 5442.00689620707, 5867.650440398732, 5909.409059094142, 5914.610066634424, 5155.757245598177, 5251.6061295403, 5312.814051508179, 5415.756290966916, 5812.244408226903, 4772.821488684746, 4794.400699912511, 5101.566366858859, 5652.982463156589, 5754.338251101093, 3867.911327882912, 4710.8351207707565, 4724.503927087606, 5127.359409903977, 5753.884922301614, 5369.248305237192, 5598.472962033892, 5627.774889004394, 5631.521320687787, 5632.5493960482245, 5350.464953504618, 5573.637713548606, 5689.459501347365, 5842.474177324061, 5860.743613708668, 4580.954190458053, 4789.521047895182, 4830.4444988826735, 4846.5638092571835, 4876.536729010881, 4853.0, 5133.897322053613, 5151.922721159111, 5745.454181852718, 5747.683877386617, 4775.403074615673, 5009.874753131201, 5346.3535549903045, 5429.809956651498, 5528.369131106414, 5336.67979921206, 5498.80754173602, 5507.5680323115475, 5515.944840551543, 5531.557475401878, 4752.405949256343, 4906.386701662293, 4980.088398757245, 5090.0, 5272.920906186334, 4688.859334219979, 5130.460422091089, 5131.358580177478, 5401.972990135024, 5483.561315094703, 5015.673981191211, 5186.066508028591, 5328.733563321896, 5422.728863556886, 5431.632387919515], "value": 4126.0494827230805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2817905288972, 720.945929055321, 738.5088915870942, 822.6668199379252, 845.4251109245714, 15282.159481228528, 16140.677186456263, 16145.677086458278, 16159.353625854952, 16161.353545858181, 14180.50368237112, 14188.006839521238, 14189.503367382144, 14191.148531088116, 14204.218767967757, 898.716904175186, 924.3714274293478, 940.8165407745493, 952.4856577448204, 956.0726095687172, 951.5813042261417, 952.3999880075577, 953.752024473635, 953.752024473635, 959.740869965109, 1000.2348203624233, 1001.8897921228659, 1001.9098281154695, 1003.1723827842023, 1004.0311099788703, 996.0736515041009, 998.3510718033264, 998.6804222648719, 999.7250756042074, 1001.6293971230618, 734.0787311923502, 734.6216698400328, 734.8199691075721, 734.9522281051715, 735.2720806401677, 15772.369105235777, 16040.278187481592, 16059.116748578823, 16180.919095404566, 16483.258253378626, 14040.85959140416, 14069.577912662637, 14132.646683832883, 14227.0, 14231.0, 11477.827832582434, 11660.475278612483, 11675.474603642857, 11793.528258869635, 12224.580052753714, 3612.422012477991, 3666.1018050577513, 3693.9630603693886, 3738.2336620992633, 3811.0472381904524, 117531.0, 118631.4068429661, 119102.0, 120182.0, 122227.55544889142, 9940.304178707422, 10057.346272492265, 10081.747956301004, 10109.241806864515, 10165.898341016644, 20264.392068237976, 20341.79658203399, 20604.0, 20636.79363206379, 20654.07056682453, 6323.27282362525, 6396.712147953353, 7505.737299194502, 7876.763697089096, 7944.642491087915, 4276.2516559601945, 4373.475182978063, 4441.600255976913, 4450.5104438511735, 4527.222906159383, 3470.722342212617, 3476.756627036083, 3538.57537095545, 3595.173110184672, 3639.3631114554846, 624.4754406298731, 642.9389208025231, 650.5868773328971, 651.7360469010058, 656.9967150164218, 674.2818897873749, 674.4016680467324, 694.7915625312386, 707.8938159276149, 714.9418860087101, 8656.740297791077, 9971.30200885931, 10370.637027703995, 10426.374417534973, 10522.789544209072, 655.3970347280514, 660.6168422315046, 678.2166597579704, 693.434850596762, 701.5439964023426, 5006.974965125224, 5040.823571175065, 5054.1407960646775, 5073.315102461194, 5078.13671675816, 93360.53319733359, 94218.0, 95929.0, 98604.0, 109716.90283097226, 65340.67329663321, 69950.0, 77032.61483692657, 77428.22571774323, 86931.56534217288, 64651.35348646547, 69862.3013769866, 74192.88710669453, 75069.0, 77308.61345693236, 11054.889451105386, 11063.502142403771, 11134.3876086816, 11252.943735281271, 11327.546898123983, 48500.02248841779, 48879.75560122319, 50139.49860501348, 51159.2326115116, 54765.0, 52911.0, 53164.46835531595, 56127.71936140293, 61133.94330283379, 62998.0, 12409.689757755767, 12566.937165314115, 12651.304178270284, 12810.615681529569, 13124.540641077516, 14237.572872813833, 14347.713045739236, 14484.493042743454, 14997.850021499646, 15152.469663561722, 13275.66810829737, 13666.09620652333, 14839.629009274855, 14857.18285494265, 15299.0, 13872.0, 14581.635459113608, 14709.190994494977, 14800.333984970917, 15377.69244615079, 13508.324583770576, 13981.930090349482, 14475.710485790436, 14931.552053438414, 15302.923485382502, 10959.616413425492, 11390.601328953448, 11443.256188348063, 11484.655460336204, 11698.590549330733, 10077.294589378673, 11009.0, 11145.387003714874, 11269.887301126884, 11725.41372931367], "value": 7633.393495484032, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 114.0, 114.0, 121.0, 169.0, 177.0, 116.0, 115.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 112.0, 169.0, 133.0, 129.0, 107.0, 107.0, 131.0, 108.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 185.0, 185.0, 185.0, 183.0, 185.0, 188.0, 185.0, 186.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 61.0, 91.0, 62.0, 59.0, 60.0, 60.0, 76.0, 59.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 87.0, 68.0, 69.0, 67.0, 81.0, 68.0, 67.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 89.0, 90.0, 89.0, 91.0, 89.0, 89.0, 90.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 82.0, 85.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 62.0, 67.0, 65.0, 65.0, 63.0, 64.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 65.0, 55.0, 70.0, 62.0, 59.0, 57.0, 57.0, 59.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 83.0, 86.0, 82.0, 86.0, 88.0, 86.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 137.0, 138.0, 137.0, 134.0, 140.0, 142.0, 190.0, 144.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 167.0, 166.0, 166.0, 173.0, 213.0, 145.0, 155.0, 198.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 09:09:46 INFO - Return code: 0 09:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:46 ERROR - # TBPL SUCCESS # 09:09:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:09:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:09:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:09:46 INFO - 2017-03-18 09:09:46.104 screenresolution[1655:10284] starting screenresolution argv=screenresolution get 09:09:46 INFO - 2017-03-18 09:09:46.106 screenresolution[1655:10284] Display 0: 1600x1200x32@60 09:09:46 INFO - 2017-03-18 09:09:46.112 screenresolution[1656:10287] starting screenresolution argv=screenresolution list 09:09:46 INFO - Available Modes on Display 0 09:09:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:09:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:09:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:09:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:09:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:09:46 INFO - Intel Iris: 09:09:46 INFO - Chipset Model: Intel Iris 09:09:46 INFO - Type: GPU 09:09:46 INFO - Bus: Built-In 09:09:46 INFO - VRAM (Dynamic, Max): 1536 MB 09:09:46 INFO - Vendor: Intel (0x8086) 09:09:46 INFO - Device ID: 0x0a2e 09:09:46 INFO - Revision ID: 0x0009 09:09:46 INFO - Displays: 09:09:46 INFO - Display: 09:09:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:09:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:09:46 INFO - Display Serial Number: 1600x1200 60 09:09:46 INFO - Main Display: Yes 09:09:46 INFO - Mirror: Off 09:09:46 INFO - Online: Yes 09:09:46 INFO - Rotation: Supported 09:09:46 INFO - Return code: 0 09:09:46 INFO - Running post-action listener: _resource_record_post_action 09:09:46 INFO - [mozharness: 2017-03-18 16:09:46.364903Z] Finished run-tests step (success) 09:09:46 INFO - Running post-run listener: _resource_record_post_run 09:09:46 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38528000; Write bytes: 505946112; Read time: 369; Write time: 1713 09:09:46 INFO - TinderboxPrint: CPU usage
53.9% 09:09:46 INFO - TinderboxPrint: I/O read bytes / time
38,528,000 / 369 09:09:46 INFO - TinderboxPrint: I/O write bytes / time
505,946,112 / 1,713 09:09:46 INFO - TinderboxPrint: CPU idle
2,218.4 (46.1%) 09:09:46 INFO - TinderboxPrint: CPU system
957.6 (19.9%) 09:09:46 INFO - TinderboxPrint: CPU user
1,633.7 (34.0%) 09:09:46 INFO - TinderboxPrint: Swap in / out
245,657,600 / 0 09:09:46 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 211485184; Write bytes: 202631168; Read time: 16258; Write time: 447 09:09:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31198208; Write bytes: 292276224; Read time: 282; Write time: 1206 09:09:46 INFO - Running post-run listener: _upload_blobber_files 09:09:46 INFO - Blob upload gear active. 09:09:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:46 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 09:09:46 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'] 09:09:46 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 09:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:09:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:47 INFO - (blobuploader) - INFO - Done attempting. 09:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:49 INFO - (blobuploader) - INFO - Done attempting. 09:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:50 INFO - (blobuploader) - INFO - Done attempting. 09:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:53 INFO - (blobuploader) - INFO - Done attempting. 09:09:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:53 INFO - Return code: 0 09:09:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3a19fe19e0c7f300fcd4880ff7a363d99ed8a9ffcfc505dd050e7b11cd65a5d101f3e0d9c65290370cdafb7ae24d29b9dd4625d6b824b0dfb475636450f3cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2500e358553817e7e63160f6a1e7a335945f0748d21125275c46b27022dccf3a75ff8b7b41feaced8e52a8bacf271823e53379eec301c39d490f48f977e2d964", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eed4548a802ca3ad84686108deaeaaf1f504010d69d76929f2a519a37ae4ba774d08a84e94ed478dd3552d86941cc90d039cb1f81b4128f7f08cfd0e691bf928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45909445b9e960a4f2c6d8618aee88990515e3f34bb8948335300097582dc5e6dfce2ef72c041b98bcceed9bae10c5d434de5b9349f4ed700cd9bb54c647e7ee"} 09:09:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:53 INFO - Contents: 09:09:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3a19fe19e0c7f300fcd4880ff7a363d99ed8a9ffcfc505dd050e7b11cd65a5d101f3e0d9c65290370cdafb7ae24d29b9dd4625d6b824b0dfb475636450f3cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2500e358553817e7e63160f6a1e7a335945f0748d21125275c46b27022dccf3a75ff8b7b41feaced8e52a8bacf271823e53379eec301c39d490f48f977e2d964", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eed4548a802ca3ad84686108deaeaaf1f504010d69d76929f2a519a37ae4ba774d08a84e94ed478dd3552d86941cc90d039cb1f81b4128f7f08cfd0e691bf928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45909445b9e960a4f2c6d8618aee88990515e3f34bb8948335300097582dc5e6dfce2ef72c041b98bcceed9bae10c5d434de5b9349f4ed700cd9bb54c647e7ee"} 09:09:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:53 INFO - Copying logs to upload dir... 09:09:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.879933 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-18 09:09:53.371382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-18 09:09:53.374548) ========= 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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3a19fe19e0c7f300fcd4880ff7a363d99ed8a9ffcfc505dd050e7b11cd65a5d101f3e0d9c65290370cdafb7ae24d29b9dd4625d6b824b0dfb475636450f3cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2500e358553817e7e63160f6a1e7a335945f0748d21125275c46b27022dccf3a75ff8b7b41feaced8e52a8bacf271823e53379eec301c39d490f48f977e2d964", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eed4548a802ca3ad84686108deaeaaf1f504010d69d76929f2a519a37ae4ba774d08a84e94ed478dd3552d86941cc90d039cb1f81b4128f7f08cfd0e691bf928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45909445b9e960a4f2c6d8618aee88990515e3f34bb8948335300097582dc5e6dfce2ef72c041b98bcceed9bae10c5d434de5b9349f4ed700cd9bb54c647e7ee"} build_url:https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/J1RTZ3gRTbq94aaP6Xz3HA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3a19fe19e0c7f300fcd4880ff7a363d99ed8a9ffcfc505dd050e7b11cd65a5d101f3e0d9c65290370cdafb7ae24d29b9dd4625d6b824b0dfb475636450f3cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2500e358553817e7e63160f6a1e7a335945f0748d21125275c46b27022dccf3a75ff8b7b41feaced8e52a8bacf271823e53379eec301c39d490f48f977e2d964", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eed4548a802ca3ad84686108deaeaaf1f504010d69d76929f2a519a37ae4ba774d08a84e94ed478dd3552d86941cc90d039cb1f81b4128f7f08cfd0e691bf928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45909445b9e960a4f2c6d8618aee88990515e3f34bb8948335300097582dc5e6dfce2ef72c041b98bcceed9bae10c5d434de5b9349f4ed700cd9bb54c647e7ee"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-18 09:09:53.412800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:09:53.413535) ========= 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.RzS6BJwXkw/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.QqbQ1XlrKp/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005237 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:09:53.464354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-18 09:09:53.464962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-18 09:09:53.466330) ========= ========= Total master_lag: 0.80 =========