builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1484736472.83 results: success (0) buildid: 20170118020830 builduid: b6f5018933a04e59b6e3d109e7c2b0b2 revision: e18248e42bfcccd6d032763f1df9406a781c3845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:52.831020) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:52.831467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:52.831749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:53.034558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:53.034843) ========= 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.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 02:47:53-- 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% 8.11M=0.001s 2017-01-18 02:47:53 (8.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:53.217222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:53.217538) ========= 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.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.021252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:53.266797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 02:47:53.267166) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e18248e42bfcccd6d032763f1df9406a781c3845 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev e18248e42bfcccd6d032763f1df9406a781c3845 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 02:47:53,347 truncating revision to first 12 chars 2017-01-18 02:47:53,347 Setting DEBUG logging. 2017-01-18 02:47:53,347 attempt 1/10 2017-01-18 02:47:53,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e18248e42bfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 02:47:55,098 unpacking tar archive at: graphics-e18248e42bfc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.988156 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 02:47:55.283114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:55.283840) ========= script_repo_revision: e18248e42bfcccd6d032763f1df9406a781c3845 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:55.284828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:55.285222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 02:47:55.306045) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-18 02:47:55.306746) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:47:55 INFO - MultiFileLogger online at 20170118 02:47:55 in /builds/slave/test 02:47:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 02:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:55 INFO - {'append_to_log': False, 02:47:55 INFO - 'base_work_dir': '/builds/slave/test', 02:47:55 INFO - 'blob_upload_branch': 'Graphics', 02:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:55 INFO - 'branch': 'Graphics', 02:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:55 INFO - 'config_files': ('talos/mac_config.py',), 02:47:55 INFO - 'default_actions': ('clobber', 02:47:55 INFO - 'read-buildbot-config', 02:47:55 INFO - 'download-and-extract', 02:47:55 INFO - 'populate-webroot', 02:47:55 INFO - 'create-virtualenv', 02:47:55 INFO - 'install', 02:47:55 INFO - 'run-tests'), 02:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:55 INFO - 'download_minidump_stackwalk': True, 02:47:55 INFO - 'download_symbols': 'ondemand', 02:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:55 INFO - 'installer_path': 'installer.exe', 02:47:55 INFO - 'log_level': 'info', 02:47:55 INFO - 'log_name': 'talos', 02:47:55 INFO - 'log_to_console': True, 02:47:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:47:55 INFO - 'opt_config_files': (), 02:47:55 INFO - 'pip_index': False, 02:47:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:55 INFO - 'cmd': ('bash', 02:47:55 INFO - '-c', 02:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:55 INFO - 'enabled': True, 02:47:55 INFO - 'halt_on_failure': False, 02:47:55 INFO - 'name': 'check_screen_resolution'},), 02:47:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:55 INFO - 'cmd': ('bash', 02:47:55 INFO - '-c', 02:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:55 INFO - 'enabled': True, 02:47:55 INFO - 'halt_on_failure': False, 02:47:55 INFO - 'name': 'check_screen_resolution'},), 02:47:55 INFO - 'run_cmd_checks_enabled': True, 02:47:55 INFO - 'sps_profile': False, 02:47:55 INFO - 'sps_profile_interval': 0, 02:47:55 INFO - 'suite': 'dromaeojs', 02:47:55 INFO - 'system_bits': '32', 02:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:55 INFO - 'title': 't-yosemite-r7-0097', 02:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:55 INFO - 'use_talos_json': True, 02:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:55 INFO - 'work_dir': 'build'} 02:47:55 INFO - [mozharness: 2017-01-18 10:47:55.515665Z] Running clobber step. 02:47:55 INFO - Running pre-action listener: _resource_record_pre_action 02:47:55 INFO - Running main action method: clobber 02:47:55 INFO - rmtree: /builds/slave/test/build 02:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:55 INFO - Running post-action listener: _resource_record_post_action 02:47:55 INFO - [mozharness: 2017-01-18 10:47:55.951249Z] Finished clobber step (success) 02:47:55 INFO - [mozharness: 2017-01-18 10:47:55.951327Z] Running read-buildbot-config step. 02:47:55 INFO - Running pre-action listener: _resource_record_pre_action 02:47:55 INFO - Running main action method: read_buildbot_config 02:47:55 INFO - Using buildbot properties: 02:47:55 INFO - { 02:47:55 INFO - "project": "", 02:47:55 INFO - "product": "firefox", 02:47:55 INFO - "script_repo_revision": "default", 02:47:55 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 02:47:55 INFO - "repository": "", 02:47:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 02:47:55 INFO - "buildid": "20170118020830", 02:47:55 INFO - "pgo_build": "False", 02:47:55 INFO - "basedir": "/builds/slave/test", 02:47:55 INFO - "buildnumber": 4, 02:47:55 INFO - "slavename": "t-yosemite-r7-0097", 02:47:55 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:47:55 INFO - "platform": "yosemite_r7", 02:47:55 INFO - "scheduler": "tests-graphics-macosx64-talos", 02:47:55 INFO - "branch": "graphics", 02:47:55 INFO - "repo_path": "projects/graphics", 02:47:55 INFO - "revision": "e18248e42bfcccd6d032763f1df9406a781c3845", 02:47:55 INFO - "stage_platform": "macosx64", 02:47:55 INFO - "builduid": "b6f5018933a04e59b6e3d109e7c2b0b2", 02:47:55 INFO - "slavebuilddir": "test" 02:47:55 INFO - } 02:47:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 02:47:55 INFO - Running post-action listener: _resource_record_post_action 02:47:55 INFO - [mozharness: 2017-01-18 10:47:55.957137Z] Finished read-buildbot-config step (success) 02:47:55 INFO - [mozharness: 2017-01-18 10:47:55.957337Z] Running download-and-extract step. 02:47:55 INFO - Running pre-action listener: _resource_record_pre_action 02:47:55 INFO - Running main action method: download_and_extract 02:47:55 INFO - mkdir: /builds/slave/test/build/tests 02:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:55 INFO - trying https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 02:47:55 INFO - Downloading https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 02:47:57 INFO - Downloaded 1199 bytes. 02:47:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:47:57 INFO - Using the following test package requirements: 02:47:57 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:47:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 02:47:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 02:47:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'jsshell-mac.zip'], 02:47:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 02:47:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:47:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 02:47:57 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 02:47:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 02:47:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:47:57 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 02:47:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:47:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:47:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:47:57 INFO - Fetch https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:47:57 INFO - Expected file size: 16326547 02:47:57 INFO - Obtained file size: 16326547 02:48:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:48:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:04 INFO - Fetch https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:48:05 INFO - Expected file size: 16326547 02:48:05 INFO - Obtained file size: 16326547 02:48:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 02:48:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:48:11 INFO - Fetch https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 02:48:13 INFO - Expected file size: 14403463 02:48:13 INFO - Obtained file size: 14403463 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:13 INFO - trying https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:48:13 INFO - Downloading https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 02:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 02:48:15 INFO - Downloaded 70310832 bytes. 02:48:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:48:15 INFO - mkdir: /builds/slave/test/properties 02:48:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:15 INFO - Contents: 02:48:15 INFO - build_url:https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:48:16 INFO - Running post-action listener: _resource_record_post_action 02:48:16 INFO - Running post-action listener: set_extra_try_arguments 02:48:16 INFO - [mozharness: 2017-01-18 10:48:16.525275Z] Finished download-and-extract step (success) 02:48:16 INFO - [mozharness: 2017-01-18 10:48:16.525391Z] Running populate-webroot step. 02:48:16 INFO - Running pre-action listener: _resource_record_pre_action 02:48:16 INFO - Running main action method: populate_webroot 02:48:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:16 INFO - '--tppagecycles', 02:48:16 INFO - '7'], 02:48:16 INFO - 'tests': ['tsvgm']}}, 02:48:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['damp', 'tps']}, 02:48:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'tests': ['damp', 'tps']}, 02:48:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['dromaeo_dom']}, 02:48:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['basic_compositor_video']}, 02:48:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:48:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['a11yr', 02:48:16 INFO - 'ts_paint', 02:48:16 INFO - 'tpaint', 02:48:16 INFO - 'sessionrestore', 02:48:16 INFO - 'sessionrestore_no_auto_restore', 02:48:16 INFO - 'tabpaint']}, 02:48:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['tsvgx', 02:48:16 INFO - 'tsvgr_opacity', 02:48:16 INFO - 'tart', 02:48:16 INFO - 'tscrollx', 02:48:16 INFO - 'cart', 02:48:16 INFO - 'tsvg_static']}, 02:48:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:16 INFO - 'tsvgr_opacity', 02:48:16 INFO - 'tart', 02:48:16 INFO - 'tscrollx', 02:48:16 INFO - 'cart', 02:48:16 INFO - 'tsvg_static']}, 02:48:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'talos_options': ['--disable-e10s'], 02:48:16 INFO - 'tests': ['tp5o']}, 02:48:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:48:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'talos_options': ['--disable-e10s', 02:48:16 INFO - '--xperf_path', 02:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:16 INFO - 'tests': ['tp5n']}, 02:48:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:48:16 INFO - 'talos_options': ['--xperf_path', 02:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:16 INFO - 'tests': ['tp5n']}}, 02:48:16 INFO - 'talos.zip': {'path': '', 02:48:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:16 INFO - Running post-action listener: _resource_record_post_action 02:48:16 INFO - [mozharness: 2017-01-18 10:48:16.543752Z] Finished populate-webroot step (success) 02:48:16 INFO - [mozharness: 2017-01-18 10:48:16.543861Z] Running create-virtualenv step. 02:48:16 INFO - Running pre-action listener: _resource_record_pre_action 02:48:16 INFO - Running main action method: create_virtualenv 02:48:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:16 INFO - Using real prefix '/tools/python27' 02:48:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:20 INFO - Installing pip.................done. 02:48:20 INFO - Return code: 0 02:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:48:20 INFO - Reading from file tmpfile_stdout 02:48:20 INFO - Output received: 02:48:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:48:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:20 INFO - 'HOME': '/Users/cltbld', 02:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:20 INFO - 'LOGNAME': 'cltbld', 02:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:20 INFO - 'MOZ_NO_REMOTE': '1', 02:48:20 INFO - 'NO_EM_RESTART': '1', 02:48:20 INFO - 'PAGER': '/bin/cat', 02:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:20 INFO - 'PWD': '/builds/slave/test', 02:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:20 INFO - 'SHELL': '/bin/bash', 02:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:20 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:20 INFO - 'USER': 'cltbld', 02:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:20 INFO - 'XPC_FLAGS': '0x0', 02:48:20 INFO - 'XPC_SERVICE_NAME': '0', 02:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:48:20 INFO - Cleaning up... 02:48:20 INFO - Return code: 0 02:48:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:20 INFO - 'HOME': '/Users/cltbld', 02:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:20 INFO - 'LOGNAME': 'cltbld', 02:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:20 INFO - 'MOZ_NO_REMOTE': '1', 02:48:20 INFO - 'NO_EM_RESTART': '1', 02:48:20 INFO - 'PAGER': '/bin/cat', 02:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:20 INFO - 'PWD': '/builds/slave/test', 02:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:20 INFO - 'SHELL': '/bin/bash', 02:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:20 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:20 INFO - 'USER': 'cltbld', 02:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:20 INFO - 'XPC_FLAGS': '0x0', 02:48:20 INFO - 'XPC_SERVICE_NAME': '0', 02:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:21 INFO - Downloading/unpacking psutil>=3.1.1 02:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:25 INFO - Installing collected packages: psutil 02:48:25 INFO - Running setup.py install for psutil 02:48:25 INFO - building 'psutil._psutil_osx' extension 02:48:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:48:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:48:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:48:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:48:25 INFO - building 'psutil._psutil_posix' extension 02:48:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:48:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:25 INFO - ^ 02:48:25 INFO - 1 warning generated. 02:48:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:25 INFO - Successfully installed psutil 02:48:25 INFO - Cleaning up... 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:48: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 mozsystemmonitor==0.3 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:29 INFO - Installing collected packages: mozsystemmonitor 02:48:29 INFO - Running setup.py install for mozsystemmonitor 02:48:29 INFO - Successfully installed mozsystemmonitor 02:48:29 INFO - Cleaning up... 02:48:29 INFO - Return code: 0 02:48:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:29 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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:29 INFO - 'HOME': '/Users/cltbld', 02:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:29 INFO - 'LOGNAME': 'cltbld', 02:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:29 INFO - 'MOZ_NO_REMOTE': '1', 02:48:29 INFO - 'NO_EM_RESTART': '1', 02:48:29 INFO - 'PAGER': '/bin/cat', 02:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:29 INFO - 'PWD': '/builds/slave/test', 02:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:29 INFO - 'SHELL': '/bin/bash', 02:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:29 INFO - 'USER': 'cltbld', 02:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:29 INFO - 'XPC_FLAGS': '0x0', 02:48:29 INFO - 'XPC_SERVICE_NAME': '0', 02:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:32 INFO - warning: no files found matching '*.txt' 02:48:32 INFO - no previously-included directories found matching 'build' 02:48:32 INFO - no previously-included directories found matching 'dist' 02:48:32 INFO - no previously-included directories found matching '.git*' 02:48:32 INFO - Installing collected packages: jsonschema, functools32 02:48:32 INFO - Running setup.py install for functools32 02:48:32 INFO - warning: no files found matching '*.txt' 02:48:32 INFO - no previously-included directories found matching 'build' 02:48:32 INFO - no previously-included directories found matching 'dist' 02:48:32 INFO - no previously-included directories found matching '.git*' 02:48:32 INFO - Successfully installed jsonschema functools32 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:33 INFO - Cleaning up... 02:48:33 INFO - Return code: 0 02:48:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:33 INFO - 'HOME': '/Users/cltbld', 02:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:33 INFO - 'LOGNAME': 'cltbld', 02:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:33 INFO - 'MOZ_NO_REMOTE': '1', 02:48:33 INFO - 'NO_EM_RESTART': '1', 02:48:33 INFO - 'PAGER': '/bin/cat', 02:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:33 INFO - 'PWD': '/builds/slave/test', 02:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:33 INFO - 'SHELL': '/bin/bash', 02:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:33 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:33 INFO - 'USER': 'cltbld', 02:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:33 INFO - 'XPC_FLAGS': '0x0', 02:48:33 INFO - 'XPC_SERVICE_NAME': '0', 02:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - Downloading docopt-0.6.1.tar.gz 02:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:37 INFO - Running setup.py install for blobuploader 02:48:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:37 INFO - Running setup.py install for requests 02:48:38 INFO - Running setup.py install for docopt 02:48:38 INFO - Successfully installed blobuploader requests docopt 02:48:38 INFO - Cleaning up... 02:48:38 INFO - Return code: 0 02:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:38 INFO - 'HOME': '/Users/cltbld', 02:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:38 INFO - 'LOGNAME': 'cltbld', 02:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:38 INFO - 'MOZ_NO_REMOTE': '1', 02:48:38 INFO - 'NO_EM_RESTART': '1', 02:48:38 INFO - 'PAGER': '/bin/cat', 02:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:38 INFO - 'PWD': '/builds/slave/test', 02:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:38 INFO - 'SHELL': '/bin/bash', 02:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:38 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:38 INFO - 'USER': 'cltbld', 02:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:38 INFO - 'XPC_FLAGS': '0x0', 02:48:38 INFO - 'XPC_SERVICE_NAME': '0', 02:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-5F6Q65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-OlHFXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CLgOEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Vj0TYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3YNArH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-yQVDcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ZqNp0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-VWKLvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-9mbcpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1m6Yko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FsPgW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-sUtynl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ox2txG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-gGS070-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:40 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QQADGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:40 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-82NjBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:40 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-RMXa9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:40 INFO - Running setup.py install for manifestparser 02:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:40 INFO - Running setup.py install for mozcrash 02:48:40 INFO - Running setup.py install for mozdebug 02:48:40 INFO - Running setup.py install for mozdevice 02:48:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:40 INFO - Running setup.py install for mozfile 02:48:41 INFO - Running setup.py install for mozhttpd 02:48:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for mozinfo 02:48:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for mozInstall 02:48:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for mozleak 02:48:41 INFO - Running setup.py install for mozlog 02:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for moznetwork 02:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozprocess 02:48:42 INFO - Running setup.py install for mozprofile 02:48:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozrunner 02:48:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozscreenshot 02:48:42 INFO - Running setup.py install for moztest 02:48:42 INFO - Running setup.py install for mozversion 02:48:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:42 INFO - 'HOME': '/Users/cltbld', 02:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PAGER': '/bin/cat', 02:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:42 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - 'XPC_FLAGS': '0x0', 02:48:42 INFO - 'XPC_SERVICE_NAME': '0', 02:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-iuPd1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-VNaZAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Kn0IO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-JkLi_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-me54ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-a8qQrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-kx98uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:43 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-0SYYEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-bXkbDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-PkVUW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Qqj7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-6VO3nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4mPR8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-A0jLH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-JhV_wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-nLt4L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:44 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-G3oAfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:47 INFO - Downloading blessings-1.6.tar.gz 02:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:47 INFO - Installing collected packages: blessings 02:48:47 INFO - Running setup.py install for blessings 02:48:47 INFO - Successfully installed blessings 02:48:47 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:48 INFO - Reading from file tmpfile_stdout 02:48:48 INFO - Current package versions: 02:48:48 INFO - blessings == 1.6 02:48:48 INFO - blobuploader == 1.2.4 02:48:48 INFO - docopt == 0.6.1 02:48:48 INFO - functools32 == 3.2.3-2 02:48:48 INFO - jsonschema == 2.5.1 02:48:48 INFO - manifestparser == 1.1 02:48:48 INFO - mozInstall == 1.12 02:48:48 INFO - mozcrash == 1.0 02:48:48 INFO - mozdebug == 0.1 02:48:48 INFO - mozdevice == 0.49 02:48:48 INFO - mozfile == 1.2 02:48:48 INFO - mozhttpd == 0.7 02:48:48 INFO - mozinfo == 0.9 02:48:48 INFO - mozleak == 0.1 02:48:48 INFO - mozlog == 3.4 02:48:48 INFO - moznetwork == 0.27 02:48:48 INFO - mozprocess == 0.24 02:48:48 INFO - mozprofile == 0.28 02:48:48 INFO - mozrunner == 6.13 02:48:48 INFO - mozscreenshot == 0.1 02:48:48 INFO - mozsystemmonitor == 0.3 02:48:48 INFO - moztest == 0.8 02:48:48 INFO - mozversion == 1.4 02:48:48 INFO - psutil == 3.1.1 02:48:48 INFO - requests == 1.2.3 02:48:48 INFO - wsgiref == 0.1.2 02:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 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 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:48 INFO - 'HOME': '/Users/cltbld', 02:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:48 INFO - 'LOGNAME': 'cltbld', 02:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:48 INFO - 'MOZ_NO_REMOTE': '1', 02:48:48 INFO - 'NO_EM_RESTART': '1', 02:48:48 INFO - 'PAGER': '/bin/cat', 02:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:48 INFO - 'PWD': '/builds/slave/test', 02:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:48 INFO - 'SHELL': '/bin/bash', 02:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:48 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:48 INFO - 'USER': 'cltbld', 02:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:48 INFO - 'XPC_FLAGS': '0x0', 02:48:48 INFO - 'XPC_SERVICE_NAME': '0', 02:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:48 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4cad6b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, '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.1lpDmirJl5/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.UPY0DL0HfU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:48 INFO - 'HOME': '/Users/cltbld', 02:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:48 INFO - 'LOGNAME': 'cltbld', 02:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:48 INFO - 'MOZ_NO_REMOTE': '1', 02:48:48 INFO - 'NO_EM_RESTART': '1', 02:48:48 INFO - 'PAGER': '/bin/cat', 02:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:48 INFO - 'PWD': '/builds/slave/test', 02:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:48 INFO - 'SHELL': '/bin/bash', 02:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:48:48 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:48 INFO - 'USER': 'cltbld', 02:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:48 INFO - 'XPC_FLAGS': '0x0', 02:48:48 INFO - 'XPC_SERVICE_NAME': '0', 02:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:48 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Running post-action listener: _resource_record_post_action 02:48:48 INFO - Running post-action listener: _start_resource_monitoring 02:48:48 INFO - Starting resource monitoring. 02:48:48 INFO - [mozharness: 2017-01-18 10:48:48.932948Z] Finished create-virtualenv step (success) 02:48:48 INFO - [mozharness: 2017-01-18 10:48:48.933946Z] Running install step. 02:48:48 INFO - Running pre-action listener: _resource_record_pre_action 02:48:48 INFO - Running main action method: install 02:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:49 INFO - Reading from file tmpfile_stdout 02:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:49 INFO - Reading from file tmpfile_stdout 02:48:49 INFO - Output received: 02:48:49 INFO - Usage: mozinstall [options] installer 02:48:49 INFO - Options: 02:48:49 INFO - -h, --help show this help message and exit 02:48:49 INFO - -d DEST, --destination=DEST 02:48:49 INFO - Directory to install application into. [default: 02:48:49 INFO - "/builds/slave/test"] 02:48:49 INFO - --app=APP Application being installed. [default: firefox] 02:48:49 INFO - mkdir: /builds/slave/test/build/application 02:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:11 INFO - Reading from file tmpfile_stdout 02:49:11 INFO - Output received: 02:49:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:11 INFO - Running post-action listener: _resource_record_post_action 02:49:11 INFO - [mozharness: 2017-01-18 10:49:11.521876Z] Finished install step (success) 02:49:11 INFO - [mozharness: 2017-01-18 10:49:11.522028Z] Running run-tests step. 02:49:11 INFO - Running pre-action listener: _resource_record_pre_action 02:49:11 INFO - Running main action method: run_tests 02:49:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:11 INFO - 2017-01-18 02:49:11.536 screenresolution[2894:303323] starting screenresolution argv=screenresolution get 02:49:11 INFO - 2017-01-18 02:49:11.539 screenresolution[2894:303323] Display 0: 1600x1200x32@60 02:49:11 INFO - 2017-01-18 02:49:11.545 screenresolution[2895:303326] starting screenresolution argv=screenresolution list 02:49:11 INFO - Available Modes on Display 0 02:49:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:11 INFO - Intel Iris: 02:49:11 INFO - Chipset Model: Intel Iris 02:49:11 INFO - Type: GPU 02:49:11 INFO - Bus: Built-In 02:49:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:11 INFO - Vendor: Intel (0x8086) 02:49:11 INFO - Device ID: 0x0a2e 02:49:11 INFO - Revision ID: 0x0009 02:49:11 INFO - Displays: 02:49:11 INFO - Display: 02:49:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:11 INFO - Display Serial Number: 1600x1200 60 02:49:11 INFO - Main Display: Yes 02:49:11 INFO - Mirror: Off 02:49:11 INFO - Online: Yes 02:49:11 INFO - Rotation: Supported 02:49:11 INFO - Return code: 0 02:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:11 INFO - Python 2.7.3 02:49:11 INFO - Return code: 0 02:49:11 INFO - grabbing minidump binary from tooltool 02:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:11 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 0x109641d30>, '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 0x109568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109636be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:49:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:49:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:11 INFO - Return code: 0 02:49:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 02:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 02:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1lpDmirJl5/Render', 02:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:11 INFO - 'HOME': '/Users/cltbld', 02:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:11 INFO - 'LOGNAME': 'cltbld', 02:49:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:11 INFO - 'MOZ_NO_REMOTE': '1', 02:49:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:11 INFO - 'NO_EM_RESTART': '1', 02:49:11 INFO - 'PAGER': '/bin/cat', 02:49:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:11 INFO - 'PWD': '/builds/slave/test', 02:49:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:11 INFO - 'SHELL': '/bin/bash', 02:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UPY0DL0HfU/Listeners', 02:49:11 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 02:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:11 INFO - 'USER': 'cltbld', 02:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:11 INFO - 'XPC_FLAGS': '0x0', 02:49:11 INFO - 'XPC_SERVICE_NAME': '0', 02:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 02:49:12 INFO - mozversion application_buildid: 20170118020830 02:49:12 INFO - mozversion application_changeset: e18248e42bfcccd6d032763f1df9406a781c3845 02:49:12 INFO - mozversion application_display_name: Nightly 02:49:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:12 INFO - mozversion application_name: Firefox 02:49:12 INFO - mozversion application_remotingname: firefox 02:49:12 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 02:49:12 INFO - mozversion application_vendor: Mozilla 02:49:12 INFO - mozversion application_version: 53.0a1 02:49:12 INFO - mozversion platform_buildid: 20170118020830 02:49:12 INFO - mozversion platform_changeset: e18248e42bfcccd6d032763f1df9406a781c3845 02:49:12 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 02:49:12 INFO - mozversion platform_version: 53.0a1 02:49:12 INFO - using testdate: 1484736552 02:49:12 INFO - actual date: 1484736552 02:49:12 INFO - starting webserver on 'localhost:56689' 02:49:12 INFO - SUITE-START | Running 2 tests 02:49:12 INFO - TEST-START | dromaeo_css 02:49:12 INFO - operating with platform_type : mac_ 02:49:12 INFO - Initialising browser for dromaeo_css test... 02:49:12 INFO - TEST-INFO | started process 2905 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp_ul59i/profile http://localhost:56689/getInfo.html) 02:49:14 INFO - PROCESS | 2905 | __metrics Screen width/height:1600/1200 02:49:14 INFO - PROCESS | 2905 | colorDepth:24 02:49:14 INFO - PROCESS | 2905 | Browser inner width/height: 1024/689 02:49:14 INFO - PROCESS | 2905 | __metrics 02:49:14 INFO - PROCESS | 2905 | 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" 02:49:14 INFO - PROCESS | 2905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:15 INFO - TEST-INFO | 2905: exit 0 02:49:15 INFO - Browser initialized. 02:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:15 INFO - TEST-INFO | started process 2908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp_ul59i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:27 INFO - PROCESS | 2908 | RSS: Main: 235810816 02:49:27 INFO - PROCESS | 2908 | 02:52:31 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56689/tests/dromaeo/cssquery-ext.html) 02:52:33 INFO - PROCESS | 2908 | RSS: Main: 372178944 02:52:33 INFO - PROCESS | 2908 | 02:54:17 INFO - PROCESS | 2908 | ************************* 02:54:17 INFO - PROCESS | 2908 | A coding exception was thrown and uncaught in a Task. 02:54:17 INFO - PROCESS | 2908 | 02:54:17 ERROR - PROCESS | 2908 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:54:17 INFO - PROCESS | 2908 | Full stack: 02:54:17 INFO - PROCESS | 2908 | ************************* 02:55:36 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-ext.html (next: http://localhost:56689/tests/dromaeo/cssquery-jquery.html) 02:55:36 INFO - PROCESS | 2908 | RSS: Main: 368398336 02:55:36 INFO - PROCESS | 2908 | 02:58:38 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56689/tests/dromaeo/cssquery-mootools.html) 02:58:39 INFO - PROCESS | 2908 | RSS: Main: 334696448 02:58:39 INFO - PROCESS | 2908 | 03:01:42 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56689/tests/dromaeo/cssquery-prototype.html) 03:01:42 INFO - PROCESS | 2908 | RSS: Main: 348897280 03:01:42 INFO - PROCESS | 2908 | 03:04:46 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56689/tests/dromaeo/cssquery-yui.html) 03:04:46 INFO - PROCESS | 2908 | RSS: Main: 326045696 03:04:46 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | Cycle 1(1): loaded http://localhost:56689/tests/dromaeo/cssquery-yui.html (next: http://localhost:56689/tests/dromaeo/cssquery-dojo.html) 03:07:50 INFO - PROCESS | 2908 | RSS: Main: 482267136 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | __start_tp_report 03:07:50 INFO - PROCESS | 2908 | _x_x_mozilla_page_load 03:07:50 INFO - PROCESS | 2908 | _x_x_mozilla_page_load_details 03:07:50 INFO - PROCESS | 2908 | |i|pagename|runs| 03:07:50 INFO - PROCESS | 2908 | |0;dojo.html;3266.7386609071277;3276.7542434317425;3278.8196649184283;3325.268440942995;3325.7671962962586;5487.039768040597;5536.446355364462;5550.750216240269;5584.078627026536;5598.83203503895;5521.282233309674;5548.833534993946;5607.831765047045;5653.180288858113;5686.687232202227;5026.346574945252;5050.090983622947;5056.469070747574;5094.388673359202;5121.385433747955;5084.135696931512;5155.690658560479;5179.61152913533;5196.844094677147;5236.293100431431;5004.799808007675;5119.513646203604;5137.51193636604;5145.3568303962;5177.145770947789;5041.571466425358;5044.9747751261375;5099.59203263738;5114.974425127888;5116.513931176532;5088.287639730441;5100.591952643779;5112.846614601568;5120;5153.201253805666;5578.525825304854;5592.692401917893;5610.242617246701;5614.775408983635;5624.5781566382275;5941.584089113764;6011.969940150271;6128;6139.355367686418;6150.138980542728;6100.5574390564525;6102.974033066861;6133.6319820810895;6187.412195841388;6260.186175797163;5705.030144875381;5706.743196556165;5714.171445140431;5722.828315150552;5748.511376532958;6180.443760061616;6289.905651415233;6307.5584709070845;6313.084602732578;6339.873202536016;5839.766409343663;5892.764289428461;5903.645781253139;5961.105834124916;5974.40255974399;6106.72519736613;6107.358727333655;6114.938850611526;6119.173911521888;6125.295591007091;5057;6098.573099883054;6112.876832246516;6127.525510585499;6134.926387882103;6134.539909506805;6136.969315153396;6139.84650383744;6145.723442445012;6157.692115394212;4942.085714142895;4944.678595891256;4946.282788995575;4947.950520494749;4958.107540642647;4361.9967407495815;4372.366006928977;4388.956110438919;4392.472903251631;4398.560143985575;5795.449432303924;5798.391168927202;5819.039858423397;5823.912641310384;5864.530837532987;6216.533759968021;6217.875642487125;6224.346443623445;6234.220722409699;6252.468540174045;5636.915446268309;5674.631148975386;5687.573431992617;5698.7435565399655;5790.392008839095;5322.627416080837;5389.487998640123;5420.756065977041;5447.645903016291;5454.809081682122;6297.244330680348;6311.589746666452;6312.495000400048;6319.715612797527;6323.747050117944;6003.909941350796;6188.845278868064;6209.906851397323;6219.222597175353;6241.656708881055;6167.6916154193;6223.37766223374;6244.968775156095;6264.5301602379095;6304.211973503312;4883.682560633548;6046.425589568984;6055.499606138352;6059.878802424015;6109.969450152721;6013.368596297326;6027.75888964454;6073.5748497604745;6088.634681919099;6134.1610691366095;5926.436988486087;5954.791582294599;5966.850828729142;5979.252593425822;5988.071848863433;4908.852734417973;5740.885182296247;5814.186013957965;5816.94183058164;5833.591648584558;5775.9133612996675;5786.508146807569;5786.94213057864;5811;5843.707814609167;5955.166276721349;5971.193888824953;5990.700464976647;5994.520438364833;5997.13041608973;5633;5670.5180059695385;5679.460451257124;5803.622764520293;5807.564432667482 03:07:50 INFO - PROCESS | 2908 | |1;ext.html;475.40574282147315;486.1589450251068;493.0287333952113;495.8834673851645;501.9673721208121;25735;32063.35873282533;39122.02194945124;41160.97097572562;41415.79292103543;42474.938126546855;42496;42927.78536107323;43028.13943721123;43036.78481607595;8383.538905360203;8617.181367770052;9130.178283954443;9320.8601870972;9350.766230844249;10915.017648411642;11196.384198869058;11217;11364;11385.430728463543;11079.002889739922;11151.721206969809;11163.609273675424;11182.776344473106;11183.776324473505;10464.63373781914;11074.335539867594;11134.888651113506;11145.442727863574;11157.330560166334;11027.779444411148;11074.833877491845;11080.279781814157;11085.944570277177;11097.55609775608;40380;40644.59355406438;40705.59294407048;40827.7958610205;40837.38743918844;3927.507398719214;3979.263836190285;4014.116894283253;4016.49793775778;4115.868136262522;29729.851350743324;30599.38801223963;30860.2284942876;30892.8455357724;31181.064568062993;3096.086654436924;3207.294395233045;3256.853441595134;3274.67253274673;3315.1712071982006;480197;484000;484128.99999999645;486581.56709216937;486710;63553;63780.68109659422;64154.67922660357;64170.35829641737;64183;65982.67008664926;66086;66088.6695566519;66180.34549136214;66214.37177839842;15748.055116693035;15969.520914372355;16004.67990640204;16009.199540022952;16034.358625654842;10932.125429965583;11214.271072380268;12049.518019279307;12069.27584344942;12114.636560903187;17417.39039133624;17706.822931770774;17953.102344882966;17978.303254511928;17980.460586182435;7600.479904019218;7626.389888808882;7714.807129821687;7717.723271634881;7761.379089672812;757.7575175943755;881.1496905486237;913.963441462334;916.8212198621205;927.888653361601;28528;28791.712082879323;29638.851805740833;30368;30470;971.4851128901694;1003.7440452684518;1030.3972176276961;1053.1574740207802;1061.7345663584103;12922.806157907638;13868.722625547432;14466.349014294172;14576.833853291922;14706.41174353014;611635;614987;616696.8330316729;617416;617478.6403835515;52114.73942630263;52300.476995230325;52402.73798631059;52459.704835419994;52598.47401526012;1392.3943084758162;1417.4046900301898;1438.719449707318;1444.934977926017;1446.8842492600356;25568.488630227665;27375.589366159125;27434.862825685745;27484.450310994067;27548.449031019667;50289.742756431384;51292.487075130266;51296.74351628218;51308;51499;544084;546221;546789;548263;549769;24307;24496.632550512113;24847.62728559037;24851.502969940862;24868.253952381456;43426;43495.56504435042;43897.56102439063;43934.12131757411;44006;32458.83770581132;33978.83010584931;34157.65842341545;36235.45646815247;36508.63491365052;34685.47971780476;35013.29973400569;35111.82444087763;36006.459903102;36029;34541.82729086339;35041;35082;35232.64767352294;35374.58501659905;27889.860550697118;28291.868325267584;31447.685523144475;31479.370412592078;31584;21888.671669924646;23024.884875575513;23169.768302316763;23249.186278480847;23292.301230963098 03:07:50 INFO - PROCESS | 2908 | |2;jquery.html;368.5062016897357;368.60375096770974;384.80951928795236;398.66113803267217;417.5761601973997;15346.616334591641;16984.83015169848;20112.29606963755;20892.582148357025;21977.780222197773;21157.94210289487;21948.670769938464;22082.558348833052;22396.77603223967;22521.774782252174;5783.2481777368985;5886.5577933406375;6111.847203819918;6117.755289788425;6123.693815309217;5488.423715509874;6056.212692349988;6061.393860613947;6074.301455332627;6077.483413909823;5832.854178645525;5891.970540147293;5894.616849904743;5909.556783241253;6029.155918171459;6036.2152920120325;6121.265448146251;6206.224221972254;6208.937910620881;6222.782202622909;5715.742791574347;6026.2165918430765;6076.240469941257;6089.421504957022;6101.2983506896835;21708.565828683495;23526.411839703975;24031.639525407132;24081.87959060211;26061;2626.3434141464636;2637.3933995181023;2661.8504587338484;2678.812483126182;2745.203890871645;10234.1300989416;16994.83005169945;17090.572735681584;17542.649147017117;17629.823701762947;1940.5245714799964;2018.1422895269598;2072.4818795301176;2089.352300786761;2177.1617927098023;156648;160146.19926900408;161193.19403403025;161498;165859;13994.758160590898;19523.414297571097;22097.44756381071;23320.65019024716;23389.883050584638;35906.563737450735;40567.39148912769;40676.59323406787;40726;40920.59079409168;9031.412958157698;10917.290376125526;11016.686495835804;11163.274387164809;11252.26860254081;8774.517401542977;8813.030566637664;8823.779405514913;8958.700988356783;8971.50656713874;10865.348079115278;10925.399103049249;11025.007749302602;11034.834477482844;11186.664400068012;4054.736442131252;4131.029208136086;4158.355454904495;4161.625453709181;4175.707700460999;1002.9749256268651;1005.9044390782864;1017.8549132226245;1058.629479682105;1061.0185578340158;20619.4845128873;22166.778332216792;22193.778062219495;22222;22242.555148897256;1027.768752030802;1059.502034043998;1071.2982996137541;1073.098597178374;1078.800421921947;8740.475571465733;10280.331778434378;10576.471176441148;11490.965813076697;11566.19036667442;634157;694830;721800;753882;756232;149953;151239;153991;155447;157112.64753962925;980.8136454073704;989.4113002763488;1008.5713571732131;1010.5806090472519;1014.3913651808856;18969.43091707251;19522.707159392903;19572.021398930283;19674.803251967296;19812;59413.40586594079;60245;60248.69875650594;60360;61326.69336653288;64404.67797660982;85421;87475.1252487467;89525;90586.54706726424;6860.8284792878585;8476.49141051539;8699.826003480022;8731.65073397057;8916.33127515426;12553.186182815813;13018.674533136747;13455;13934.721305573628;14103.224322662352;11232.831507527557;11383;11718.472668729757;11842.881571184178;11844.933955944007;9875.40747555149;10712.410817405118;11312.264702794291;11424.942875285571;11592.6522204334;6135.417135372132;7711.614419278902;11497.48261328259;11834.881651183377;11846.170768046153;7331.926680733124;7539.095308562788;8423.8736418955;8772.868406974028;8816.162464565856;10122.392656440637;10766;11109.722256943642;11310.547578096784;11370.31778093317 03:07:50 INFO - PROCESS | 2908 | |3;mootools.html;1456.8688818006378;1467;1469.7942288079666;1482.3181336585171;1489.4712377106127;8042.276195142436;8434.072252052269;8439.409241353107;8445.873311900326;8450.746477605673;6689.498287628435;7376.336129748322;7693.384529237647;8264.462809917351;8266.132056134094;2254.875981820999;2324.4769926766426;2332.836701430892;2332.8600283982933;2338.695969523968;2332.2536788227776;2356.528694261146;2375.70303712036;2377.476955069882;2380.5000949800565;1941.4078705994666;2319.802816760569;2348.0490401387465;2354.5761762882676;2357.375295546673;2177.7277840269967;2306.192832508617;2316.5366926614574;2318.211807985276;2338.1115176232925;2077.210659949225;2367.147826782357;2370.810335173182;2370.8696021718797;2371.5731168389857;8289.212524810133;8373.874391884126;8381.11998240182;8386.454880432813;8386.8322633547;4979.427365852901;5132.692038477666;5143.665661732013;5144.61415393847;5145.922811157836;3148.9685103148904;3306.553615261957;3488.2674638325984;3506.7019303359243;3542.8051457169845;1208.9516419343215;1222.0773316146253;1239.6714870559308;1244.9688757781037;1258.4211262819022;10528.84206736892;10651.733706657318;10775.568977240979;10786.946065269702;10828.025477707044;4331.761753103547;4590.678652494294;4651.511591282934;4653.813847446064;4664.580187783115;9432;9455.952720236492;9465.52672366379;9468.053194680615;9487.288453366025;4466.441694788152;5177;5204.375474943031;5211.088059589557;5232.3459567554055;4250;4412.911741765147;4443.933340999887;4554.203014472454;4671.299305104261;3732.869349572752;3782.3759079751535;3863.7681739095183;3876.050367659885;3903.2583809076186;1235.975280494385;1254.8996080313552;1260.3005332040805;1276.942537585811;1277.0613599004723;878.1306506558461;904.0507467159588;909.8771665825161;935.2377812083131;940.9294401965062;5427.457254274541;5576.9163462548095;5729.169270455761;5836.182934389189;5902.675352855634;855.2858363266618;861.9396642235109;953.7186529973675;985.6693463823924;994.5673631970116;3610.494530765695;3684.963150368462;3803.0682482791894;3906.511686039245;4024.215278020758;9824.705258842247;10021.348612340174;10067.144292735053;10072.899271007343;10086.848697269546;9997.650082247086;10024;10025.849612255823;10041.548130334153;10050.899491004997;7319.268073192745;7734.690612375442;7926.8810967835525;7940.722074727472;7953.443258971816;5199.324087868553;5227.503387178212;5530.723463826873;5546.168074788814;5836.328822185503;8867.91132088671;8894.28845692356;9076.183143517115;9236.30727695439;9263.212626926786;8941.46351218929;9092.408993415407;9244.352895297265;9294.302927280616;9311.649810777264;7149.857002860018;7366.447516436396;7367.484276100621;7599.01212842327;7833.09919359281;7306.2693730626515;7549.849003019799;7562.810929726801;7568.772936811904;7597.88603170964;7108.289171082851;7111.217766045627;7189.7483588074165;7217.639118043971;7249.383802376857;6774.153230846145;6861.416779573592;7013.614251216232;7025.964870175617;7079;6352.9047064293145;6363.427291543783;6456.515761317826;6456.515761318014;6461.224653041665;4768.189407800752;4769.57073863354;4945.159322915185;5013.373328333958;5037.622178336566;4851.175300198904;4929.876753081202;5024.57291130258;5077.492250774893;5097.337346144977 03:07:50 INFO - PROCESS | 2908 | |4;prototype.html;296.8797636957033;330.0626221530852;349.4422364303132;360.9512715783369;369.5306960160596;4998.675086119404;5087.5421212090905;5094.388673359193;5095.929854730506;5146.382434107913;3952.565217826037;4699;4764.428268607772;4834.25069114287;4984.261803647265;3408.982955085221;3951.2097580483874;3978.482797236355;4009.6391324780766;4020.6180412860876;3627.8209581885862;3814.150137183464;3975.860844870416;4025.476688030552;4042.6765858731233;3768.171002379472;3896.649301562859;3950.5851885551892;3951.8857411284966;3994.04143005678;3665.78005319679;3712.795796231206;3897.5322961244833;3927.607239276078;3979.602039796026;3086.8147911125407;3101.5037593984853;3300.9106994691692;3340.3987282289177;3493.388656985043;4695.929561056587;4811.350467686852;4944.629152813517;4960.87597810054;5008.69947803133;4318.519139451986;4511.796969136397;4555.020670555813;4560.247559152735;4563.927477042892;4890.168671325848;5315.6013299002725;5315.707636080014;5331.760070796823;5335.359756829166;3621.963780362189;3653.1232504199065;3864.574896761354;3886.028492876781;3900.941485877714;5237.559671090443;5497.835064948058;5552.861663359002;5560.610757246995;5681.261436013333;3936.7834769087403;3938.306528192847;3951.585083566184;3958.267720471722;3971.5844373838477;3996.18078293949;4003.6396724294955;4018.457508236409;4020.8592699255387;4068.3694027425795;4269.615734583902;4503.887402814956;4549.27211646135;4560.315952607069;4591.632669386441;5101.897962040813;5315.3621565412395;5332.760025798849;5352.223927530564;5437.564994800407;1064.7391389109719;1089.9645336929948;1174.467320147199;1294.6310301564008;1312.7308901675133;847.7541512961295;876.9824603507894;888.6534251641865;931.1293940165966;959.7810780308969;4076.6331030207425;4098.959010409858;4587.944772702231;4730.266808644666;4754.881127971828;4698.2952557116705;5008.524190201925;5148.4079330876675;5164.638475306768;5182.300389447376;4129.501651500859;4349.847755328548;4504.986378064975;4699.224627936421;4765.380500534909;2615.9476810463684;2664.960665340519;2675.7725593324785;2686.2344231893817;2691.8788654510595;4628.467726211461;5348.973255133699;5381.838544843661;5402.675839449567;5442.482964118402;4612.238980568169;4668.292390413552;5195.272661827347;5269.076786972727;5348.705821179872;5077.517635824591;5705.800296989585;5710.5159255723065;5719.826465942915;5744.368119506851;4604.973811522919;5242.842714718565;5301.310829592128;5435.510804027656;5503.147012213113;4979;5331.866703332447;5418.155468379133;5441.700706461024;5460.863478412913;5486.396496385474;5733.971330143323;5756.2229099072765;5793.652380856994;5795.507381872588;3408.3694516514524;3678.816059197083;3696.3900956341904;3721.553413590278;3752.3058234226755;4796.424429068534;5440.156775699773;5440.863978400572;5484;5531.529819965348;4527.592516673515;5246.501582349671;5311.141100614908;5342.43904390049;5363.490468405495;4297.8495752648505;4727.550882666142;5052.459000005034;5059.721715305694;5255.527002569787;4465.575770301816;4861.586765124863;5195.19474481456;5196.53231209193;5204.635675502678;4106.199291138199;5036.514228302733;5124.8718782029255;5154.5103215194495;5275.338268445427;4642.373279607345;4930.211166213388;5139.526404379324;5162.793488260578;5164.406093299319 03:07:50 INFO - PROCESS | 2908 | |5;yui.html;717.5407739047007;753.036113774369;771.9771303023496;822.2271065198713;825.1130035212146;15187.088774673513;15216.315265813037;15941.601459963507;15990.760138597916;16007.439739609115;14517.854821451783;14681.926590367033;14684.192369419678;14685.412583496647;14694.55916322512;685.9691313890875;709.2481969112757;715.1275443958389;852.9658813647478;867.119873328572;858.8754630578562;873.6549063120063;873.9169778870997;876.0844917061686;876.128252388874;928.0626567167176;928.3779867488765;930.1767935377172;930.1814403325064;931.0875342164683;721.2967356827052;744.4900243333334;892.6072528087685;923.7367350305165;925.1950802801539;684.7603338831369;692.8926016467406;693.2686016252851;693.3205458650551;695.0443140681563;14842.109473431521;15580;15620.656901464758;15621.531354059396;15640.296186671627;13976.091554048955;13992.510262140777;14052.578422647337;14083.014189006773;14387.136771793726;12600;12636.49454021838;12871.22772633645;13290.601281961557;13335.86664133356;4024.9195016099516;4486.416765820455;4536.319552067216;4541.772911354452;4726.361941137937;104810.95189048088;106388.40417393745;106541;106876;107779;11053.889461105447;11213.551457941754;11285.830712539318;11318.26431281964;11525.48135333912;21994.780052199592;22521.211757588735;22616.434589135402;22648.094076237096;22767.31698049061;7771.650275737606;7777.338926191224;7833.1775163608145;7975.920240797634;8005.518289330326;4208.642265407413;4229.661627069827;4293.592108749664;4294.398784170218;4366.978165109218;3355.4128027595075;3432.3993301172195;3454.689077982943;3460.740444466625;3713.1459764254373;716.3159182980241;718.2530168624677;719.341802250945;738.1437532462318;740.326303064209;672.2370109925172;686.7459040155074;707.6320313436984;721.7546034348346;733.2484203691259;10197.847032294521;10261.9486902565;10380.688579342632;10427.701402527247;10689.83965240522;676.4351766275215;685.6297599296324;695.2178798851293;696.6725638949686;699.6991293743739;4553.749543775058;4832.9850731346105;4863.05785000077;5025.396952365666;5484.122540393598;95876;96123.73856455687;98232.52651210094;98262.34583312471;98646;84829.72755408674;85749.14250857412;85859.57070214734;86649.13350866537;87854.56072719724;73929;74201.25798742051;74218.25781742329;74350;76490.08774780676;9764.462954537568;10793.514291857042;10868.510917008596;10909.454527273447;10918.071963882841;39034;48917.510824891295;49080;49572;50035.49964500308;64696.2380909531;64995.025074624864;65207.67396163179;66193;67150.66424667845;11100.722481938015;12841.807372889227;13024.674383140118;13322.600321990356;13442.865571344553;14345.856541434452;14857.405703771728;14893.627659308171;14951.551453456414;15052.774208387102;13689.315534223448;13921.721565568834;14121.2939353034;14125;14437;13608.591742247749;13801.309934503435;14141.43434262618;14385.424583016562;14609.196494192496;13324;13491.86508134906;13603.523876664269;13790.172589644653;14100.36548355347;9987.750306242402;10487.685369438928;10572.36565806054;10645.680629581126;11154.88845111571;9359.438433694;10966.890331096905;11185.608503702331;11191.216614836883;11254.324740515594 03:07:50 INFO - PROCESS | 2908 | __end_tp_report 03:07:50 INFO - PROCESS | 2908 | __start_cc_report 03:07:50 INFO - PROCESS | 2908 | _x_x_mozilla_cycle_collect,1497 03:07:50 INFO - PROCESS | 2908 | __end_cc_report 03:07:50 INFO - PROCESS | 2908 | __startTimestamp1484737670718__endTimestamp 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | ------- Summary: start ------- 03:07:50 INFO - PROCESS | 2908 | Number of tests: 6 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#0] dojo.html Cycles:165 Average:5640.05 Median:5803.62 stddev:631.39 (10.9%) stddev-sans-first:605.26 03:07:50 INFO - PROCESS | 2908 | Values: 3266.7 3276.8 3278.8 3325.3 3325.8 5487.0 5536.4 5550.8 5584.1 5598.8 5521.3 5548.8 5607.8 5653.2 5686.7 5026.3 5050.1 5056.5 5094.4 5121.4 5084.1 5155.7 5179.6 5196.8 5236.3 5004.8 5119.5 5137.5 5145.4 5177.1 5041.6 5045.0 5099.6 5115.0 5116.5 5088.3 5100.6 5112.8 5120.0 5153.2 5578.5 5592.7 5610.2 5614.8 5624.6 5941.6 6012.0 6128.0 6139.4 6150.1 6100.6 6103.0 6133.6 6187.4 6260.2 5705.0 5706.7 5714.2 5722.8 5748.5 6180.4 6289.9 6307.6 6313.1 6339.9 5839.8 5892.8 5903.6 5961.1 5974.4 6106.7 6107.4 6114.9 6119.2 6125.3 5057.0 6098.6 6112.9 6127.5 6134.9 6134.5 6137.0 6139.8 6145.7 6157.7 4942.1 4944.7 4946.3 4948.0 4958.1 4362.0 4372.4 4389.0 4392.5 4398.6 5795.4 5798.4 5819.0 5823.9 5864.5 6216.5 6217.9 6224.3 6234.2 6252.5 5636.9 5674.6 5687.6 5698.7 5790.4 5322.6 5389.5 5420.8 5447.6 5454.8 6297.2 6311.6 6312.5 6319.7 6323.7 6003.9 6188.8 6209.9 6219.2 6241.7 6167.7 6223.4 6245.0 6264.5 6304.2 4883.7 6046.4 6055.5 6059.9 6110.0 6013.4 6027.8 6073.6 6088.6 6134.2 5926.4 5954.8 5966.9 5979.3 5988.1 4908.9 5740.9 5814.2 5816.9 5833.6 5775.9 5786.5 5786.9 5811.0 5843.7 5955.2 5971.2 5990.7 5994.5 5997.1 5633.0 5670.5 5679.5 5803.6 5807.6 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#1] ext.html Cycles:180 Average:67931.05 Median:34849.39 stddev:147332.59 (422.8%) stddev-sans-first:147658.85 03:07:50 INFO - PROCESS | 2908 | Values: 475.4 486.2 493.0 495.9 502.0 25735.0 32063.4 39122.0 41161.0 41415.8 42474.9 42496.0 42927.8 43028.1 43036.8 8383.5 8617.2 9130.2 9320.9 9350.8 10915.0 11196.4 11217.0 11364.0 11385.4 11079.0 11151.7 11163.6 11182.8 11183.8 10464.6 11074.3 11134.9 11145.4 11157.3 11027.8 11074.8 11080.3 11085.9 11097.6 40380.0 40644.6 40705.6 40827.8 40837.4 3927.5 3979.3 4014.1 4016.5 4115.9 29729.9 30599.4 30860.2 30892.8 31181.1 3096.1 3207.3 3256.9 3274.7 3315.2 480197.0 484000.0 484129.0 486581.6 486710.0 63553.0 63780.7 64154.7 64170.4 64183.0 65982.7 66086.0 66088.7 66180.3 66214.4 15748.1 15969.5 16004.7 16009.2 16034.4 10932.1 11214.3 12049.5 12069.3 12114.6 17417.4 17706.8 17953.1 17978.3 17980.5 7600.5 7626.4 7714.8 7717.7 7761.4 757.8 881.1 914.0 916.8 927.9 28528.0 28791.7 29638.9 30368.0 30470.0 971.5 1003.7 1030.4 1053.2 1061.7 12922.8 13868.7 14466.3 14576.8 14706.4 611635.0 614987.0 616696.8 617416.0 617478.6 52114.7 52300.5 52402.7 52459.7 52598.5 1392.4 1417.4 1438.7 1444.9 1446.9 25568.5 27375.6 27434.9 27484.5 27548.4 50289.7 51292.5 51296.7 51308.0 51499.0 544084.0 546221.0 546789.0 548263.0 549769.0 24307.0 24496.6 24847.6 24851.5 24868.3 43426.0 43495.6 43897.6 43934.1 44006.0 32458.8 33978.8 34157.7 36235.5 36508.6 34685.5 35013.3 35111.8 36006.5 36029.0 34541.8 35041.0 35082.0 35232.6 35374.6 27889.9 28291.9 31447.7 31479.4 31584.0 21888.7 23024.9 23169.8 23249.2 23292.3 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#2] jquery.html Cycles:180 Average:41938.89 Median:22459.28 stddev:119607.06 (532.6%) stddev-sans-first:119901.86 03:07:50 INFO - PROCESS | 2908 | Values: 368.5 368.6 384.8 398.7 417.6 15346.6 16984.8 20112.3 20892.6 21977.8 21157.9 21948.7 22082.6 22396.8 22521.8 5783.2 5886.6 6111.8 6117.8 6123.7 5488.4 6056.2 6061.4 6074.3 6077.5 5832.9 5892.0 5894.6 5909.6 6029.2 6036.2 6121.3 6206.2 6208.9 6222.8 5715.7 6026.2 6076.2 6089.4 6101.3 21708.6 23526.4 24031.6 24081.9 26061.0 2626.3 2637.4 2661.9 2678.8 2745.2 10234.1 16994.8 17090.6 17542.6 17629.8 1940.5 2018.1 2072.5 2089.4 2177.2 156648.0 160146.2 161193.2 161498.0 165859.0 13994.8 19523.4 22097.4 23320.7 23389.9 35906.6 40567.4 40676.6 40726.0 40920.6 9031.4 10917.3 11016.7 11163.3 11252.3 8774.5 8813.0 8823.8 8958.7 8971.5 10865.3 10925.4 11025.0 11034.8 11186.7 4054.7 4131.0 4158.4 4161.6 4175.7 1003.0 1005.9 1017.9 1058.6 1061.0 20619.5 22166.8 22193.8 22222.0 22242.6 1027.8 1059.5 1071.3 1073.1 1078.8 8740.5 10280.3 10576.5 11491.0 11566.2 634157.0 694830.0 721800.0 753882.0 756232.0 149953.0 151239.0 153991.0 155447.0 157112.6 980.8 989.4 1008.6 1010.6 1014.4 18969.4 19522.7 19572.0 19674.8 19812.0 59413.4 60245.0 60248.7 60360.0 61326.7 64404.7 85421.0 87475.1 89525.0 90586.5 6860.8 8476.5 8699.8 8731.7 8916.3 12553.2 13018.7 13455.0 13934.7 14103.2 11232.8 11383.0 11718.5 11842.9 11844.9 9875.4 10712.4 11312.3 11424.9 11592.7 6135.4 7711.6 11497.5 11834.9 11846.2 7331.9 7539.1 8423.9 8772.9 8816.2 10122.4 10766.0 11109.7 11310.5 11370.3 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#3] mootools.html Cycles:180 Average:5411.71 Median:5138.18 stddev:2936.62 (57.2%) stddev-sans-first:2929.82 03:07:50 INFO - PROCESS | 2908 | Values: 1456.9 1467.0 1469.8 1482.3 1489.5 8042.3 8434.1 8439.4 8445.9 8450.7 6689.5 7376.3 7693.4 8264.5 8266.1 2254.9 2324.5 2332.8 2332.9 2338.7 2332.3 2356.5 2375.7 2377.5 2380.5 1941.4 2319.8 2348.0 2354.6 2357.4 2177.7 2306.2 2316.5 2318.2 2338.1 2077.2 2367.1 2370.8 2370.9 2371.6 8289.2 8373.9 8381.1 8386.5 8386.8 4979.4 5132.7 5143.7 5144.6 5145.9 3149.0 3306.6 3488.3 3506.7 3542.8 1209.0 1222.1 1239.7 1245.0 1258.4 10528.8 10651.7 10775.6 10786.9 10828.0 4331.8 4590.7 4651.5 4653.8 4664.6 9432.0 9456.0 9465.5 9468.1 9487.3 4466.4 5177.0 5204.4 5211.1 5232.3 4250.0 4412.9 4443.9 4554.2 4671.3 3732.9 3782.4 3863.8 3876.1 3903.3 1236.0 1254.9 1260.3 1276.9 1277.1 878.1 904.1 909.9 935.2 940.9 5427.5 5576.9 5729.2 5836.2 5902.7 855.3 861.9 953.7 985.7 994.6 3610.5 3685.0 3803.1 3906.5 4024.2 9824.7 10021.3 10067.1 10072.9 10086.8 9997.7 10024.0 10025.8 10041.5 10050.9 7319.3 7734.7 7926.9 7940.7 7953.4 5199.3 5227.5 5530.7 5546.2 5836.3 8867.9 8894.3 9076.2 9236.3 9263.2 8941.5 9092.4 9244.4 9294.3 9311.6 7149.9 7366.4 7367.5 7599.0 7833.1 7306.3 7549.8 7562.8 7568.8 7597.9 7108.3 7111.2 7189.7 7217.6 7249.4 6774.2 6861.4 7013.6 7026.0 7079.0 6352.9 6363.4 6456.5 6456.5 6461.2 4768.2 4769.6 4945.2 5013.4 5037.6 4851.2 4929.9 5024.6 5077.5 5097.3 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#4] prototype.html Cycles:180 Average:4315.30 Median:4728.91 stddev:1288.32 (27.2%) stddev-sans-first:1256.13 03:07:50 INFO - PROCESS | 2908 | Values: 296.9 330.1 349.4 361.0 369.5 4998.7 5087.5 5094.4 5095.9 5146.4 3952.6 4699.0 4764.4 4834.3 4984.3 3409.0 3951.2 3978.5 4009.6 4020.6 3627.8 3814.2 3975.9 4025.5 4042.7 3768.2 3896.6 3950.6 3951.9 3994.0 3665.8 3712.8 3897.5 3927.6 3979.6 3086.8 3101.5 3300.9 3340.4 3493.4 4695.9 4811.4 4944.6 4960.9 5008.7 4318.5 4511.8 4555.0 4560.2 4563.9 4890.2 5315.6 5315.7 5331.8 5335.4 3622.0 3653.1 3864.6 3886.0 3900.9 5237.6 5497.8 5552.9 5560.6 5681.3 3936.8 3938.3 3951.6 3958.3 3971.6 3996.2 4003.6 4018.5 4020.9 4068.4 4269.6 4503.9 4549.3 4560.3 4591.6 5101.9 5315.4 5332.8 5352.2 5437.6 1064.7 1090.0 1174.5 1294.6 1312.7 847.8 877.0 888.7 931.1 959.8 4076.6 4099.0 4587.9 4730.3 4754.9 4698.3 5008.5 5148.4 5164.6 5182.3 4129.5 4349.8 4505.0 4699.2 4765.4 2615.9 2665.0 2675.8 2686.2 2691.9 4628.5 5349.0 5381.8 5402.7 5442.5 4612.2 4668.3 5195.3 5269.1 5348.7 5077.5 5705.8 5710.5 5719.8 5744.4 4605.0 5242.8 5301.3 5435.5 5503.1 4979.0 5331.9 5418.2 5441.7 5460.9 5486.4 5734.0 5756.2 5793.7 5795.5 3408.4 3678.8 3696.4 3721.6 3752.3 4796.4 5440.2 5440.9 5484.0 5531.5 4527.6 5246.5 5311.1 5342.4 5363.5 4297.8 4727.6 5052.5 5059.7 5255.5 4465.6 4861.6 5195.2 5196.5 5204.6 4106.2 5036.5 5124.9 5154.5 5275.3 4642.4 4930.2 5139.5 5162.8 5164.4 03:07:50 INFO - PROCESS | 2908 | 03:07:50 INFO - PROCESS | 2908 | [#5] yui.html Cycles:180 Average:20227.12 Median:4261.63 stddev:28428.08 (667.1%) stddev-sans-first:28470.08 03:07:50 INFO - PROCESS | 2908 | Values: 717.5 753.0 772.0 822.2 825.1 15187.1 15216.3 15941.6 15990.8 16007.4 14517.9 14681.9 14684.2 14685.4 14694.6 686.0 709.2 715.1 853.0 867.1 858.9 873.7 873.9 876.1 876.1 928.1 928.4 930.2 930.2 931.1 721.3 744.5 892.6 923.7 925.2 684.8 692.9 693.3 693.3 695.0 14842.1 15580.0 15620.7 15621.5 15640.3 13976.1 13992.5 14052.6 14083.0 14387.1 12600.0 12636.5 12871.2 13290.6 13335.9 4024.9 4486.4 4536.3 4541.8 4726.4 104811.0 106388.4 106541.0 106876.0 107779.0 11053.9 11213.6 11285.8 11318.3 11525.5 21994.8 22521.2 22616.4 22648.1 22767.3 7771.7 7777.3 7833.2 7975.9 8005.5 4208.6 4229.7 4293.6 4294.4 4367.0 3355.4 3432.4 3454.7 3460.7 3713.1 716.3 718.3 719.3 738.1 740.3 672.2 686.7 707.6 721.8 733.2 10197.8 10261.9 10380.7 10427.7 10689.8 676.4 685.6 695.2 696.7 699.7 4553.7 4833.0 4863.1 5025.4 5484.1 95876.0 96123.7 98232.5 98262.3 98646.0 84829.7 85749.1 85859.6 86649.1 87854.6 73929.0 74201.3 74218.3 74350.0 76490.1 9764.5 10793.5 10868.5 10909.5 10918.1 39034.0 48917.5 49080.0 49572.0 50035.5 64696.2 64995.0 65207.7 66193.0 67150.7 11100.7 12841.8 13024.7 13322.6 13442.9 14345.9 14857.4 14893.6 14951.6 15052.8 13689.3 13921.7 14121.3 14125.0 14437.0 13608.6 13801.3 14141.4 14385.4 14609.2 13324.0 13491.9 13603.5 13790.2 14100.4 9987.8 10487.7 10572.4 10645.7 11154.9 9359.4 10966.9 11185.6 11191.2 11254.3 03:07:50 INFO - PROCESS | 2908 | -------- Summary: end -------- 03:07:50 INFO - PROCESS | 2908 | 03:07:51 INFO - TEST-INFO | 2908: exit 0 03:07:51 INFO - TEST-OK | dromaeo_css | took 1119260ms 03:07:51 INFO - TEST-START | kraken 03:07:51 INFO - operating with platform_type : mac_ 03:07:51 INFO - Initialising browser for kraken test... 03:07:51 INFO - TEST-INFO | started process 2912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpcil8tS/profile http://localhost:56689/getInfo.html) 03:07:53 INFO - PROCESS | 2912 | __metrics Screen width/height:1600/1200 03:07:53 INFO - PROCESS | 2912 | colorDepth:24 03:07:53 INFO - PROCESS | 2912 | Browser inner width/height: 1024/689 03:07:53 INFO - PROCESS | 2912 | __metrics 03:07:53 INFO - PROCESS | 2912 | 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" 03:07:53 INFO - PROCESS | 2912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:54 INFO - TEST-INFO | 2912: exit 0 03:07:54 INFO - Browser initialized. 03:07:54 INFO - Running cycle 1/1 for kraken test... 03:07:54 INFO - TEST-INFO | started process 2913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpcil8tS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:06 INFO - PROCESS | 2913 | RSS: Main: 235376640 03:08:06 INFO - PROCESS | 2913 | 03:08:09 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56689/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:10 INFO - PROCESS | 2913 | RSS: Main: 287891456 03:08:10 INFO - PROCESS | 2913 | 03:08:12 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56689/tests/kraken/driver.html?testName=audio-dft) 03:08:13 INFO - PROCESS | 2913 | RSS: Main: 288251904 03:08:13 INFO - PROCESS | 2913 | 03:08:16 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56689/tests/kraken/driver.html?testName=audio-fft) 03:08:17 INFO - PROCESS | 2913 | RSS: Main: 380583936 03:08:17 INFO - PROCESS | 2913 | 03:08:19 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56689/tests/kraken/driver.html?testName=audio-oscillator) 03:08:20 INFO - PROCESS | 2913 | RSS: Main: 284545024 03:08:20 INFO - PROCESS | 2913 | 03:08:22 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:22 INFO - PROCESS | 2913 | RSS: Main: 286650368 03:08:22 INFO - PROCESS | 2913 | 03:08:25 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56689/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:26 INFO - PROCESS | 2913 | RSS: Main: 327299072 03:08:26 INFO - PROCESS | 2913 | 03:08:29 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56689/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:30 INFO - PROCESS | 2913 | RSS: Main: 329256960 03:08:30 INFO - PROCESS | 2913 | 03:08:32 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56689/tests/kraken/driver.html?testName=json-parse-financial) 03:08:33 INFO - PROCESS | 2913 | RSS: Main: 327032832 03:08:33 INFO - PROCESS | 2913 | 03:08:34 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:35 INFO - PROCESS | 2913 | RSS: Main: 303652864 03:08:35 INFO - PROCESS | 2913 | 03:08:37 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:38 INFO - PROCESS | 2913 | RSS: Main: 306323456 03:08:38 INFO - PROCESS | 2913 | 03:08:40 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:41 INFO - PROCESS | 2913 | RSS: Main: 307613696 03:08:41 INFO - PROCESS | 2913 | 03:08:43 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:44 INFO - PROCESS | 2913 | RSS: Main: 319676416 03:08:44 INFO - PROCESS | 2913 | 03:08:47 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:48 INFO - PROCESS | 2913 | RSS: Main: 318787584 03:08:48 INFO - PROCESS | 2913 | 03:08:49 INFO - PROCESS | 2913 | Cycle 1(1): loaded http://localhost:56689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56689/tests/kraken/driver.html?testName=ai-astar) 03:08:50 INFO - PROCESS | 2913 | RSS: Main: 363151360 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | __start_tp_report 03:08:50 INFO - PROCESS | 2913 | _x_x_mozilla_page_load 03:08:50 INFO - PROCESS | 2913 | _x_x_mozilla_page_load_details 03:08:50 INFO - PROCESS | 2913 | |i|pagename|runs| 03:08:50 INFO - PROCESS | 2913 | |0;ai-astar;114;114;115;114;114;114;114;113;113;115 03:08:50 INFO - PROCESS | 2913 | |1;audio-beat-detection;149;111;111;148;114;111;115;134;115;127 03:08:50 INFO - PROCESS | 2913 | |2;audio-dft;187;183;184;186;184;185;184;186;184;191 03:08:50 INFO - PROCESS | 2913 | |3;audio-fft;84;58;58;91;62;73;89;83;90;58 03:08:50 INFO - PROCESS | 2913 | |4;audio-oscillator;90;71;86;70;68;69;82;69;68;83 03:08:50 INFO - PROCESS | 2913 | |5;imaging-gaussian-blur;90;88;91;89;91;87;91;88;90;88 03:08:50 INFO - PROCESS | 2913 | |6;imaging-darkroom;101;88;132;92;135;150;98;97;96;96 03:08:50 INFO - PROCESS | 2913 | |7;imaging-desaturate;87;88;86;88;87;88;88;90;88;87 03:08:50 INFO - PROCESS | 2913 | |8;json-parse-financial;56;55;55;54;56;56;55;56;56;56 03:08:50 INFO - PROCESS | 2913 | |9;json-stringify-tinderbox;72;82;79;79;74;73;73;73;72;73 03:08:50 INFO - PROCESS | 2913 | |10;stanford-crypto-aes;86;86;87;84;77;84;104;107;94;87 03:08:50 INFO - PROCESS | 2913 | |11;stanford-crypto-ccm;144;133;142;141;140;140;141;138;227;152 03:08:50 INFO - PROCESS | 2913 | |12;stanford-crypto-pbkdf2;175;175;175;175;171;174;174;172;174;170 03:08:50 INFO - PROCESS | 2913 | |13;stanford-crypto-sha256-iterative;66;68;69;67;68;67;66;67;68;66 03:08:50 INFO - PROCESS | 2913 | __end_tp_report 03:08:50 INFO - PROCESS | 2913 | __start_cc_report 03:08:50 INFO - PROCESS | 2913 | _x_x_mozilla_cycle_collect,1994 03:08:50 INFO - PROCESS | 2913 | __end_cc_report 03:08:50 INFO - PROCESS | 2913 | __startTimestamp1484737730230__endTimestamp 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | ------- Summary: start ------- 03:08:50 INFO - PROCESS | 2913 | Number of tests: 14 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:08:50 INFO - PROCESS | 2913 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 113.0 115.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:121.00 stddev:15.19 (12.6%) stddev-sans-first:13.01 03:08:50 INFO - PROCESS | 2913 | Values: 149.0 111.0 111.0 148.0 114.0 111.0 115.0 134.0 115.0 127.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:2.32 (1.3%) stddev-sans-first:2.39 03:08:50 INFO - PROCESS | 2913 | Values: 187.0 183.0 184.0 186.0 184.0 185.0 184.0 186.0 184.0 191.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#3] audio-fft Cycles:10 Average:74.60 Median:83.50 stddev:14.38 (17.2%) stddev-sans-first:14.84 03:08:50 INFO - PROCESS | 2913 | Values: 84.0 58.0 58.0 91.0 62.0 73.0 89.0 83.0 90.0 58.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.60 (11.2%) stddev-sans-first:7.38 03:08:50 INFO - PROCESS | 2913 | Values: 90.0 71.0 86.0 70.0 68.0 69.0 82.0 69.0 68.0 83.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:90.00 stddev:1.49 (1.7%) stddev-sans-first:1.56 03:08:50 INFO - PROCESS | 2913 | Values: 90.0 88.0 91.0 89.0 91.0 87.0 91.0 88.0 90.0 88.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.00 stddev:21.81 (23.2%) stddev-sans-first:22.96 03:08:50 INFO - PROCESS | 2913 | Values: 101.0 88.0 132.0 92.0 135.0 150.0 98.0 97.0 96.0 96.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#7] imaging-desaturate Cycles:10 Average:87.70 Median:88.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 03:08:50 INFO - PROCESS | 2913 | Values: 87.0 88.0 86.0 88.0 87.0 88.0 88.0 90.0 88.0 87.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:0.71 (1.3%) stddev-sans-first:0.73 03:08:50 INFO - PROCESS | 2913 | Values: 56.0 55.0 55.0 54.0 56.0 56.0 55.0 56.0 56.0 56.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#9] json-stringify-tinderbox Cycles:10 Average:75.00 Median:73.50 stddev:3.59 (4.9%) stddev-sans-first:3.64 03:08:50 INFO - PROCESS | 2913 | Values: 72.0 82.0 79.0 79.0 74.0 73.0 73.0 73.0 72.0 73.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.00 stddev:9.37 (10.9%) stddev-sans-first:9.85 03:08:50 INFO - PROCESS | 2913 | Values: 86.0 86.0 87.0 84.0 77.0 84.0 104.0 107.0 94.0 87.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:141.50 stddev:27.54 (19.5%) stddev-sans-first:29.13 03:08:50 INFO - PROCESS | 2913 | Values: 144.0 133.0 142.0 141.0 140.0 140.0 141.0 138.0 227.0 152.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:1.84 (1.1%) stddev-sans-first:1.87 03:08:50 INFO - PROCESS | 2913 | Values: 175.0 175.0 175.0 175.0 171.0 174.0 174.0 172.0 174.0 170.0 03:08:50 INFO - PROCESS | 2913 | 03:08:50 INFO - PROCESS | 2913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 03:08:50 INFO - PROCESS | 2913 | Values: 66.0 68.0 69.0 67.0 68.0 67.0 66.0 67.0 68.0 66.0 03:08:50 INFO - PROCESS | 2913 | -------- Summary: end -------- 03:08:50 INFO - PROCESS | 2913 | 03:08:51 INFO - TEST-INFO | 2913: exit 0 03:08:51 INFO - TEST-OK | kraken | took 59774ms 03:08:51 INFO - SUITE-END | took 1179s 03:08:51 INFO - Completed test suite (00:19:39) 03:08:51 INFO - javascript benchmark 03:08:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.7386609071277, 3276.7542434317425, 3278.8196649184283, 3325.268440942995, 3325.7671962962586, 5487.039768040597, 5536.446355364462, 5550.750216240269, 5584.078627026536, 5598.83203503895, 5521.282233309674, 5548.833534993946, 5607.831765047045, 5653.180288858113, 5686.687232202227, 5026.346574945252, 5050.090983622947, 5056.469070747574, 5094.388673359202, 5121.385433747955, 5084.135696931512, 5155.690658560479, 5179.61152913533, 5196.844094677147, 5236.293100431431, 5004.799808007675, 5119.513646203604, 5137.51193636604, 5145.3568303962, 5177.145770947789, 5041.571466425358, 5044.9747751261375, 5099.59203263738, 5114.974425127888, 5116.513931176532, 5088.287639730441, 5100.591952643779, 5112.846614601568, 5120.0, 5153.201253805666, 5578.525825304854, 5592.692401917893, 5610.242617246701, 5614.775408983635, 5624.5781566382275, 5941.584089113764, 6011.969940150271, 6128.0, 6139.355367686418, 6150.138980542728, 6100.5574390564525, 6102.974033066861, 6133.6319820810895, 6187.412195841388, 6260.186175797163, 5705.030144875381, 5706.743196556165, 5714.171445140431, 5722.828315150552, 5748.511376532958, 6180.443760061616, 6289.905651415233, 6307.5584709070845, 6313.084602732578, 6339.873202536016, 5839.766409343663, 5892.764289428461, 5903.645781253139, 5961.105834124916, 5974.40255974399, 6106.72519736613, 6107.358727333655, 6114.938850611526, 6119.173911521888, 6125.295591007091, 5057.0, 6098.573099883054, 6112.876832246516, 6127.525510585499, 6134.926387882103, 6134.539909506805, 6136.969315153396, 6139.84650383744, 6145.723442445012, 6157.692115394212, 4942.085714142895, 4944.678595891256, 4946.282788995575, 4947.950520494749, 4958.107540642647, 4361.9967407495815, 4372.366006928977, 4388.956110438919, 4392.472903251631, 4398.560143985575, 5795.449432303924, 5798.391168927202, 5819.039858423397, 5823.912641310384, 5864.530837532987, 6216.533759968021, 6217.875642487125, 6224.346443623445, 6234.220722409699, 6252.468540174045, 5636.915446268309, 5674.631148975386, 5687.573431992617, 5698.7435565399655, 5790.392008839095, 5322.627416080837, 5389.487998640123, 5420.756065977041, 5447.645903016291, 5454.809081682122, 6297.244330680348, 6311.589746666452, 6312.495000400048, 6319.715612797527, 6323.747050117944, 6003.909941350796, 6188.845278868064, 6209.906851397323, 6219.222597175353, 6241.656708881055, 6167.6916154193, 6223.37766223374, 6244.968775156095, 6264.5301602379095, 6304.211973503312, 4883.682560633548, 6046.425589568984, 6055.499606138352, 6059.878802424015, 6109.969450152721, 6013.368596297326, 6027.75888964454, 6073.5748497604745, 6088.634681919099, 6134.1610691366095, 5926.436988486087, 5954.791582294599, 5966.850828729142, 5979.252593425822, 5988.071848863433, 4908.852734417973, 5740.885182296247, 5814.186013957965, 5816.94183058164, 5833.591648584558, 5775.9133612996675, 5786.508146807569, 5786.94213057864, 5811.0, 5843.707814609167, 5955.166276721349, 5971.193888824953, 5990.700464976647, 5994.520438364833, 5997.13041608973, 5633.0, 5670.5180059695385, 5679.460451257124, 5803.622764520293, 5807.564432667482], "value": 5600.0292499801335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.40574282147315, 486.1589450251068, 493.0287333952113, 495.8834673851645, 501.9673721208121, 25735.0, 32063.35873282533, 39122.02194945124, 41160.97097572562, 41415.79292103543, 42474.938126546855, 42496.0, 42927.78536107323, 43028.13943721123, 43036.78481607595, 8383.538905360203, 8617.181367770052, 9130.178283954443, 9320.8601870972, 9350.766230844249, 10915.017648411642, 11196.384198869058, 11217.0, 11364.0, 11385.430728463543, 11079.002889739922, 11151.721206969809, 11163.609273675424, 11182.776344473106, 11183.776324473505, 10464.63373781914, 11074.335539867594, 11134.888651113506, 11145.442727863574, 11157.330560166334, 11027.779444411148, 11074.833877491845, 11080.279781814157, 11085.944570277177, 11097.55609775608, 40380.0, 40644.59355406438, 40705.59294407048, 40827.7958610205, 40837.38743918844, 3927.507398719214, 3979.263836190285, 4014.116894283253, 4016.49793775778, 4115.868136262522, 29729.851350743324, 30599.38801223963, 30860.2284942876, 30892.8455357724, 31181.064568062993, 3096.086654436924, 3207.294395233045, 3256.853441595134, 3274.67253274673, 3315.1712071982006, 480197.0, 484000.0, 484128.99999999645, 486581.56709216937, 486710.0, 63553.0, 63780.68109659422, 64154.67922660357, 64170.35829641737, 64183.0, 65982.67008664926, 66086.0, 66088.6695566519, 66180.34549136214, 66214.37177839842, 15748.055116693035, 15969.520914372355, 16004.67990640204, 16009.199540022952, 16034.358625654842, 10932.125429965583, 11214.271072380268, 12049.518019279307, 12069.27584344942, 12114.636560903187, 17417.39039133624, 17706.822931770774, 17953.102344882966, 17978.303254511928, 17980.460586182435, 7600.479904019218, 7626.389888808882, 7714.807129821687, 7717.723271634881, 7761.379089672812, 757.7575175943755, 881.1496905486237, 913.963441462334, 916.8212198621205, 927.888653361601, 28528.0, 28791.712082879323, 29638.851805740833, 30368.0, 30470.0, 971.4851128901694, 1003.7440452684518, 1030.3972176276961, 1053.1574740207802, 1061.7345663584103, 12922.806157907638, 13868.722625547432, 14466.349014294172, 14576.833853291922, 14706.41174353014, 611635.0, 614987.0, 616696.8330316729, 617416.0, 617478.6403835515, 52114.73942630263, 52300.476995230325, 52402.73798631059, 52459.704835419994, 52598.47401526012, 1392.3943084758162, 1417.4046900301898, 1438.719449707318, 1444.934977926017, 1446.8842492600356, 25568.488630227665, 27375.589366159125, 27434.862825685745, 27484.450310994067, 27548.449031019667, 50289.742756431384, 51292.487075130266, 51296.74351628218, 51308.0, 51499.0, 544084.0, 546221.0, 546789.0, 548263.0, 549769.0, 24307.0, 24496.632550512113, 24847.62728559037, 24851.502969940862, 24868.253952381456, 43426.0, 43495.56504435042, 43897.56102439063, 43934.12131757411, 44006.0, 32458.83770581132, 33978.83010584931, 34157.65842341545, 36235.45646815247, 36508.63491365052, 34685.47971780476, 35013.29973400569, 35111.82444087763, 36006.459903102, 36029.0, 34541.82729086339, 35041.0, 35082.0, 35232.64767352294, 35374.58501659905, 27889.860550697118, 28291.868325267584, 31447.685523144475, 31479.370412592078, 31584.0, 21888.671669924646, 23024.884875575513, 23169.768302316763, 23249.186278480847, 23292.301230963098], "value": 19653.13084631246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5062016897357, 368.60375096770974, 384.80951928795236, 398.66113803267217, 417.5761601973997, 15346.616334591641, 16984.83015169848, 20112.29606963755, 20892.582148357025, 21977.780222197773, 21157.94210289487, 21948.670769938464, 22082.558348833052, 22396.77603223967, 22521.774782252174, 5783.2481777368985, 5886.5577933406375, 6111.847203819918, 6117.755289788425, 6123.693815309217, 5488.423715509874, 6056.212692349988, 6061.393860613947, 6074.301455332627, 6077.483413909823, 5832.854178645525, 5891.970540147293, 5894.616849904743, 5909.556783241253, 6029.155918171459, 6036.2152920120325, 6121.265448146251, 6206.224221972254, 6208.937910620881, 6222.782202622909, 5715.742791574347, 6026.2165918430765, 6076.240469941257, 6089.421504957022, 6101.2983506896835, 21708.565828683495, 23526.411839703975, 24031.639525407132, 24081.87959060211, 26061.0, 2626.3434141464636, 2637.3933995181023, 2661.8504587338484, 2678.812483126182, 2745.203890871645, 10234.1300989416, 16994.83005169945, 17090.572735681584, 17542.649147017117, 17629.823701762947, 1940.5245714799964, 2018.1422895269598, 2072.4818795301176, 2089.352300786761, 2177.1617927098023, 156648.0, 160146.19926900408, 161193.19403403025, 161498.0, 165859.0, 13994.758160590898, 19523.414297571097, 22097.44756381071, 23320.65019024716, 23389.883050584638, 35906.563737450735, 40567.39148912769, 40676.59323406787, 40726.0, 40920.59079409168, 9031.412958157698, 10917.290376125526, 11016.686495835804, 11163.274387164809, 11252.26860254081, 8774.517401542977, 8813.030566637664, 8823.779405514913, 8958.700988356783, 8971.50656713874, 10865.348079115278, 10925.399103049249, 11025.007749302602, 11034.834477482844, 11186.664400068012, 4054.736442131252, 4131.029208136086, 4158.355454904495, 4161.625453709181, 4175.707700460999, 1002.9749256268651, 1005.9044390782864, 1017.8549132226245, 1058.629479682105, 1061.0185578340158, 20619.4845128873, 22166.778332216792, 22193.778062219495, 22222.0, 22242.555148897256, 1027.768752030802, 1059.502034043998, 1071.2982996137541, 1073.098597178374, 1078.800421921947, 8740.475571465733, 10280.331778434378, 10576.471176441148, 11490.965813076697, 11566.19036667442, 634157.0, 694830.0, 721800.0, 753882.0, 756232.0, 149953.0, 151239.0, 153991.0, 155447.0, 157112.64753962925, 980.8136454073704, 989.4113002763488, 1008.5713571732131, 1010.5806090472519, 1014.3913651808856, 18969.43091707251, 19522.707159392903, 19572.021398930283, 19674.803251967296, 19812.0, 59413.40586594079, 60245.0, 60248.69875650594, 60360.0, 61326.69336653288, 64404.67797660982, 85421.0, 87475.1252487467, 89525.0, 90586.54706726424, 6860.8284792878585, 8476.49141051539, 8699.826003480022, 8731.65073397057, 8916.33127515426, 12553.186182815813, 13018.674533136747, 13455.0, 13934.721305573628, 14103.224322662352, 11232.831507527557, 11383.0, 11718.472668729757, 11842.881571184178, 11844.933955944007, 9875.40747555149, 10712.410817405118, 11312.264702794291, 11424.942875285571, 11592.6522204334, 6135.417135372132, 7711.614419278902, 11497.48261328259, 11834.881651183377, 11846.170768046153, 7331.926680733124, 7539.095308562788, 8423.8736418955, 8772.868406974028, 8816.162464565856, 10122.392656440637, 10766.0, 11109.722256943642, 11310.547578096784, 11370.31778093317], "value": 11154.284087891961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.8688818006378, 1467.0, 1469.7942288079666, 1482.3181336585171, 1489.4712377106127, 8042.276195142436, 8434.072252052269, 8439.409241353107, 8445.873311900326, 8450.746477605673, 6689.498287628435, 7376.336129748322, 7693.384529237647, 8264.462809917351, 8266.132056134094, 2254.875981820999, 2324.4769926766426, 2332.836701430892, 2332.8600283982933, 2338.695969523968, 2332.2536788227776, 2356.528694261146, 2375.70303712036, 2377.476955069882, 2380.5000949800565, 1941.4078705994666, 2319.802816760569, 2348.0490401387465, 2354.5761762882676, 2357.375295546673, 2177.7277840269967, 2306.192832508617, 2316.5366926614574, 2318.211807985276, 2338.1115176232925, 2077.210659949225, 2367.147826782357, 2370.810335173182, 2370.8696021718797, 2371.5731168389857, 8289.212524810133, 8373.874391884126, 8381.11998240182, 8386.454880432813, 8386.8322633547, 4979.427365852901, 5132.692038477666, 5143.665661732013, 5144.61415393847, 5145.922811157836, 3148.9685103148904, 3306.553615261957, 3488.2674638325984, 3506.7019303359243, 3542.8051457169845, 1208.9516419343215, 1222.0773316146253, 1239.6714870559308, 1244.9688757781037, 1258.4211262819022, 10528.84206736892, 10651.733706657318, 10775.568977240979, 10786.946065269702, 10828.025477707044, 4331.761753103547, 4590.678652494294, 4651.511591282934, 4653.813847446064, 4664.580187783115, 9432.0, 9455.952720236492, 9465.52672366379, 9468.053194680615, 9487.288453366025, 4466.441694788152, 5177.0, 5204.375474943031, 5211.088059589557, 5232.3459567554055, 4250.0, 4412.911741765147, 4443.933340999887, 4554.203014472454, 4671.299305104261, 3732.869349572752, 3782.3759079751535, 3863.7681739095183, 3876.050367659885, 3903.2583809076186, 1235.975280494385, 1254.8996080313552, 1260.3005332040805, 1276.942537585811, 1277.0613599004723, 878.1306506558461, 904.0507467159588, 909.8771665825161, 935.2377812083131, 940.9294401965062, 5427.457254274541, 5576.9163462548095, 5729.169270455761, 5836.182934389189, 5902.675352855634, 855.2858363266618, 861.9396642235109, 953.7186529973675, 985.6693463823924, 994.5673631970116, 3610.494530765695, 3684.963150368462, 3803.0682482791894, 3906.511686039245, 4024.215278020758, 9824.705258842247, 10021.348612340174, 10067.144292735053, 10072.899271007343, 10086.848697269546, 9997.650082247086, 10024.0, 10025.849612255823, 10041.548130334153, 10050.899491004997, 7319.268073192745, 7734.690612375442, 7926.8810967835525, 7940.722074727472, 7953.443258971816, 5199.324087868553, 5227.503387178212, 5530.723463826873, 5546.168074788814, 5836.328822185503, 8867.91132088671, 8894.28845692356, 9076.183143517115, 9236.30727695439, 9263.212626926786, 8941.46351218929, 9092.408993415407, 9244.352895297265, 9294.302927280616, 9311.649810777264, 7149.857002860018, 7366.447516436396, 7367.484276100621, 7599.01212842327, 7833.09919359281, 7306.2693730626515, 7549.849003019799, 7562.810929726801, 7568.772936811904, 7597.88603170964, 7108.289171082851, 7111.217766045627, 7189.7483588074165, 7217.639118043971, 7249.383802376857, 6774.153230846145, 6861.416779573592, 7013.614251216232, 7025.964870175617, 7079.0, 6352.9047064293145, 6363.427291543783, 6456.515761317826, 6456.515761318014, 6461.224653041665, 4768.189407800752, 4769.57073863354, 4945.159322915185, 5013.373328333958, 5037.622178336566, 4851.175300198904, 4929.876753081202, 5024.57291130258, 5077.492250774893, 5097.337346144977], "value": 4413.2452655803445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8797636957033, 330.0626221530852, 349.4422364303132, 360.9512715783369, 369.5306960160596, 4998.675086119404, 5087.5421212090905, 5094.388673359193, 5095.929854730506, 5146.382434107913, 3952.565217826037, 4699.0, 4764.428268607772, 4834.25069114287, 4984.261803647265, 3408.982955085221, 3951.2097580483874, 3978.482797236355, 4009.6391324780766, 4020.6180412860876, 3627.8209581885862, 3814.150137183464, 3975.860844870416, 4025.476688030552, 4042.6765858731233, 3768.171002379472, 3896.649301562859, 3950.5851885551892, 3951.8857411284966, 3994.04143005678, 3665.78005319679, 3712.795796231206, 3897.5322961244833, 3927.607239276078, 3979.602039796026, 3086.8147911125407, 3101.5037593984853, 3300.9106994691692, 3340.3987282289177, 3493.388656985043, 4695.929561056587, 4811.350467686852, 4944.629152813517, 4960.87597810054, 5008.69947803133, 4318.519139451986, 4511.796969136397, 4555.020670555813, 4560.247559152735, 4563.927477042892, 4890.168671325848, 5315.6013299002725, 5315.707636080014, 5331.760070796823, 5335.359756829166, 3621.963780362189, 3653.1232504199065, 3864.574896761354, 3886.028492876781, 3900.941485877714, 5237.559671090443, 5497.835064948058, 5552.861663359002, 5560.610757246995, 5681.261436013333, 3936.7834769087403, 3938.306528192847, 3951.585083566184, 3958.267720471722, 3971.5844373838477, 3996.18078293949, 4003.6396724294955, 4018.457508236409, 4020.8592699255387, 4068.3694027425795, 4269.615734583902, 4503.887402814956, 4549.27211646135, 4560.315952607069, 4591.632669386441, 5101.897962040813, 5315.3621565412395, 5332.760025798849, 5352.223927530564, 5437.564994800407, 1064.7391389109719, 1089.9645336929948, 1174.467320147199, 1294.6310301564008, 1312.7308901675133, 847.7541512961295, 876.9824603507894, 888.6534251641865, 931.1293940165966, 959.7810780308969, 4076.6331030207425, 4098.959010409858, 4587.944772702231, 4730.266808644666, 4754.881127971828, 4698.2952557116705, 5008.524190201925, 5148.4079330876675, 5164.638475306768, 5182.300389447376, 4129.501651500859, 4349.847755328548, 4504.986378064975, 4699.224627936421, 4765.380500534909, 2615.9476810463684, 2664.960665340519, 2675.7725593324785, 2686.2344231893817, 2691.8788654510595, 4628.467726211461, 5348.973255133699, 5381.838544843661, 5402.675839449567, 5442.482964118402, 4612.238980568169, 4668.292390413552, 5195.272661827347, 5269.076786972727, 5348.705821179872, 5077.517635824591, 5705.800296989585, 5710.5159255723065, 5719.826465942915, 5744.368119506851, 4604.973811522919, 5242.842714718565, 5301.310829592128, 5435.510804027656, 5503.147012213113, 4979.0, 5331.866703332447, 5418.155468379133, 5441.700706461024, 5460.863478412913, 5486.396496385474, 5733.971330143323, 5756.2229099072765, 5793.652380856994, 5795.507381872588, 3408.3694516514524, 3678.816059197083, 3696.3900956341904, 3721.553413590278, 3752.3058234226755, 4796.424429068534, 5440.156775699773, 5440.863978400572, 5484.0, 5531.529819965348, 4527.592516673515, 5246.501582349671, 5311.141100614908, 5342.43904390049, 5363.490468405495, 4297.8495752648505, 4727.550882666142, 5052.459000005034, 5059.721715305694, 5255.527002569787, 4465.575770301816, 4861.586765124863, 5195.19474481456, 5196.53231209193, 5204.635675502678, 4106.199291138199, 5036.514228302733, 5124.8718782029255, 5154.5103215194495, 5275.338268445427, 4642.373279607345, 4930.211166213388, 5139.526404379324, 5162.793488260578, 5164.406093299319], "value": 3916.5066664301216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.5407739047007, 753.036113774369, 771.9771303023496, 822.2271065198713, 825.1130035212146, 15187.088774673513, 15216.315265813037, 15941.601459963507, 15990.760138597916, 16007.439739609115, 14517.854821451783, 14681.926590367033, 14684.192369419678, 14685.412583496647, 14694.55916322512, 685.9691313890875, 709.2481969112757, 715.1275443958389, 852.9658813647478, 867.119873328572, 858.8754630578562, 873.6549063120063, 873.9169778870997, 876.0844917061686, 876.128252388874, 928.0626567167176, 928.3779867488765, 930.1767935377172, 930.1814403325064, 931.0875342164683, 721.2967356827052, 744.4900243333334, 892.6072528087685, 923.7367350305165, 925.1950802801539, 684.7603338831369, 692.8926016467406, 693.2686016252851, 693.3205458650551, 695.0443140681563, 14842.109473431521, 15580.0, 15620.656901464758, 15621.531354059396, 15640.296186671627, 13976.091554048955, 13992.510262140777, 14052.578422647337, 14083.014189006773, 14387.136771793726, 12600.0, 12636.49454021838, 12871.22772633645, 13290.601281961557, 13335.86664133356, 4024.9195016099516, 4486.416765820455, 4536.319552067216, 4541.772911354452, 4726.361941137937, 104810.95189048088, 106388.40417393745, 106541.0, 106876.0, 107779.0, 11053.889461105447, 11213.551457941754, 11285.830712539318, 11318.26431281964, 11525.48135333912, 21994.780052199592, 22521.211757588735, 22616.434589135402, 22648.094076237096, 22767.31698049061, 7771.650275737606, 7777.338926191224, 7833.1775163608145, 7975.920240797634, 8005.518289330326, 4208.642265407413, 4229.661627069827, 4293.592108749664, 4294.398784170218, 4366.978165109218, 3355.4128027595075, 3432.3993301172195, 3454.689077982943, 3460.740444466625, 3713.1459764254373, 716.3159182980241, 718.2530168624677, 719.341802250945, 738.1437532462318, 740.326303064209, 672.2370109925172, 686.7459040155074, 707.6320313436984, 721.7546034348346, 733.2484203691259, 10197.847032294521, 10261.9486902565, 10380.688579342632, 10427.701402527247, 10689.83965240522, 676.4351766275215, 685.6297599296324, 695.2178798851293, 696.6725638949686, 699.6991293743739, 4553.749543775058, 4832.9850731346105, 4863.05785000077, 5025.396952365666, 5484.122540393598, 95876.0, 96123.73856455687, 98232.52651210094, 98262.34583312471, 98646.0, 84829.72755408674, 85749.14250857412, 85859.57070214734, 86649.13350866537, 87854.56072719724, 73929.0, 74201.25798742051, 74218.25781742329, 74350.0, 76490.08774780676, 9764.462954537568, 10793.514291857042, 10868.510917008596, 10909.454527273447, 10918.071963882841, 39034.0, 48917.510824891295, 49080.0, 49572.0, 50035.49964500308, 64696.2380909531, 64995.025074624864, 65207.67396163179, 66193.0, 67150.66424667845, 11100.722481938015, 12841.807372889227, 13024.674383140118, 13322.600321990356, 13442.865571344553, 14345.856541434452, 14857.405703771728, 14893.627659308171, 14951.551453456414, 15052.774208387102, 13689.315534223448, 13921.721565568834, 14121.2939353034, 14125.0, 14437.0, 13608.591742247749, 13801.309934503435, 14141.43434262618, 14385.424583016562, 14609.196494192496, 13324.0, 13491.86508134906, 13603.523876664269, 13790.172589644653, 14100.36548355347, 9987.750306242402, 10487.685369438928, 10572.36565806054, 10645.680629581126, 11154.88845111571, 9359.438433694, 10966.890331096905, 11185.608503702331, 11191.216614836883, 11254.324740515594], "value": 7623.930858903182, "unit": "score"}], "name": "dromaeo_css", "value": 7381.737133827926, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 111.0, 148.0, 114.0, 111.0, 115.0, 134.0, 115.0, 127.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 184.0, 186.0, 184.0, 185.0, 184.0, 186.0, 184.0, 191.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 91.0, 62.0, 73.0, 89.0, 83.0, 90.0, 58.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 70.0, 68.0, 69.0, 82.0, 69.0, 68.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 89.0, 91.0, 87.0, 91.0, 88.0, 90.0, 88.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 88.0, 132.0, 92.0, 135.0, 150.0, 98.0, 97.0, 96.0, 96.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 88.0, 87.0, 88.0, 88.0, 90.0, 88.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 79.0, 79.0, 74.0, 73.0, 73.0, 73.0, 72.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 77.0, 84.0, 104.0, 107.0, 94.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 142.0, 141.0, 140.0, 140.0, 141.0, 138.0, 227.0, 152.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 175.0, 175.0, 171.0, 174.0, 174.0, 172.0, 174.0, 170.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1469.2, "alertThreshold": 2.0}]} 03:08:51 INFO - Return code: 0 03:08:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:08:51 ERROR - # TBPL SUCCESS # 03:08:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:51 INFO - 2017-01-18 03:08:51.533 screenresolution[2917:305530] starting screenresolution argv=screenresolution get 03:08:51 INFO - 2017-01-18 03:08:51.535 screenresolution[2917:305530] Display 0: 1600x1200x32@60 03:08:51 INFO - 2017-01-18 03:08:51.542 screenresolution[2918:305533] starting screenresolution argv=screenresolution list 03:08:51 INFO - Available Modes on Display 0 03:08:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:51 INFO - Intel Iris: 03:08:51 INFO - Chipset Model: Intel Iris 03:08:51 INFO - Type: GPU 03:08:51 INFO - Bus: Built-In 03:08:51 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:51 INFO - Vendor: Intel (0x8086) 03:08:51 INFO - Device ID: 0x0a2e 03:08:51 INFO - Revision ID: 0x0009 03:08:51 INFO - Displays: 03:08:51 INFO - Display: 03:08:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:51 INFO - Display Serial Number: 1600x1200 60 03:08:51 INFO - Main Display: Yes 03:08:51 INFO - Mirror: Off 03:08:51 INFO - Online: Yes 03:08:51 INFO - Rotation: Supported 03:08:51 INFO - Return code: 0 03:08:51 INFO - Running post-action listener: _resource_record_post_action 03:08:51 INFO - [mozharness: 2017-01-18 11:08:51.779373Z] Finished run-tests step (success) 03:08:51 INFO - Running post-run listener: _resource_record_post_run 03:08:51 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 6664704; Write bytes: 554953728; Read time: 55; Write time: 1620 03:08:51 INFO - TinderboxPrint: CPU usage
54.1% 03:08:51 INFO - TinderboxPrint: I/O read bytes / time
6,664,704 / 55 03:08:51 INFO - TinderboxPrint: I/O write bytes / time
554,953,728 / 1,620 03:08:51 INFO - TinderboxPrint: CPU idle
2,208.5 (45.9%) 03:08:51 INFO - TinderboxPrint: CPU system
971.6 (20.2%) 03:08:51 INFO - TinderboxPrint: CPU user
1,629.7 (33.9%) 03:08:51 INFO - TinderboxPrint: Swap in / out
265,908,224 / 0 03:08:51 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241711616; Write bytes: 234258432; Read time: 17774; Write time: 423 03:08:51 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 6664704; Write bytes: 301038592; Read time: 55; Write time: 1157 03:08:52 INFO - Running post-run listener: _upload_blobber_files 03:08:52 INFO - Blob upload gear active. 03:08:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:08:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:08:52 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:08:52 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:08:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:53 INFO - (blobuploader) - INFO - Done attempting. 03:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:54 INFO - (blobuploader) - INFO - Done attempting. 03:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:55 INFO - (blobuploader) - INFO - Done attempting. 03:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:57 INFO - (blobuploader) - INFO - Done attempting. 03:08:57 INFO - (blobuploader) - INFO - Iteration through files over. 03:08:57 INFO - Return code: 0 03:08:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:08:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:08:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ca64e6a78fc29be0214a298e0fafc57b54ae0f45fa2eda02d075f444d21066f5489a3119f9f6db9b15df58d4beab02a9d5c584414999e0d9f95b96c47ed06c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dbdeda5daf89a772af79911708689efa32740e95fd9b1c19892418a5d023df0300ae48d723b656c498fee1a16195d64184f8eadfbb002c81dcb8b7af33920b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a459c5df06671a611b0951b0816f8799447853ccdaaff33b450dd720f9dfe502c0460fab770abdd9b474169dc870071f8ad56ab305a0f57d2ef825d58c955c34", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce625c31be91e614fee2e91872d48848aa4cc15c1ced7c12eddcbbc52d9bd4d2dc272d770aa22a46de48a0356634051ada90e50c6b0504468656e1ed643f6a79"} 03:08:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:08:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:08:57 INFO - Contents: 03:08:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ca64e6a78fc29be0214a298e0fafc57b54ae0f45fa2eda02d075f444d21066f5489a3119f9f6db9b15df58d4beab02a9d5c584414999e0d9f95b96c47ed06c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dbdeda5daf89a772af79911708689efa32740e95fd9b1c19892418a5d023df0300ae48d723b656c498fee1a16195d64184f8eadfbb002c81dcb8b7af33920b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a459c5df06671a611b0951b0816f8799447853ccdaaff33b450dd720f9dfe502c0460fab770abdd9b474169dc870071f8ad56ab305a0f57d2ef825d58c955c34", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce625c31be91e614fee2e91872d48848aa4cc15c1ced7c12eddcbbc52d9bd4d2dc272d770aa22a46de48a0356634051ada90e50c6b0504468656e1ed643f6a79"} 03:08:57 INFO - Running post-run listener: copy_logs_to_upload_dir 03:08:57 INFO - Copying logs to upload dir... 03:08:57 INFO - mkdir: /builds/slave/test/build/upload/logs 03:08:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.453650 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-18 03:08:57.813138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 03:08:57.816356) ========= 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.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/Graphics/sha512/6ca64e6a78fc29be0214a298e0fafc57b54ae0f45fa2eda02d075f444d21066f5489a3119f9f6db9b15df58d4beab02a9d5c584414999e0d9f95b96c47ed06c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dbdeda5daf89a772af79911708689efa32740e95fd9b1c19892418a5d023df0300ae48d723b656c498fee1a16195d64184f8eadfbb002c81dcb8b7af33920b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a459c5df06671a611b0951b0816f8799447853ccdaaff33b450dd720f9dfe502c0460fab770abdd9b474169dc870071f8ad56ab305a0f57d2ef825d58c955c34", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce625c31be91e614fee2e91872d48848aa4cc15c1ced7c12eddcbbc52d9bd4d2dc272d770aa22a46de48a0356634051ada90e50c6b0504468656e1ed643f6a79"} build_url:https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011529 build_url: 'https://queue.taskcluster.net/v1/task/N5AnW5_RSVyaSYtd0AQrwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ca64e6a78fc29be0214a298e0fafc57b54ae0f45fa2eda02d075f444d21066f5489a3119f9f6db9b15df58d4beab02a9d5c584414999e0d9f95b96c47ed06c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dbdeda5daf89a772af79911708689efa32740e95fd9b1c19892418a5d023df0300ae48d723b656c498fee1a16195d64184f8eadfbb002c81dcb8b7af33920b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a459c5df06671a611b0951b0816f8799447853ccdaaff33b450dd720f9dfe502c0460fab770abdd9b474169dc870071f8ad56ab305a0f57d2ef825d58c955c34", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce625c31be91e614fee2e91872d48848aa4cc15c1ced7c12eddcbbc52d9bd4d2dc272d770aa22a46de48a0356634051ada90e50c6b0504468656e1ed643f6a79"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 03:08:57.855738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 03:08:57.856506) ========= 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.1lpDmirJl5/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.UPY0DL0HfU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005475 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 03:08:57.909531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 03:08:57.910255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 03:08:57.910977) ========= ========= Total master_lag: 0.21 =========