builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1484671258.42 results: success (0) buildid: 20170117071825 builduid: dba817f6f1984c5a81e60b92112955b2 revision: 8f272d554787e096ae515ba635c3705a6b9b6bcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.419660) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.420097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.420372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.481477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.481899) ========= 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.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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-17 08:40:58-- 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% 18.6M=0.001s 2017-01-17 08:40:58 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.626726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.627030) ========= 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.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.024451 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:58.675977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 08:40:58.676282) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8f272d554787e096ae515ba635c3705a6b9b6bcf --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 8f272d554787e096ae515ba635c3705a6b9b6bcf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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-17 08:40:58,780 truncating revision to first 12 chars 2017-01-17 08:40:58,780 Setting DEBUG logging. 2017-01-17 08:40:58,780 attempt 1/10 2017-01-17 08:40:58,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8f272d554787?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 08:40:59,537 unpacking tar archive at: graphics-8f272d554787/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035270 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 08:40:59.738467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:59.741892) ========= script_repo_revision: 8f272d554787e096ae515ba635c3705a6b9b6bcf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:59.742329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:59.742606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 08:40:59.763002) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 08:40:59.763391) ========= /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.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:40:59 INFO - MultiFileLogger online at 20170117 08:40:59 in /builds/slave/test 08:40:59 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 08:40:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:59 INFO - {'append_to_log': False, 08:40:59 INFO - 'base_work_dir': '/builds/slave/test', 08:40:59 INFO - 'blob_upload_branch': 'Graphics', 08:40:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:59 INFO - 'branch': 'Graphics', 08:40:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:59 INFO - 'config_files': ('talos/mac_config.py',), 08:40:59 INFO - 'default_actions': ('clobber', 08:40:59 INFO - 'read-buildbot-config', 08:40:59 INFO - 'download-and-extract', 08:40:59 INFO - 'populate-webroot', 08:40:59 INFO - 'create-virtualenv', 08:40:59 INFO - 'install', 08:40:59 INFO - 'run-tests'), 08:40:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:59 INFO - 'download_minidump_stackwalk': True, 08:40:59 INFO - 'download_symbols': 'ondemand', 08:40:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:59 INFO - 'installer_path': 'installer.exe', 08:40:59 INFO - 'log_level': 'info', 08:40:59 INFO - 'log_name': 'talos', 08:40:59 INFO - 'log_to_console': True, 08:40:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:59 INFO - 'opt_config_files': (), 08:40:59 INFO - 'pip_index': False, 08:40:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:59 INFO - 'cmd': ('bash', 08:40:59 INFO - '-c', 08:40:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:59 INFO - 'enabled': True, 08:40:59 INFO - 'halt_on_failure': False, 08:40:59 INFO - 'name': 'check_screen_resolution'},), 08:40:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:59 INFO - 'cmd': ('bash', 08:40:59 INFO - '-c', 08:40:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:59 INFO - 'enabled': True, 08:40:59 INFO - 'halt_on_failure': False, 08:40:59 INFO - 'name': 'check_screen_resolution'},), 08:40:59 INFO - 'run_cmd_checks_enabled': True, 08:40:59 INFO - 'sps_profile': False, 08:40:59 INFO - 'sps_profile_interval': 0, 08:40:59 INFO - 'suite': 'dromaeojs', 08:40:59 INFO - 'system_bits': '32', 08:40:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:59 INFO - 'title': 't-yosemite-r7-0225', 08:40:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:59 INFO - 'use_talos_json': True, 08:40:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:59 INFO - 'work_dir': 'build'} 08:40:59 INFO - [mozharness: 2017-01-17 16:40:59.966033Z] Running clobber step. 08:40:59 INFO - Running pre-action listener: _resource_record_pre_action 08:40:59 INFO - Running main action method: clobber 08:40:59 INFO - rmtree: /builds/slave/test/build 08:40:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:02 INFO - Running post-action listener: _resource_record_post_action 08:41:02 INFO - [mozharness: 2017-01-17 16:41:02.488062Z] Finished clobber step (success) 08:41:02 INFO - [mozharness: 2017-01-17 16:41:02.488237Z] Running read-buildbot-config step. 08:41:02 INFO - Running pre-action listener: _resource_record_pre_action 08:41:02 INFO - Running main action method: read_buildbot_config 08:41:02 INFO - Using buildbot properties: 08:41:02 INFO - { 08:41:02 INFO - "project": "", 08:41:02 INFO - "product": "firefox", 08:41:02 INFO - "script_repo_revision": "default", 08:41:02 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 08:41:02 INFO - "repository": "", 08:41:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 08:41:02 INFO - "buildid": "20170117071825", 08:41:02 INFO - "pgo_build": "False", 08:41:02 INFO - "basedir": "/builds/slave/test", 08:41:02 INFO - "buildnumber": 1, 08:41:02 INFO - "slavename": "t-yosemite-r7-0225", 08:41:02 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:41:02 INFO - "platform": "yosemite_r7", 08:41:02 INFO - "scheduler": "tests-graphics-macosx64-talos", 08:41:02 INFO - "branch": "graphics", 08:41:02 INFO - "repo_path": "projects/graphics", 08:41:02 INFO - "revision": "8f272d554787e096ae515ba635c3705a6b9b6bcf", 08:41:02 INFO - "stage_platform": "macosx64", 08:41:02 INFO - "builduid": "dba817f6f1984c5a81e60b92112955b2", 08:41:02 INFO - "slavebuilddir": "test" 08:41:02 INFO - } 08:41:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:41:02 INFO - Running post-action listener: _resource_record_post_action 08:41:02 INFO - [mozharness: 2017-01-17 16:41:02.492385Z] Finished read-buildbot-config step (success) 08:41:02 INFO - [mozharness: 2017-01-17 16:41:02.492569Z] Running download-and-extract step. 08:41:02 INFO - Running pre-action listener: _resource_record_pre_action 08:41:02 INFO - Running main action method: download_and_extract 08:41:02 INFO - mkdir: /builds/slave/test/build/tests 08:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:02 INFO - trying https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:41:02 INFO - Downloading https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/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 08:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/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 08:41:03 INFO - Downloaded 1199 bytes. 08:41:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:41:03 INFO - Using the following test package requirements: 08:41:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:41:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:41:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:41:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'jsshell-mac.zip'], 08:41:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:41:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:41:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:41:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:41:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:41:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:41:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:41:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:41:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:41:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:41:03 INFO - Fetch https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:41:04 INFO - Expected file size: 16326547 08:41:04 INFO - Obtained file size: 16326547 08:41:11 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 08:41:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:41:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:41:12 INFO - Expected file size: 16326547 08:41:12 INFO - Obtained file size: 16326547 08:41:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:41:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:41:18 INFO - Fetch https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:41:20 INFO - Expected file size: 14403463 08:41:20 INFO - Obtained file size: 14403463 08:41: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')]} 08:41:20 INFO - trying https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:41:20 INFO - Downloading https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/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 08:41:22 INFO - Downloaded 70311533 bytes. 08:41:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:41:22 INFO - mkdir: /builds/slave/test/properties 08:41:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:22 INFO - Contents: 08:41:22 INFO - build_url:https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:41:22 INFO - Running post-action listener: _resource_record_post_action 08:41:22 INFO - Running post-action listener: set_extra_try_arguments 08:41:22 INFO - [mozharness: 2017-01-17 16:41:22.980015Z] Finished download-and-extract step (success) 08:41:22 INFO - [mozharness: 2017-01-17 16:41:22.980162Z] Running populate-webroot step. 08:41:22 INFO - Running pre-action listener: _resource_record_pre_action 08:41:22 INFO - Running main action method: populate_webroot 08:41:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:22 INFO - '--tppagecycles', 08:41:22 INFO - '7'], 08:41:22 INFO - 'tests': ['tsvgm']}}, 08:41:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['damp', 'tps']}, 08:41:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'tests': ['damp', 'tps']}, 08:41:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['dromaeo_dom']}, 08:41:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['basic_compositor_video']}, 08:41:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:41:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['a11yr', 08:41:22 INFO - 'ts_paint', 08:41:22 INFO - 'tpaint', 08:41:22 INFO - 'sessionrestore', 08:41:22 INFO - 'sessionrestore_no_auto_restore', 08:41:22 INFO - 'tabpaint']}, 08:41:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['tsvgx', 08:41:22 INFO - 'tsvgr_opacity', 08:41:22 INFO - 'tart', 08:41:22 INFO - 'tscrollx', 08:41:22 INFO - 'cart', 08:41:22 INFO - 'tsvg_static']}, 08:41:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:22 INFO - 'tsvgr_opacity', 08:41:22 INFO - 'tart', 08:41:22 INFO - 'tscrollx', 08:41:22 INFO - 'cart', 08:41:22 INFO - 'tsvg_static']}, 08:41:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'talos_options': ['--disable-e10s'], 08:41:22 INFO - 'tests': ['tp5o']}, 08:41:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:41:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'talos_options': ['--disable-e10s', 08:41:22 INFO - '--xperf_path', 08:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:22 INFO - 'tests': ['tp5n']}, 08:41:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:41:22 INFO - 'talos_options': ['--xperf_path', 08:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:22 INFO - 'tests': ['tp5n']}}, 08:41:22 INFO - 'talos.zip': {'path': '', 08:41:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:22 INFO - Running post-action listener: _resource_record_post_action 08:41:22 INFO - [mozharness: 2017-01-17 16:41:22.998588Z] Finished populate-webroot step (success) 08:41:22 INFO - [mozharness: 2017-01-17 16:41:22.998709Z] Running create-virtualenv step. 08:41:22 INFO - Running pre-action listener: _resource_record_pre_action 08:41:22 INFO - Running main action method: create_virtualenv 08:41:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:41:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:23 INFO - Using real prefix '/tools/python27' 08:41:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:26 INFO - Installing pip.................done. 08:41:26 INFO - Return code: 0 08:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:41:26 INFO - Reading from file tmpfile_stdout 08:41:26 INFO - Output received: 08:41:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:41:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41: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', 'pip>=1.5'] in /builds/slave/test/build 08:41: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 pip>=1.5 08:41:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:26 INFO - 'HOME': '/Users/cltbld', 08:41:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:26 INFO - 'LOGNAME': 'cltbld', 08:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:26 INFO - 'MOZ_NO_REMOTE': '1', 08:41:26 INFO - 'NO_EM_RESTART': '1', 08:41:26 INFO - 'PAGER': '/bin/cat', 08:41:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:26 INFO - 'PWD': '/builds/slave/test', 08:41:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:26 INFO - 'SHELL': '/bin/bash', 08:41:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:26 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:26 INFO - 'USER': 'cltbld', 08:41:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:26 INFO - 'XPC_FLAGS': '0x0', 08:41:26 INFO - 'XPC_SERVICE_NAME': '0', 08:41:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:41:27 INFO - Cleaning up... 08:41:27 INFO - Return code: 0 08:41:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:27 INFO - 'HOME': '/Users/cltbld', 08:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:27 INFO - 'LOGNAME': 'cltbld', 08:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:27 INFO - 'MOZ_NO_REMOTE': '1', 08:41:27 INFO - 'NO_EM_RESTART': '1', 08:41:27 INFO - 'PAGER': '/bin/cat', 08:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:27 INFO - 'PWD': '/builds/slave/test', 08:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:27 INFO - 'SHELL': '/bin/bash', 08:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:27 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:27 INFO - 'USER': 'cltbld', 08:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:27 INFO - 'XPC_FLAGS': '0x0', 08:41:27 INFO - 'XPC_SERVICE_NAME': '0', 08:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:27 INFO - Downloading/unpacking psutil>=3.1.1 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:31 INFO - Installing collected packages: psutil 08:41:31 INFO - Running setup.py install for psutil 08:41:31 INFO - building 'psutil._psutil_osx' extension 08:41:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:41:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:41:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:41:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:41:32 INFO - building 'psutil._psutil_posix' extension 08:41:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:41:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:41:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:41:32 INFO - ^ 08:41:32 INFO - 1 warning generated. 08:41:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:41:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:32 INFO - Successfully installed psutil 08:41:32 INFO - Cleaning up... 08:41:32 INFO - Return code: 0 08:41:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41: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 mozsystemmonitor==0.3 08:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:32 INFO - 'HOME': '/Users/cltbld', 08:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:32 INFO - 'LOGNAME': 'cltbld', 08:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:32 INFO - 'MOZ_NO_REMOTE': '1', 08:41:32 INFO - 'NO_EM_RESTART': '1', 08:41:32 INFO - 'PAGER': '/bin/cat', 08:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:32 INFO - 'PWD': '/builds/slave/test', 08:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:32 INFO - 'SHELL': '/bin/bash', 08:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:32 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:32 INFO - 'USER': 'cltbld', 08:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:32 INFO - 'XPC_FLAGS': '0x0', 08:41:32 INFO - 'XPC_SERVICE_NAME': '0', 08:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:35 INFO - Installing collected packages: mozsystemmonitor 08:41:35 INFO - Running setup.py install for mozsystemmonitor 08:41:35 INFO - Successfully installed mozsystemmonitor 08:41:35 INFO - Cleaning up... 08:41:35 INFO - Return code: 0 08:41:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:35 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:35 INFO - 'HOME': '/Users/cltbld', 08:41:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:35 INFO - 'LOGNAME': 'cltbld', 08:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:35 INFO - 'MOZ_NO_REMOTE': '1', 08:41:35 INFO - 'NO_EM_RESTART': '1', 08:41:35 INFO - 'PAGER': '/bin/cat', 08:41:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:35 INFO - 'PWD': '/builds/slave/test', 08:41:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:35 INFO - 'SHELL': '/bin/bash', 08:41:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:35 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:35 INFO - 'USER': 'cltbld', 08:41:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:35 INFO - 'XPC_FLAGS': '0x0', 08:41:35 INFO - 'XPC_SERVICE_NAME': '0', 08:41:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:39 INFO - warning: no files found matching '*.txt' 08:41:39 INFO - no previously-included directories found matching 'build' 08:41:39 INFO - no previously-included directories found matching 'dist' 08:41:39 INFO - no previously-included directories found matching '.git*' 08:41:39 INFO - Installing collected packages: jsonschema, functools32 08:41:39 INFO - Running setup.py install for functools32 08:41:39 INFO - warning: no files found matching '*.txt' 08:41:39 INFO - no previously-included directories found matching 'build' 08:41:39 INFO - no previously-included directories found matching 'dist' 08:41:39 INFO - no previously-included directories found matching '.git*' 08:41:39 INFO - Successfully installed jsonschema functools32 08:41:39 INFO - Cleaning up... 08:41:39 INFO - Return code: 0 08:41:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:39 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:39 INFO - 'HOME': '/Users/cltbld', 08:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:39 INFO - 'LOGNAME': 'cltbld', 08:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:39 INFO - 'MOZ_NO_REMOTE': '1', 08:41:39 INFO - 'NO_EM_RESTART': '1', 08:41:39 INFO - 'PAGER': '/bin/cat', 08:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:39 INFO - 'PWD': '/builds/slave/test', 08:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:39 INFO - 'SHELL': '/bin/bash', 08:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:39 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:39 INFO - 'USER': 'cltbld', 08:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:39 INFO - 'XPC_FLAGS': '0x0', 08:41:39 INFO - 'XPC_SERVICE_NAME': '0', 08:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:39 INFO - Cleaning up... 08:41:39 INFO - Return code: 0 08:41:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:39 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:39 INFO - 'HOME': '/Users/cltbld', 08:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:39 INFO - 'LOGNAME': 'cltbld', 08:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:39 INFO - 'MOZ_NO_REMOTE': '1', 08:41:39 INFO - 'NO_EM_RESTART': '1', 08:41:39 INFO - 'PAGER': '/bin/cat', 08:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:39 INFO - 'PWD': '/builds/slave/test', 08:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:39 INFO - 'SHELL': '/bin/bash', 08:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:39 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:39 INFO - 'USER': 'cltbld', 08:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:39 INFO - 'XPC_FLAGS': '0x0', 08:41:39 INFO - 'XPC_SERVICE_NAME': '0', 08:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:43 INFO - Downloading docopt-0.6.1.tar.gz 08:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:43 INFO - Running setup.py install for blobuploader 08:41:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:44 INFO - Running setup.py install for requests 08:41:44 INFO - Running setup.py install for docopt 08:41:44 INFO - Successfully installed blobuploader requests docopt 08:41:44 INFO - Cleaning up... 08:41:44 INFO - Return code: 0 08:41:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:44 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:44 INFO - 'HOME': '/Users/cltbld', 08:41:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:44 INFO - 'LOGNAME': 'cltbld', 08:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:44 INFO - 'MOZ_NO_REMOTE': '1', 08:41:44 INFO - 'NO_EM_RESTART': '1', 08:41:44 INFO - 'PAGER': '/bin/cat', 08:41:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:44 INFO - 'PWD': '/builds/slave/test', 08:41:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:44 INFO - 'SHELL': '/bin/bash', 08:41:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:44 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:44 INFO - 'USER': 'cltbld', 08:41:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:44 INFO - 'XPC_FLAGS': '0x0', 08:41:44 INFO - 'XPC_SERVICE_NAME': '0', 08:41:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-E88AaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-iyEX0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mC1jf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mhbZjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ppOIov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_Xb3Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8qW5Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-baUJju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:45 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-rGNwdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-BVavdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-vo8sIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-u7gmMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-FeECiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xc09Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HZJ1ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-jRjmsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:46 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-FBAuYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:46 INFO - Running setup.py install for manifestparser 08:41:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:47 INFO - Running setup.py install for mozcrash 08:41:47 INFO - Running setup.py install for mozdebug 08:41:47 INFO - Running setup.py install for mozdevice 08:41:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:47 INFO - Running setup.py install for mozfile 08:41:47 INFO - Running setup.py install for mozhttpd 08:41:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:47 INFO - Running setup.py install for mozinfo 08:41:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:47 INFO - Running setup.py install for mozInstall 08:41:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozleak 08:41:48 INFO - Running setup.py install for mozlog 08:41:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for moznetwork 08:41:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozprocess 08:41:48 INFO - Running setup.py install for mozprofile 08:41:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozrunner 08:41:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:48 INFO - Running setup.py install for mozscreenshot 08:41:49 INFO - Running setup.py install for moztest 08:41:49 INFO - Running setup.py install for mozversion 08:41:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:49 INFO - Cleaning up... 08:41:49 INFO - Return code: 0 08:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:49 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:49 INFO - 'HOME': '/Users/cltbld', 08:41:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:49 INFO - 'LOGNAME': 'cltbld', 08:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:49 INFO - 'MOZ_NO_REMOTE': '1', 08:41:49 INFO - 'NO_EM_RESTART': '1', 08:41:49 INFO - 'PAGER': '/bin/cat', 08:41:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:49 INFO - 'PWD': '/builds/slave/test', 08:41:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:49 INFO - 'SHELL': '/bin/bash', 08:41:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:49 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:49 INFO - 'USER': 'cltbld', 08:41:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:49 INFO - 'XPC_FLAGS': '0x0', 08:41:49 INFO - 'XPC_SERVICE_NAME': '0', 08:41:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:49 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ZhAjlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:49 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-4oDfkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:49 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-D5ecS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Ph5tJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_tjt1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-a07XYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-9c5EcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-zjPXhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-vSyaq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-wv1NMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5jPzcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-o2vVCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:50 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)) 08:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:50 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-R9fezG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:51 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-In0BlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:51 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-LoJRiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:51 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-3_e7_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:51 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-VlmOOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:54 INFO - Downloading blessings-1.6.tar.gz 08:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:54 INFO - Installing collected packages: blessings 08:41:54 INFO - Running setup.py install for blessings 08:41:54 INFO - Successfully installed blessings 08:41:54 INFO - Cleaning up... 08:41:54 INFO - Return code: 0 08:41:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:54 INFO - Reading from file tmpfile_stdout 08:41:54 INFO - Current package versions: 08:41:54 INFO - blessings == 1.6 08:41:54 INFO - blobuploader == 1.2.4 08:41:54 INFO - docopt == 0.6.1 08:41:54 INFO - functools32 == 3.2.3-2 08:41:54 INFO - jsonschema == 2.5.1 08:41:54 INFO - manifestparser == 1.1 08:41:54 INFO - mozInstall == 1.12 08:41:54 INFO - mozcrash == 1.0 08:41:54 INFO - mozdebug == 0.1 08:41:54 INFO - mozdevice == 0.49 08:41:54 INFO - mozfile == 1.2 08:41:54 INFO - mozhttpd == 0.7 08:41:54 INFO - mozinfo == 0.9 08:41:54 INFO - mozleak == 0.1 08:41:54 INFO - mozlog == 3.4 08:41:54 INFO - moznetwork == 0.27 08:41:54 INFO - mozprocess == 0.24 08:41:54 INFO - mozprofile == 0.28 08:41:54 INFO - mozrunner == 6.13 08:41:54 INFO - mozscreenshot == 0.1 08:41:54 INFO - mozsystemmonitor == 0.3 08:41:54 INFO - moztest == 0.8 08:41:54 INFO - mozversion == 1.4 08:41:54 INFO - psutil == 3.1.1 08:41:54 INFO - requests == 1.2.3 08:41:54 INFO - wsgiref == 0.1.2 08:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:54 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 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:54 INFO - 'HOME': '/Users/cltbld', 08:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:54 INFO - 'LOGNAME': 'cltbld', 08:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:54 INFO - 'MOZ_NO_REMOTE': '1', 08:41:54 INFO - 'NO_EM_RESTART': '1', 08:41:54 INFO - 'PAGER': '/bin/cat', 08:41:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:54 INFO - 'PWD': '/builds/slave/test', 08:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:54 INFO - 'SHELL': '/bin/bash', 08:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:54 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:54 INFO - 'USER': 'cltbld', 08:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:54 INFO - 'XPC_FLAGS': '0x0', 08:41:54 INFO - 'XPC_SERVICE_NAME': '0', 08:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:54 INFO - Cleaning up... 08:41:54 INFO - Return code: 0 08:41:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d24a2a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, '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.1MEK3to0IM/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.6mvkm8HJVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:54 INFO - 'HOME': '/Users/cltbld', 08:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:54 INFO - 'LOGNAME': 'cltbld', 08:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:54 INFO - 'MOZ_NO_REMOTE': '1', 08:41:54 INFO - 'NO_EM_RESTART': '1', 08:41:54 INFO - 'PAGER': '/bin/cat', 08:41:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:54 INFO - 'PWD': '/builds/slave/test', 08:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:54 INFO - 'SHELL': '/bin/bash', 08:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:41:54 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:54 INFO - 'USER': 'cltbld', 08:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:54 INFO - 'XPC_FLAGS': '0x0', 08:41:54 INFO - 'XPC_SERVICE_NAME': '0', 08:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:55 INFO - Cleaning up... 08:41:55 INFO - Return code: 0 08:41:55 INFO - Running post-action listener: _resource_record_post_action 08:41:55 INFO - Running post-action listener: _start_resource_monitoring 08:41:55 INFO - Starting resource monitoring. 08:41:55 INFO - [mozharness: 2017-01-17 16:41:55.261200Z] Finished create-virtualenv step (success) 08:41:55 INFO - [mozharness: 2017-01-17 16:41:55.261968Z] Running install step. 08:41:55 INFO - Running pre-action listener: _resource_record_pre_action 08:41:55 INFO - Running main action method: install 08:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:55 INFO - Reading from file tmpfile_stdout 08:41:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:55 INFO - Reading from file tmpfile_stdout 08:41:55 INFO - Output received: 08:41:55 INFO - Usage: mozinstall [options] installer 08:41:55 INFO - Options: 08:41:55 INFO - -h, --help show this help message and exit 08:41:55 INFO - -d DEST, --destination=DEST 08:41:55 INFO - Directory to install application into. [default: 08:41:55 INFO - "/builds/slave/test"] 08:41:55 INFO - --app=APP Application being installed. [default: firefox] 08:41:55 INFO - mkdir: /builds/slave/test/build/application 08:41:55 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'] 08:41:55 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 08:42:17 INFO - Reading from file tmpfile_stdout 08:42:17 INFO - Output received: 08:42:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:42:17 INFO - Running post-action listener: _resource_record_post_action 08:42:17 INFO - [mozharness: 2017-01-17 16:42:17.779782Z] Finished install step (success) 08:42:17 INFO - [mozharness: 2017-01-17 16:42:17.779922Z] Running run-tests step. 08:42:17 INFO - Running pre-action listener: _resource_record_pre_action 08:42:17 INFO - Running main action method: run_tests 08:42:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:17 INFO - 2017-01-17 08:42:17.794 screenresolution[1638:9567] starting screenresolution argv=screenresolution get 08:42:17 INFO - 2017-01-17 08:42:17.796 screenresolution[1638:9567] Display 0: 1600x1200x32@60 08:42:17 INFO - 2017-01-17 08:42:17.802 screenresolution[1639:9570] starting screenresolution argv=screenresolution list 08:42:17 INFO - Available Modes on Display 0 08:42:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:18 INFO - Intel Iris: 08:42:18 INFO - Chipset Model: Intel Iris 08:42:18 INFO - Type: GPU 08:42:18 INFO - Bus: Built-In 08:42:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:42:18 INFO - Vendor: Intel (0x8086) 08:42:18 INFO - Device ID: 0x0a2e 08:42:18 INFO - Revision ID: 0x0009 08:42:18 INFO - Displays: 08:42:18 INFO - Display: 08:42:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:18 INFO - Display Serial Number: 1600x1200 60 08:42:18 INFO - Main Display: Yes 08:42:18 INFO - Mirror: Off 08:42:18 INFO - Online: Yes 08:42:18 INFO - Rotation: Supported 08:42:18 INFO - Return code: 0 08:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:18 INFO - Python 2.7.3 08:42:18 INFO - Return code: 0 08:42:18 INFO - grabbing minidump binary from tooltool 08:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:18 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 0x102f23d30>, '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 0x102e4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f18be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:42:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:42:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:42:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:18 INFO - Return code: 0 08:42:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:42:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:42:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:18 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/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:42:18 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/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1MEK3to0IM/Render', 08:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:18 INFO - 'HOME': '/Users/cltbld', 08:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:18 INFO - 'LOGNAME': 'cltbld', 08:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:18 INFO - 'MOZ_NO_REMOTE': '1', 08:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:18 INFO - 'NO_EM_RESTART': '1', 08:42:18 INFO - 'PAGER': '/bin/cat', 08:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:18 INFO - 'PWD': '/builds/slave/test', 08:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:18 INFO - 'SHELL': '/bin/bash', 08:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mvkm8HJVV/Listeners', 08:42:18 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:18 INFO - 'USER': 'cltbld', 08:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:18 INFO - 'XPC_FLAGS': '0x0', 08:42:18 INFO - 'XPC_SERVICE_NAME': '0', 08:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:18 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/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:42:18 INFO - mozversion application_buildid: 20170117071825 08:42:18 INFO - mozversion application_changeset: 8f272d554787e096ae515ba635c3705a6b9b6bcf 08:42:18 INFO - mozversion application_display_name: Nightly 08:42:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:18 INFO - mozversion application_name: Firefox 08:42:18 INFO - mozversion application_remotingname: firefox 08:42:18 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 08:42:18 INFO - mozversion application_vendor: Mozilla 08:42:18 INFO - mozversion application_version: 53.0a1 08:42:18 INFO - mozversion platform_buildid: 20170117071825 08:42:18 INFO - mozversion platform_changeset: 8f272d554787e096ae515ba635c3705a6b9b6bcf 08:42:18 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 08:42:18 INFO - mozversion platform_version: 53.0a1 08:42:18 INFO - using testdate: 1484671338 08:42:18 INFO - actual date: 1484671338 08:42:18 INFO - starting webserver on 'localhost:49242' 08:42:18 INFO - SUITE-START | Running 2 tests 08:42:18 INFO - TEST-START | dromaeo_css 08:42:18 INFO - operating with platform_type : mac_ 08:42:18 INFO - Initialising browser for dromaeo_css test... 08:42:18 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpUDhqLS/profile http://localhost:49242/getInfo.html) 08:42:20 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:42:20 INFO - PROCESS | 1649 | colorDepth:24 08:42:20 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:42:20 INFO - PROCESS | 1649 | __metrics 08:42:20 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:42:20 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:21 INFO - TEST-INFO | 1649: exit 0 08:42:21 INFO - Browser initialized. 08:42:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:21 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpUDhqLS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:33 INFO - PROCESS | 1652 | RSS: Main: 235700224 08:42:33 INFO - PROCESS | 1652 | 08:45:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 08:45:39 INFO - PROCESS | 1652 | RSS: Main: 451424256 08:45:39 INFO - PROCESS | 1652 | 08:47:23 INFO - PROCESS | 1652 | ************************* 08:47:23 INFO - PROCESS | 1652 | A coding exception was thrown and uncaught in a Task. 08:47:23 INFO - PROCESS | 1652 | 08:47:23 ERROR - PROCESS | 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:47:23 INFO - PROCESS | 1652 | Full stack: 08:47:23 INFO - PROCESS | 1652 | ************************* 08:48:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 08:48:42 INFO - PROCESS | 1652 | RSS: Main: 375312384 08:48:42 INFO - PROCESS | 1652 | 08:51:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 08:51:45 INFO - PROCESS | 1652 | RSS: Main: 335941632 08:51:45 INFO - PROCESS | 1652 | 08:54:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 08:54:48 INFO - PROCESS | 1652 | RSS: Main: 334401536 08:54:48 INFO - PROCESS | 1652 | 08:57:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 08:57:53 INFO - PROCESS | 1652 | RSS: Main: 320159744 08:57:53 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 09:00:56 INFO - PROCESS | 1652 | RSS: Main: 446369792 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | __start_tp_report 09:00:56 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:00:56 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:00:56 INFO - PROCESS | 1652 | |i|pagename|runs| 09:00:56 INFO - PROCESS | 1652 | |0;dojo.html;3362.730981521477;3364.814935178565;3368.6462921393268;3376.6285708572054;3427.1603457152987;5527.917081243784;5561.749721262543;5584.106542953128;5603.383627800944;5616.971915140423;5582.413846546115;5582.441755824416;5627.915581266284;5667.688277144755;5679.261695979517;4549.135664223803;4847;5064.620153488485;5114.3095682083;5164.819231326905;5140.408852981917;5213.58291336694;5230.476952304758;5233.03188910051;5285.524302812746;4572.582499425155;5062.1141300272675;5192;5195.324607801;5202.375714914197;4815.542523460301;5086.237064440326;5150.175971844487;5157.819476318311;5209.843704688866;5057.797688092472;5105.361829771278;5117.385913690344;5124.538791508782;5135.4094279157625;5618.269624948772;5618.859528511779;5619.971900140473;5623.971880140573;5644.153376993443;6095.564968108635;6097.57316987811;6112.260323016922;6123.659048217005;6185.257769067695;5501.477359650827;6237.282712488031;6249.312575616678;6262;6271.372862713738;5790.957627626984;5793.7392817323325;5794.101914203306;5797.971010144965;5801.129830525413;5495.807646732425;6150.415710507495;6173;6179.907301390483;6244.12582238487;6104.246950856165;6121.112438696364;6146.877062458726;6150.661713605705;6153.138560601519;6043.942310095804;6224.439800417984;6225;6226.40849119333;6247.219097612799;6072.028475443908;6100.248138957816;6101.338204344246;6145.4161854623735;6148.1085242639565;6194.628322300677;6200;6205.379462053758;6208.689565521796;6215.34738852423;4961.875953101201;5019.548240658285;5024.572911302507;5026.84919452417;5039.294498770175;4413.205622987893;4417.668674849399;4443.577860103285;4448.399466072104;4479.61923236522;5781;5790.507806836466;5858.297004359419;5866.7066646668345;5873.882522349614;6112.694365281807;6149.692515374213;6150.415710507495;6158.568900177034;6163.8150855474405;5693.231413759172;5758.856028599319;5830;5839.737211825478;5845.181674565564;5452.6183167177915;5458.61789674719;5497.697626630494;5510.889782204334;5563.970665426909;6407.327230640902;6429.421352078241;6430.614163150226;6436.806895793227;6439.098526206241;6129.724162412613;6150.985087460519;6193;6214.689265536796;6218.906716399167;6216.595921265103;6271.153394291895;6302.716377763103;6428.19647544057;6432.839179020562;6115.816525504242;6157.84605384869;6177.135201071764;6186.752529898754;6196.876062478816;6108.480779133645;6126.632402055891;6205.81382558524;6210.441060304594;6211.9068213977735;4917.508249175054;5909.497692695997;6017.18767966319;6123.112148738319;6138.478229350555;4922.852314430573;6016.398360164124;6054.364291749479;6083.996140636746;6092.543059270661;5709;5798.15926690619;5910.113482977587;5915.733791979285;5925.318588362394;5966.612170208922;5969.850753731192;6004.729787159501;6017.969910150421;6040.577159598786;5393.6224464287125;5849.795257165979;5852.678102704393;5857.209276747755;5857.7949771757785 09:00:56 INFO - PROCESS | 1652 | |1;ext.html;458.9678722489426;473.2215505493463;493.4300882480734;516.5196367378342;530.3344302899859;30465.695343046562;31674.52488212673;31722.682773172262;31780.20549486261;31859.884904028364;40864;42340;42570.14859702804;44448.555514444844;44735;9294.349395542298;9494.81010379792;9503.952480237589;9504.287178461644;9516.238700903945;8473;9359.812803743955;9445.00827413122;9458.196053335474;9467.81064378712;8527.829443411129;8652.740417787476;8653.783655408602;8668.696595619154;11094.778104437906;11212.271202371861;11438.428078596036;11442.42787860612;11447.25592836463;11461.713457163554;11247.887521124765;11282.379469129195;11307.49116289769;11332.716682082932;11342.943285283522;31026.844865775525;31598;38950;40117.19765604701;40530.189396212205;4036.616521430489;4046.9392959105635;4097.282975479279;4153.356229784388;4196.958030419687;28515.57226641602;30134.0959771205;30179.396412071856;30354.089377318716;30641.927532536476;3142.120206342228;3216.726578240852;3267.9183020424443;3335.5163501292177;3348.648391918862;474252;477074;478012.9999999965;478014;481576;56098.71950640221;57675.42324576701;57987.71006145026;58096;58173.70913145492;58647.70676146592;59659.70170149121;60457.69771151116;60490;60538;15638;15908.522744317688;15913.761293580606;15955.60110997211;16017;12321.93839030799;12383.876161238453;12402.627921162379;12424.627261182179;12441.942434892955;13374.598762037154;15200.695986080216;15239.085654860744;15247.466338678092;15388.922775405614;4842.868058465434;7117.928820711727;7354.154272258758;7436.814079647944;7480.8877866832045;886.4858382138344;889.6530353162271;891.4027601507006;917.738444543302;918.6555041859302;29485;29581.85209073941;29621;30112.54831177534;30312;1079.611339917629;1080.2006515178869;1116.1182665694173;1124.1905827803969;1204.1270079192516;13799.793003104962;15171.620709482351;15422.260762092814;15570.9221453892;15641.826862985321;617853;620925;621540;621749;621861.8906905437;58926;59284.70357648184;59355;59422;59536.40463595395;1283.7047479079863;1427.108057464085;1458.2562892924473;1483.7625979843174;1488.6204017975563;28840.567391489563;28994.84020639151;29047.56428653614;29698.851505742332;29748.363839989008;47796;49078.50921490882;49587.752061240906;49688.75155624199;49709.75145124251;532429;532934;536135;536177;536297;23954.88022559876;24477.51044979055;24647.507049858545;25298.74701252964;38527.42208866926;42479.788641985244;42582.787086064374;43319.35020974751;43599.12801744011;43712.34431483594;31222.531662024634;33525;35649.82175089108;36469.81765091157;36960.815195923846;34439.82780086083;34731.82634086813;34969.82515087408;35931.64068359283;35977;35085.122871927386;35194.64805351914;35291.29417411586;35507.64492355147;35632.46551301681;28919.42161156723;29533.85233073821;31360.372792543563;31874.84062579672;32007.839960800047;22750.08999640062;23170;23423.297301080995;24100.03599856056;24169.63745543783 09:00:56 INFO - PROCESS | 1652 | |2;jquery.html;345.25425081823266;374.40282749015313;396.9801509924504;403.4130340354784;415.7921238801283;12511.374431278433;15890.602734931632;19910.10404531794;21285;21561.79544988728;20916.790832091676;21008.159673613038;21135.048922798473;21270.255541056027;21296.254631087915;5763.798267060664;6126.509879209652;6126.693665316717;6129.846753831145;6148.477379422732;5307.363116426034;5933.614315069528;6699.229588597325;6742.561733487308;6819.863602727943;6383.4893208543435;6720;6729.899051514231;6737.528373013891;6745.0556922030955;6495;6535.281119076922;6559.901601475934;6585.637789921552;6588.472922166239;5193.896122077537;5501.202325662796;5505.862353441196;5649.23735295734;5734.713264336767;24613.87693061541;25289;25330.56715074873;25471.235862924143;25698.50276201657;2739.7123302053196;2748.244232835986;2772.1960631416864;2814.7185281471893;2851.7148285171525;14770.483033093898;15371.923965322432;15396.384144634201;16010.519684409486;16115.19424028794;1823.8632102592358;1827.2416946966994;1841.1829900252635;1869.9813001869943;1884.6136542008992;107767.46116269447;114199;124346;128703;129258;10610;10968.396738179317;11628.53485860573;11735.823962640567;11911.166218364631;14790.334434950453;14879.776803347959;14935.17856517902;15625.921870390803;15672.294746736425;8473.3644976627;8546.61540230691;8689.652413903374;8772.824543509094;8790.956045219733;8380.706675266458;8396.958015209884;8432.241098301183;8558.058613552505;8563.743087707378;4661.300804879295;4710.057988402334;4718.970842537742;4725.149473094876;4737.336772851803;1986.5331647062928;2035.7862424445516;2036.7148599196125;2037.0934933954545;2065.1532871522604;814.8655471847197;1000.4797505297205;1002.8746406699163;1009.8131845608586;1025.3284098915221;16011;19809.504762381057;20181.798182018287;20944.581108377748;20992.3512070754;961.5000199896015;984.5717113055844;1004.7488127968008;1019.4800651667555;1020.5203554329453;10343.1382351176;10710.03609675133;10738.355698658106;10745.570177192825;10785.352878827296;722425;730798.3460082666;737544;756094;757198.4980525766;108756;136132;143634;153205;154525.22737386465;974.6101559376165;1008.6620981971122;1029.2846471702096;1034.4310629153936;1034.6689059500889;17261.39585114565;17889.910550447687;17914.820851791836;18319.908400458444;18499.90750046295;44365.55634443614;57807.13289300748;58843.70578147082;60148.49628759316;60414.69792651009;88741.55629221813;88882;89341.55329223312;89530;89792.82390775581;7252.4560657949805;7489.251074892467;8077.31342835842;8120.431569790058;8512.574371281287;11232.831507527557;12605.24368537854;12782;13431.529896453578;13839.238841863391;11044.502997364978;11235.84333455943;11523.654290371302;11640.883591164318;11843.170978031456;10622.52198651078;10724.946375268073;11043.668689939315;11480.94259528697;11868.169228153947;10227;11093.611723589636;11566.65300041;11839.881601183877;12032.639020829389;6269.905951410824;7144.214136444883;7646.9617651911385;7696.230376962259;7876.8818467721885;10815.945920270347;11111.833322500008;11329.263597866113;11447.02700270453;11711.648650540497 09:00:56 INFO - PROCESS | 1652 | |3;mootools.html;1428.6428392901776;1438.3096113865345;1452.9346179421925;1469.404891019137;1473.5873955292516;7947.602619869005;8339;8352.164783521644;8361.540115293656;8363.289120424764;7358.22738612446;7624.733134340299;7630.732924347635;7684.846303073935;8157.306628936532;2100.7689154193026;2237.966430503544;2319.211468100845;2319.7912187903084;2327.2901764961766;2348.5655153796515;2349.048635302705;2352.3178278299274;2355.6231003039516;2356.646503024543;1756.5784211789141;2259.0737797503025;2295.701558797354;2300.148944890393;2304.0783686525356;1559.8830087743409;2229.554089182162;2300.1144559344607;2305.4121199094125;2314.2247347138727;2268.319504148749;2316.6756654068445;2332.043862016582;2335.334429687548;2342.7891489766002;8241.299489543397;8321.750347489586;8322.126176751415;8322.50064996096;8323.209295116954;4990.925136122924;5141.665791723526;5144.305518754958;5157.48425157485;5162.148245539482;3328.251143492719;3349.6650334966553;3524.6475352464804;3583.3549961007006;3613.5483064616924;1189.619321817019;1225.3750587200502;1226.7975783995719;1272.7009152849073;1274.910756247063;10742.140628749681;10777.461126943621;10783.245172837904;10815.675529734042;10883.455827208609;3480.9905127513243;4276.2089013532595;4555.635549156126;4606.95393046072;4694.718316900997;8580.957095214484;8620.655173793104;8622.870656940151;8641.697540586048;8642.827143457096;5083.923741143886;5089.134847076006;5093.134167191586;5094.592432605383;5104.438511763703;4639.721616702941;4701.247800351927;4737.928931066037;4781.474037855833;4823.155947709207;3615;3661.908452288714;3703;3752.2870654575545;3757.229767897574;1146.7362506623356;1160.843286156375;1161.7269941563725;1165.2717051842599;1173.7593793272358;589.970501474929;731.1591669580025;832.9296853543168;897.4974014551872;905.7463910105181;4564.7717614119165;5297.231901374356;5476.835694929158;5508.3114610673665;5520.806771762969;982.4841957972122;991.5835349153373;994.9253805964581;996.7557948302567;1025.0723095598346;3462.376772181032;3528.8412021459094;3649.6532829381167;3674.154944362758;3757.8496860125288;8925.553722313989;9369.250459963187;9496.572654230577;9503;9530.90469095314;9257.398269112486;9464.1009104135;9479.099485548863;9485.098915603006;9491.145796878314;7358.337749602561;7577.128630207487;7583.165851756303;7586.886196707053;7591.4685971981435;4828.8792780180775;5178.171492561172;5223.660462069954;5298;5449.6185267032515;7219.205887352282;8655.87016194745;8823.558822058743;8959;8960;8856.3800533962;9053.68312109073;9080.954595227246;9175.954120229357;9189.356745027784;7000.439964802906;7036.648167591497;7085.078939737801;7172.0676312079095;7184.640767961477;7704.768856934301;7793;7795.22047795216;7800.336971357271;7809.765707028798;6775.491838112062;6807.965960170168;6990.965045174741;7110.217876033736;7131.928680713127;6601.240857301472;6700.02849586817;6838.692258848463;6857.828554285983;6931.618760967994;5352.277442545206;6019.849503762441;6189.721462534287;6277.246730392382;6277.403646653561;4130.958690413057;4738.099761045391;4783.258594917794;4785.330053792542;4820.25286080658;4729.952700472952;4807.495213002724;4835.8065677372515;4892.951070489392;5022.974885125551 09:00:56 INFO - PROCESS | 1652 | |4;prototype.html;358.84928330101354;363.15928625232584;367.62135000949013;380.7125620156783;380.9085819403344;4296.066769953525;4503.324501324799;4607.124646317197;5064.063148317564;5211.264086354666;4927.753612319379;4978.5270399312;5068.452083541517;5124.974375128119;5150.716710580926;4004.5594984551676;4005.8998525036814;4007.098402859348;4027.0536423940353;4073.8370465181433;3193.3613277344507;3854;4031.0449432025443;4059.330210515276;4129.463169787939;3346.9497957530534;3513.595936467301;3977.303971804937;4021.3163762160502;4054.513458384983;3506.386382383073;3790.279846829121;3984.7049708844597;4027.7583344999102;4030.9798451007705;3124.53132030195;3249.723773479257;3527.664871837171;3536.664016918389;3567.1795487038125;4357.281048626973;4795.726521233117;4939.407271127488;5083.847484575469;5092.567131793802;3962.899663178491;4006.8797936061965;4643.628509719214;4668;4698.107359601665;4526.818927242939;5027.572656324217;5059.16523773577;5387.299651045379;5458.880929409462;3817.48463957365;3975.662068724133;3987.581303963071;3998.6001399859783;4028.5769994150487;5231.163013917755;5410.377806552257;5629.8592535186535;5741.076739292301;5742.674216942187;4066.6543343816106;4074.5314288856566;4074.633283004544;4085.9182816343505;4094.160697057096;3925.21495700861;4073.961139909304;4105.932457561055;4124.979375103106;4151.356539736345;4107.507099148122;4405.889852753643;4577.427821522309;4639.095376401637;4729.43246810385;4629.629629629621;4875.975620121877;5425.186222066643;5576.832695019156;5600.187972744011;1277.8977681785434;1309.849367322751;1313.5993521975697;1314.454501381935;1326.7147563273943;870.6212797433137;920.9125133112343;943.8725772020827;952.9761755956157;975.6585195181772;4249.491430542175;4320.4599425071865;4515.59729263965;4872.634552408584;4984.700917944935;4648.604868586141;5144.742762861842;5390.9191362129595;5407.972960135174;5456.590755693339;4117.171030941194;4480.305552639346;4565.589096981221;4865.805367785249;4978.278149668277;2309.8845057747044;2735.8372691605987;2800.439912017564;2804.775617950559;2812.1141840320233;4573.428321459817;4635;5068.746562671851;5408.594355423359;5648.85877853057;4698.483166851644;5307.62846600742;5508.173773933942;5534.703098214277;5546.972265138648;4837.612990960714;5240.554552863049;5611.579131565149;5611.9719401403545;5634.60557760961;4587.954120458753;5217.9478205217465;5262.8947421052135;5279.419263880894;5599.796043850592;4656.231721765871;5088.6946783193125;5570.498655120897;5590.888182236251;5640.266765320482;5361.651492652965;5622.522085622768;5868.501177399969;5880.353161152356;5901.439363260483;3437.9028792436093;3845.096677144831;3872.3997780344093;3881.0103423626792;3885.630865067927;5248.396434410091;5716.628419152742;5717.285339332583;5729.914051289317;5749.620091178171;4857.8299759508245;5052.267421223975;5351.545118664957;5548.833534993957;5553.4724201200825;5413.160960051198;5477.959187754314;5521.806736764194;5528.723563821713;5529.889402211853;5060.3927528696795;5118.590512759045;5278.313819203632;5285.471452854684;5406.75669594877;5086.21163719624;5152.995165942605;5216.791328346823;5515.200295957144;5517.2551705519245;4507.864764057083;4689.742064186366;4972.204447288416;5333.653312534673;5334.866628334323 09:00:56 INFO - PROCESS | 1652 | |5;yui.html;722.73981366708;742.2132539508121;764.6138699956521;823.5017814222396;848.5036253791532;14901.552953411401;15356.385744570232;15811.525654230392;15846.128462934534;15969.201539922986;13588.72822543551;13839.861601383984;13849.376778044987;13874.4450221991;14007.509737159202;699.5033526196406;870.1559487297311;872.2237208884098;873.981811189963;876.1457578860592;684.2404930527111;701.7964790210858;706.0750416953781;855.3883972959364;873.9519326437044;922.5018490015384;935.5228833295;936.7096200177966;936.8360536906048;940.501534186882;927.082188633255;927.958241879117;928.5032507608464;929.3355250995503;932.8367535681263;531.4711861697597;541.339565729809;549.2502733768417;696.9930300696979;702.2065066474902;12479.93760031203;12521.686957826036;14286.571402857931;14844.10935343872;14877.107373557621;14180.716385672333;14340.354684039243;14530.418783248657;14554.490592829306;14584.854151458456;11757.23577967438;11780.424568130504;11894.048476121889;12089.637310880687;12128.393580320948;3622.2703285082825;3702.9629703702885;3790.8294126764085;3791.6587507124214;3852.8844134676006;89828;99889.00332990022;99957;100690.99309006889;101835.81641835831;11112.833307500232;11243.26918750295;11247.268927519684;11257.887421125684;11267.436628168558;23164.305070847902;23313.7668623315;23313.883430582737;23334.2999710009;23372;7554.660040298199;7774.611269436506;7805.960970195113;7833.882491762628;8061.717839875576;4206.957930420718;4308.095299986975;4311.568843115726;4340.717853339523;4395.582419670126;3579.4451859961746;3687.2256826066828;3689.206820533598;3694.3165514379925;3715.3498137825773;578.4620303118056;645.2805122288709;664.2726214794792;666.2904007232282;667.2926697700453;584.3601256624075;691.218922617439;711.8433944532195;730.5470608222936;739.737393225408;9594.42433453995;9982.935153583636;10098.798024039477;10190.592376305012;10195.133413659922;665.9833504162337;682.7644462660375;709.9599087337076;720.8306048078697;723.4248772226093;4904.337914381585;4952.486647707556;4982.128127577659;4994.300797888299;4998.575121114746;79941.60029199817;82449.58775206086;101649;102912;103382;74093.5181296371;78795.21204787878;79281.60359198166;80283;82196;51093;79849;80554;80619.59690201511;82220.58889705632;9683.467409292556;9691.321607487409;9701.6604418845;9744.317897747089;9835.85246221293;46898.53101468942;47916.76041619769;48102;49056;51633;59941.40058599358;69482;69575.65212173907;69777;70382;12833.486660533474;13244.668883277995;13269.071165018742;13318.933405332911;13707.423646280806;14602;14734.557963261119;14922.179280139697;15317.004394714308;15461.922690386926;13276.977124835044;13613.421093279054;13750;13752.31238438094;13795.517156899461;13444.327783610584;13561.118527295694;13706.177629342272;13763.449462021808;14036.087654302437;13308.600741977756;13386.732265354443;13432.261225632685;13906.58280251594;13965.231912244924;10387.480625968823;11125.833112503156;11178.970783928387;11488.48301826403;11846;10762.192835537522;10912.345259284151;10925.289856159325;10960.068394186264;10966.342019478856 09:00:56 INFO - PROCESS | 1652 | __end_tp_report 09:00:56 INFO - PROCESS | 1652 | __start_cc_report 09:00:56 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2491 09:00:56 INFO - PROCESS | 1652 | __end_cc_report 09:00:56 INFO - PROCESS | 1652 | __startTimestamp1484672456387__endTimestamp 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:00:56 INFO - PROCESS | 1652 | Number of tests: 6 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5685.17 Median:5857.79 stddev:642.86 (11.0%) stddev-sans-first:618.48 09:00:56 INFO - PROCESS | 1652 | Values: 3362.7 3364.8 3368.6 3376.6 3427.2 5527.9 5561.7 5584.1 5603.4 5617.0 5582.4 5582.4 5627.9 5667.7 5679.3 4549.1 4847.0 5064.6 5114.3 5164.8 5140.4 5213.6 5230.5 5233.0 5285.5 4572.6 5062.1 5192.0 5195.3 5202.4 4815.5 5086.2 5150.2 5157.8 5209.8 5057.8 5105.4 5117.4 5124.5 5135.4 5618.3 5618.9 5620.0 5624.0 5644.2 6095.6 6097.6 6112.3 6123.7 6185.3 5501.5 6237.3 6249.3 6262.0 6271.4 5791.0 5793.7 5794.1 5798.0 5801.1 5495.8 6150.4 6173.0 6179.9 6244.1 6104.2 6121.1 6146.9 6150.7 6153.1 6043.9 6224.4 6225.0 6226.4 6247.2 6072.0 6100.2 6101.3 6145.4 6148.1 6194.6 6200.0 6205.4 6208.7 6215.3 4961.9 5019.5 5024.6 5026.8 5039.3 4413.2 4417.7 4443.6 4448.4 4479.6 5781.0 5790.5 5858.3 5866.7 5873.9 6112.7 6149.7 6150.4 6158.6 6163.8 5693.2 5758.9 5830.0 5839.7 5845.2 5452.6 5458.6 5497.7 5510.9 5564.0 6407.3 6429.4 6430.6 6436.8 6439.1 6129.7 6151.0 6193.0 6214.7 6218.9 6216.6 6271.2 6302.7 6428.2 6432.8 6115.8 6157.8 6177.1 6186.8 6196.9 6108.5 6126.6 6205.8 6210.4 6211.9 4917.5 5909.5 6017.2 6123.1 6138.5 4922.9 6016.4 6054.4 6084.0 6092.5 5709.0 5798.2 5910.1 5915.7 5925.3 5966.6 5969.9 6004.7 6018.0 6040.6 5393.6 5849.8 5852.7 5857.2 5857.8 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:67124.34 Median:35570.06 stddev:146318.73 (411.4%) stddev-sans-first:146643.58 09:00:56 INFO - PROCESS | 1652 | Values: 459.0 473.2 493.4 516.5 530.3 30465.7 31674.5 31722.7 31780.2 31859.9 40864.0 42340.0 42570.1 44448.6 44735.0 9294.3 9494.8 9504.0 9504.3 9516.2 8473.0 9359.8 9445.0 9458.2 9467.8 8527.8 8652.7 8653.8 8668.7 11094.8 11212.3 11438.4 11442.4 11447.3 11461.7 11247.9 11282.4 11307.5 11332.7 11342.9 31026.8 31598.0 38950.0 40117.2 40530.2 4036.6 4046.9 4097.3 4153.4 4197.0 28515.6 30134.1 30179.4 30354.1 30641.9 3142.1 3216.7 3267.9 3335.5 3348.6 474252.0 477074.0 478013.0 478014.0 481576.0 56098.7 57675.4 57987.7 58096.0 58173.7 58647.7 59659.7 60457.7 60490.0 60538.0 15638.0 15908.5 15913.8 15955.6 16017.0 12321.9 12383.9 12402.6 12424.6 12441.9 13374.6 15200.7 15239.1 15247.5 15388.9 4842.9 7117.9 7354.2 7436.8 7480.9 886.5 889.7 891.4 917.7 918.7 29485.0 29581.9 29621.0 30112.5 30312.0 1079.6 1080.2 1116.1 1124.2 1204.1 13799.8 15171.6 15422.3 15570.9 15641.8 617853.0 620925.0 621540.0 621749.0 621861.9 58926.0 59284.7 59355.0 59422.0 59536.4 1283.7 1427.1 1458.3 1483.8 1488.6 28840.6 28994.8 29047.6 29698.9 29748.4 47796.0 49078.5 49587.8 49688.8 49709.8 532429.0 532934.0 536135.0 536177.0 536297.0 23954.9 24477.5 24647.5 25298.7 38527.4 42479.8 42582.8 43319.4 43599.1 43712.3 31222.5 33525.0 35649.8 36469.8 36960.8 34439.8 34731.8 34969.8 35931.6 35977.0 35085.1 35194.6 35291.3 35507.6 35632.5 28919.4 29533.9 31360.4 31874.8 32007.8 22750.1 23170.0 23423.3 24100.0 24169.6 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:39934.50 Median:21071.60 stddev:122944.91 (583.5%) stddev-sans-first:123253.87 09:00:56 INFO - PROCESS | 1652 | Values: 345.3 374.4 397.0 403.4 415.8 12511.4 15890.6 19910.1 21285.0 21561.8 20916.8 21008.2 21135.0 21270.3 21296.3 5763.8 6126.5 6126.7 6129.8 6148.5 5307.4 5933.6 6699.2 6742.6 6819.9 6383.5 6720.0 6729.9 6737.5 6745.1 6495.0 6535.3 6559.9 6585.6 6588.5 5193.9 5501.2 5505.9 5649.2 5734.7 24613.9 25289.0 25330.6 25471.2 25698.5 2739.7 2748.2 2772.2 2814.7 2851.7 14770.5 15371.9 15396.4 16010.5 16115.2 1823.9 1827.2 1841.2 1870.0 1884.6 107767.5 114199.0 124346.0 128703.0 129258.0 10610.0 10968.4 11628.5 11735.8 11911.2 14790.3 14879.8 14935.2 15625.9 15672.3 8473.4 8546.6 8689.7 8772.8 8791.0 8380.7 8397.0 8432.2 8558.1 8563.7 4661.3 4710.1 4719.0 4725.1 4737.3 1986.5 2035.8 2036.7 2037.1 2065.2 814.9 1000.5 1002.9 1009.8 1025.3 16011.0 19809.5 20181.8 20944.6 20992.4 961.5 984.6 1004.7 1019.5 1020.5 10343.1 10710.0 10738.4 10745.6 10785.4 722425.0 730798.3 737544.0 756094.0 757198.5 108756.0 136132.0 143634.0 153205.0 154525.2 974.6 1008.7 1029.3 1034.4 1034.7 17261.4 17889.9 17914.8 18319.9 18499.9 44365.6 57807.1 58843.7 60148.5 60414.7 88741.6 88882.0 89341.6 89530.0 89792.8 7252.5 7489.3 8077.3 8120.4 8512.6 11232.8 12605.2 12782.0 13431.5 13839.2 11044.5 11235.8 11523.7 11640.9 11843.2 10622.5 10724.9 11043.7 11480.9 11868.2 10227.0 11093.6 11566.7 11839.9 12032.6 6269.9 7144.2 7647.0 7696.2 7876.9 10815.9 11111.8 11329.3 11447.0 11711.6 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5256.05 Median:5150.89 stddev:2840.35 (55.1%) stddev-sans-first:2833.75 09:00:56 INFO - PROCESS | 1652 | Values: 1428.6 1438.3 1452.9 1469.4 1473.6 7947.6 8339.0 8352.2 8361.5 8363.3 7358.2 7624.7 7630.7 7684.8 8157.3 2100.8 2238.0 2319.2 2319.8 2327.3 2348.6 2349.0 2352.3 2355.6 2356.6 1756.6 2259.1 2295.7 2300.1 2304.1 1559.9 2229.6 2300.1 2305.4 2314.2 2268.3 2316.7 2332.0 2335.3 2342.8 8241.3 8321.8 8322.1 8322.5 8323.2 4990.9 5141.7 5144.3 5157.5 5162.1 3328.3 3349.7 3524.6 3583.4 3613.5 1189.6 1225.4 1226.8 1272.7 1274.9 10742.1 10777.5 10783.2 10815.7 10883.5 3481.0 4276.2 4555.6 4607.0 4694.7 8581.0 8620.7 8622.9 8641.7 8642.8 5083.9 5089.1 5093.1 5094.6 5104.4 4639.7 4701.2 4737.9 4781.5 4823.2 3615.0 3661.9 3703.0 3752.3 3757.2 1146.7 1160.8 1161.7 1165.3 1173.8 590.0 731.2 832.9 897.5 905.7 4564.8 5297.2 5476.8 5508.3 5520.8 982.5 991.6 994.9 996.8 1025.1 3462.4 3528.8 3649.7 3674.2 3757.8 8925.6 9369.3 9496.6 9503.0 9530.9 9257.4 9464.1 9479.1 9485.1 9491.1 7358.3 7577.1 7583.2 7586.9 7591.5 4828.9 5178.2 5223.7 5298.0 5449.6 7219.2 8655.9 8823.6 8959.0 8960.0 8856.4 9053.7 9081.0 9176.0 9189.4 7000.4 7036.6 7085.1 7172.1 7184.6 7704.8 7793.0 7795.2 7800.3 7809.8 6775.5 6808.0 6991.0 7110.2 7131.9 6601.2 6700.0 6838.7 6857.8 6931.6 5352.3 6019.8 6189.7 6277.2 6277.4 4131.0 4738.1 4783.3 4785.3 4820.3 4730.0 4807.5 4835.8 4893.0 5023.0 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4383.91 Median:4816.67 stddev:1300.86 (27.0%) stddev-sans-first:1268.95 09:00:56 INFO - PROCESS | 1652 | Values: 358.8 363.2 367.6 380.7 380.9 4296.1 4503.3 4607.1 5064.1 5211.3 4927.8 4978.5 5068.5 5125.0 5150.7 4004.6 4005.9 4007.1 4027.1 4073.8 3193.4 3854.0 4031.0 4059.3 4129.5 3346.9 3513.6 3977.3 4021.3 4054.5 3506.4 3790.3 3984.7 4027.8 4031.0 3124.5 3249.7 3527.7 3536.7 3567.2 4357.3 4795.7 4939.4 5083.8 5092.6 3962.9 4006.9 4643.6 4668.0 4698.1 4526.8 5027.6 5059.2 5387.3 5458.9 3817.5 3975.7 3987.6 3998.6 4028.6 5231.2 5410.4 5629.9 5741.1 5742.7 4066.7 4074.5 4074.6 4085.9 4094.2 3925.2 4074.0 4105.9 4125.0 4151.4 4107.5 4405.9 4577.4 4639.1 4729.4 4629.6 4876.0 5425.2 5576.8 5600.2 1277.9 1309.8 1313.6 1314.5 1326.7 870.6 920.9 943.9 953.0 975.7 4249.5 4320.5 4515.6 4872.6 4984.7 4648.6 5144.7 5390.9 5408.0 5456.6 4117.2 4480.3 4565.6 4865.8 4978.3 2309.9 2735.8 2800.4 2804.8 2812.1 4573.4 4635.0 5068.7 5408.6 5648.9 4698.5 5307.6 5508.2 5534.7 5547.0 4837.6 5240.6 5611.6 5612.0 5634.6 4588.0 5217.9 5262.9 5279.4 5599.8 4656.2 5088.7 5570.5 5590.9 5640.3 5361.7 5622.5 5868.5 5880.4 5901.4 3437.9 3845.1 3872.4 3881.0 3885.6 5248.4 5716.6 5717.3 5729.9 5749.6 4857.8 5052.3 5351.5 5548.8 5553.5 5413.2 5478.0 5521.8 5528.7 5529.9 5060.4 5118.6 5278.3 5285.5 5406.8 5086.2 5153.0 5216.8 5515.2 5517.3 4507.9 4689.7 4972.2 5333.7 5334.9 09:00:56 INFO - PROCESS | 1652 | 09:00:56 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:19706.53 Median:4326.14 stddev:27385.71 (633.0%) stddev-sans-first:27425.44 09:00:56 INFO - PROCESS | 1652 | Values: 722.7 742.2 764.6 823.5 848.5 14901.6 15356.4 15811.5 15846.1 15969.2 13588.7 13839.9 13849.4 13874.4 14007.5 699.5 870.2 872.2 874.0 876.1 684.2 701.8 706.1 855.4 874.0 922.5 935.5 936.7 936.8 940.5 927.1 928.0 928.5 929.3 932.8 531.5 541.3 549.3 697.0 702.2 12479.9 12521.7 14286.6 14844.1 14877.1 14180.7 14340.4 14530.4 14554.5 14584.9 11757.2 11780.4 11894.0 12089.6 12128.4 3622.3 3703.0 3790.8 3791.7 3852.9 89828.0 99889.0 99957.0 100691.0 101835.8 11112.8 11243.3 11247.3 11257.9 11267.4 23164.3 23313.8 23313.9 23334.3 23372.0 7554.7 7774.6 7806.0 7833.9 8061.7 4207.0 4308.1 4311.6 4340.7 4395.6 3579.4 3687.2 3689.2 3694.3 3715.3 578.5 645.3 664.3 666.3 667.3 584.4 691.2 711.8 730.5 739.7 9594.4 9982.9 10098.8 10190.6 10195.1 666.0 682.8 710.0 720.8 723.4 4904.3 4952.5 4982.1 4994.3 4998.6 79941.6 82449.6 101649.0 102912.0 103382.0 74093.5 78795.2 79281.6 80283.0 82196.0 51093.0 79849.0 80554.0 80619.6 82220.6 9683.5 9691.3 9701.7 9744.3 9835.9 46898.5 47916.8 48102.0 49056.0 51633.0 59941.4 69482.0 69575.7 69777.0 70382.0 12833.5 13244.7 13269.1 13318.9 13707.4 14602.0 14734.6 14922.2 15317.0 15461.9 13277.0 13613.4 13750.0 13752.3 13795.5 13444.3 13561.1 13706.2 13763.4 14036.1 13308.6 13386.7 13432.3 13906.6 13965.2 10387.5 11125.8 11179.0 11488.5 11846.0 10762.2 10912.3 10925.3 10960.1 10966.3 09:00:56 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:00:56 INFO - PROCESS | 1652 | 09:00:57 INFO - TEST-INFO | 1652: exit 0 09:00:57 INFO - TEST-OK | dromaeo_css | took 1118669ms 09:00:57 INFO - TEST-START | kraken 09:00:57 INFO - operating with platform_type : mac_ 09:00:57 INFO - Initialising browser for kraken test... 09:00:57 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpuuAhWM/profile http://localhost:49242/getInfo.html) 09:00:59 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 09:00:59 INFO - PROCESS | 1658 | colorDepth:24 09:00:59 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 09:00:59 INFO - PROCESS | 1658 | __metrics 09:00:59 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:59 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:00 INFO - TEST-INFO | 1658: exit 0 09:01:00 INFO - Browser initialized. 09:01:00 INFO - Running cycle 1/1 for kraken test... 09:01:00 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpuuAhWM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:12 INFO - PROCESS | 1659 | RSS: Main: 235814912 09:01:12 INFO - PROCESS | 1659 | 09:01:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:16 INFO - PROCESS | 1659 | RSS: Main: 287744000 09:01:16 INFO - PROCESS | 1659 | 09:01:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 09:01:19 INFO - PROCESS | 1659 | RSS: Main: 286797824 09:01:19 INFO - PROCESS | 1659 | 09:01:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 09:01:23 INFO - PROCESS | 1659 | RSS: Main: 381149184 09:01:23 INFO - PROCESS | 1659 | 09:01:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 09:01:26 INFO - PROCESS | 1659 | RSS: Main: 282783744 09:01:26 INFO - PROCESS | 1659 | 09:01:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:28 INFO - PROCESS | 1659 | RSS: Main: 286433280 09:01:28 INFO - PROCESS | 1659 | 09:01:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:32 INFO - PROCESS | 1659 | RSS: Main: 327749632 09:01:32 INFO - PROCESS | 1659 | 09:01:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:35 INFO - PROCESS | 1659 | RSS: Main: 330551296 09:01:35 INFO - PROCESS | 1659 | 09:01:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 09:01:39 INFO - PROCESS | 1659 | RSS: Main: 328712192 09:01:39 INFO - PROCESS | 1659 | 09:01:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:41 INFO - PROCESS | 1659 | RSS: Main: 302456832 09:01:41 INFO - PROCESS | 1659 | 09:01:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:43 INFO - PROCESS | 1659 | RSS: Main: 304263168 09:01:43 INFO - PROCESS | 1659 | 09:01:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:46 INFO - PROCESS | 1659 | RSS: Main: 306221056 09:01:46 INFO - PROCESS | 1659 | 09:01:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:50 INFO - PROCESS | 1659 | RSS: Main: 324046848 09:01:50 INFO - PROCESS | 1659 | 09:01:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:53 INFO - PROCESS | 1659 | RSS: Main: 317673472 09:01:53 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 09:01:55 INFO - PROCESS | 1659 | RSS: Main: 361517056 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | __start_tp_report 09:01:55 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 09:01:55 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 09:01:55 INFO - PROCESS | 1659 | |i|pagename|runs| 09:01:55 INFO - PROCESS | 1659 | |0;ai-astar;114;115;115;113;114;115;114;113;115;114 09:01:55 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;110;106;133;118;130;127;138;159;111 09:01:55 INFO - PROCESS | 1659 | |2;audio-dft;182;182;183;183;181;182;183;181;182;184 09:01:55 INFO - PROCESS | 1659 | |3;audio-fft;82;58;58;88;59;59;60;58;75;58 09:01:55 INFO - PROCESS | 1659 | |4;audio-oscillator;89;70;85;70;68;69;81;67;69;83 09:01:55 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;88;84;87;83;86;85;87;83;90;83 09:01:55 INFO - PROCESS | 1659 | |6;imaging-darkroom;93;110;149;150;91;93;93;94;93;93 09:01:55 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;84;85;85;85;86;87;85;86;86 09:01:55 INFO - PROCESS | 1659 | |8;json-parse-financial;59;57;58;56;55;57;55;54;56;58 09:01:55 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;68;77;70;67;78;72;70;70;70;74 09:01:55 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;87;87;86;90;90;86;87;88;86;87 09:01:55 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;142;141;139;139;140;139;139;135;183;147 09:01:55 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;174;175;174;181;172;175;169;172;173;170 09:01:55 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;69;67;69;67;66;68;66;69;67;67 09:01:55 INFO - PROCESS | 1659 | __end_tp_report 09:01:55 INFO - PROCESS | 1659 | __start_cc_report 09:01:55 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1991 09:01:55 INFO - PROCESS | 1659 | __end_cc_report 09:01:55 INFO - PROCESS | 1659 | __startTimestamp1484672515766__endTimestamp 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | ------- Summary: start ------- 09:01:55 INFO - PROCESS | 1659 | Number of tests: 14 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:01:55 INFO - PROCESS | 1659 | Values: 114.0 115.0 115.0 113.0 114.0 115.0 114.0 113.0 115.0 114.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:131.50 stddev:16.70 (12.7%) stddev-sans-first:16.75 09:01:55 INFO - PROCESS | 1659 | Values: 143.0 110.0 106.0 133.0 118.0 130.0 127.0 138.0 159.0 111.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.50 stddev:0.95 (0.5%) stddev-sans-first:1.00 09:01:55 INFO - PROCESS | 1659 | Values: 182.0 182.0 183.0 183.0 181.0 182.0 183.0 181.0 182.0 184.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:65.50 Median:59.50 stddev:11.59 (19.5%) stddev-sans-first:10.64 09:01:55 INFO - PROCESS | 1659 | Values: 82.0 58.0 58.0 88.0 59.0 59.0 60.0 58.0 75.0 58.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.37 (11.1%) stddev-sans-first:7.21 09:01:55 INFO - PROCESS | 1659 | Values: 89.0 70.0 85.0 70.0 68.0 69.0 81.0 67.0 69.0 83.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.41 (2.8%) stddev-sans-first:2.40 09:01:55 INFO - PROCESS | 1659 | Values: 88.0 84.0 87.0 83.0 86.0 85.0 87.0 83.0 90.0 83.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:93.00 stddev:23.61 (25.4%) stddev-sans-first:24.57 09:01:55 INFO - PROCESS | 1659 | Values: 93.0 110.0 149.0 150.0 91.0 93.0 93.0 94.0 93.0 93.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 09:01:55 INFO - PROCESS | 1659 | Values: 86.0 84.0 85.0 85.0 85.0 86.0 87.0 85.0 86.0 86.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.39 09:01:55 INFO - PROCESS | 1659 | Values: 59.0 57.0 58.0 56.0 55.0 57.0 55.0 54.0 56.0 58.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:3.66 (5.2%) stddev-sans-first:3.64 09:01:55 INFO - PROCESS | 1659 | Values: 68.0 77.0 70.0 67.0 78.0 72.0 70.0 70.0 70.0 74.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 09:01:55 INFO - PROCESS | 1659 | Values: 87.0 87.0 86.0 90.0 90.0 86.0 87.0 88.0 86.0 87.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:140.50 stddev:13.90 (9.9%) stddev-sans-first:14.71 09:01:55 INFO - PROCESS | 1659 | Values: 142.0 141.0 139.0 139.0 140.0 139.0 139.0 135.0 183.0 147.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:3.31 (1.9%) stddev-sans-first:3.50 09:01:55 INFO - PROCESS | 1659 | Values: 174.0 175.0 174.0 181.0 172.0 175.0 169.0 172.0 173.0 170.0 09:01:55 INFO - PROCESS | 1659 | 09:01:55 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.18 (1.7%) stddev-sans-first:1.12 09:01:55 INFO - PROCESS | 1659 | Values: 69.0 67.0 69.0 67.0 66.0 68.0 66.0 69.0 67.0 67.0 09:01:55 INFO - PROCESS | 1659 | -------- Summary: end -------- 09:01:55 INFO - PROCESS | 1659 | 09:01:56 INFO - TEST-INFO | 1659: exit 0 09:01:56 INFO - TEST-OK | kraken | took 59625ms 09:01:56 INFO - SUITE-END | took 1178s 09:01:56 INFO - Completed test suite (00:19:38) 09:01:56 INFO - javascript benchmark 09:01:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.730981521477, 3364.814935178565, 3368.6462921393268, 3376.6285708572054, 3427.1603457152987, 5527.917081243784, 5561.749721262543, 5584.106542953128, 5603.383627800944, 5616.971915140423, 5582.413846546115, 5582.441755824416, 5627.915581266284, 5667.688277144755, 5679.261695979517, 4549.135664223803, 4847.0, 5064.620153488485, 5114.3095682083, 5164.819231326905, 5140.408852981917, 5213.58291336694, 5230.476952304758, 5233.03188910051, 5285.524302812746, 4572.582499425155, 5062.1141300272675, 5192.0, 5195.324607801, 5202.375714914197, 4815.542523460301, 5086.237064440326, 5150.175971844487, 5157.819476318311, 5209.843704688866, 5057.797688092472, 5105.361829771278, 5117.385913690344, 5124.538791508782, 5135.4094279157625, 5618.269624948772, 5618.859528511779, 5619.971900140473, 5623.971880140573, 5644.153376993443, 6095.564968108635, 6097.57316987811, 6112.260323016922, 6123.659048217005, 6185.257769067695, 5501.477359650827, 6237.282712488031, 6249.312575616678, 6262.0, 6271.372862713738, 5790.957627626984, 5793.7392817323325, 5794.101914203306, 5797.971010144965, 5801.129830525413, 5495.807646732425, 6150.415710507495, 6173.0, 6179.907301390483, 6244.12582238487, 6104.246950856165, 6121.112438696364, 6146.877062458726, 6150.661713605705, 6153.138560601519, 6043.942310095804, 6224.439800417984, 6225.0, 6226.40849119333, 6247.219097612799, 6072.028475443908, 6100.248138957816, 6101.338204344246, 6145.4161854623735, 6148.1085242639565, 6194.628322300677, 6200.0, 6205.379462053758, 6208.689565521796, 6215.34738852423, 4961.875953101201, 5019.548240658285, 5024.572911302507, 5026.84919452417, 5039.294498770175, 4413.205622987893, 4417.668674849399, 4443.577860103285, 4448.399466072104, 4479.61923236522, 5781.0, 5790.507806836466, 5858.297004359419, 5866.7066646668345, 5873.882522349614, 6112.694365281807, 6149.692515374213, 6150.415710507495, 6158.568900177034, 6163.8150855474405, 5693.231413759172, 5758.856028599319, 5830.0, 5839.737211825478, 5845.181674565564, 5452.6183167177915, 5458.61789674719, 5497.697626630494, 5510.889782204334, 5563.970665426909, 6407.327230640902, 6429.421352078241, 6430.614163150226, 6436.806895793227, 6439.098526206241, 6129.724162412613, 6150.985087460519, 6193.0, 6214.689265536796, 6218.906716399167, 6216.595921265103, 6271.153394291895, 6302.716377763103, 6428.19647544057, 6432.839179020562, 6115.816525504242, 6157.84605384869, 6177.135201071764, 6186.752529898754, 6196.876062478816, 6108.480779133645, 6126.632402055891, 6205.81382558524, 6210.441060304594, 6211.9068213977735, 4917.508249175054, 5909.497692695997, 6017.18767966319, 6123.112148738319, 6138.478229350555, 4922.852314430573, 6016.398360164124, 6054.364291749479, 6083.996140636746, 6092.543059270661, 5709.0, 5798.15926690619, 5910.113482977587, 5915.733791979285, 5925.318588362394, 5966.612170208922, 5969.850753731192, 6004.729787159501, 6017.969910150421, 6040.577159598786, 5393.6224464287125, 5849.795257165979, 5852.678102704393, 5857.209276747755, 5857.7949771757785], "value": 5645.047315183404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.9678722489426, 473.2215505493463, 493.4300882480734, 516.5196367378342, 530.3344302899859, 30465.695343046562, 31674.52488212673, 31722.682773172262, 31780.20549486261, 31859.884904028364, 40864.0, 42340.0, 42570.14859702804, 44448.555514444844, 44735.0, 9294.349395542298, 9494.81010379792, 9503.952480237589, 9504.287178461644, 9516.238700903945, 8473.0, 9359.812803743955, 9445.00827413122, 9458.196053335474, 9467.81064378712, 8527.829443411129, 8652.740417787476, 8653.783655408602, 8668.696595619154, 11094.778104437906, 11212.271202371861, 11438.428078596036, 11442.42787860612, 11447.25592836463, 11461.713457163554, 11247.887521124765, 11282.379469129195, 11307.49116289769, 11332.716682082932, 11342.943285283522, 31026.844865775525, 31598.0, 38950.0, 40117.19765604701, 40530.189396212205, 4036.616521430489, 4046.9392959105635, 4097.282975479279, 4153.356229784388, 4196.958030419687, 28515.57226641602, 30134.0959771205, 30179.396412071856, 30354.089377318716, 30641.927532536476, 3142.120206342228, 3216.726578240852, 3267.9183020424443, 3335.5163501292177, 3348.648391918862, 474252.0, 477074.0, 478012.9999999965, 478014.0, 481576.0, 56098.71950640221, 57675.42324576701, 57987.71006145026, 58096.0, 58173.70913145492, 58647.70676146592, 59659.70170149121, 60457.69771151116, 60490.0, 60538.0, 15638.0, 15908.522744317688, 15913.761293580606, 15955.60110997211, 16017.0, 12321.93839030799, 12383.876161238453, 12402.627921162379, 12424.627261182179, 12441.942434892955, 13374.598762037154, 15200.695986080216, 15239.085654860744, 15247.466338678092, 15388.922775405614, 4842.868058465434, 7117.928820711727, 7354.154272258758, 7436.814079647944, 7480.8877866832045, 886.4858382138344, 889.6530353162271, 891.4027601507006, 917.738444543302, 918.6555041859302, 29485.0, 29581.85209073941, 29621.0, 30112.54831177534, 30312.0, 1079.611339917629, 1080.2006515178869, 1116.1182665694173, 1124.1905827803969, 1204.1270079192516, 13799.793003104962, 15171.620709482351, 15422.260762092814, 15570.9221453892, 15641.826862985321, 617853.0, 620925.0, 621540.0, 621749.0, 621861.8906905437, 58926.0, 59284.70357648184, 59355.0, 59422.0, 59536.40463595395, 1283.7047479079863, 1427.108057464085, 1458.2562892924473, 1483.7625979843174, 1488.6204017975563, 28840.567391489563, 28994.84020639151, 29047.56428653614, 29698.851505742332, 29748.363839989008, 47796.0, 49078.50921490882, 49587.752061240906, 49688.75155624199, 49709.75145124251, 532429.0, 532934.0, 536135.0, 536177.0, 536297.0, 23954.88022559876, 24477.51044979055, 24647.507049858545, 25298.74701252964, 38527.42208866926, 42479.788641985244, 42582.787086064374, 43319.35020974751, 43599.12801744011, 43712.34431483594, 31222.531662024634, 33525.0, 35649.82175089108, 36469.81765091157, 36960.815195923846, 34439.82780086083, 34731.82634086813, 34969.82515087408, 35931.64068359283, 35977.0, 35085.122871927386, 35194.64805351914, 35291.29417411586, 35507.64492355147, 35632.46551301681, 28919.42161156723, 29533.85233073821, 31360.372792543563, 31874.84062579672, 32007.839960800047, 22750.08999640062, 23170.0, 23423.297301080995, 24100.03599856056, 24169.63745543783], "value": 19396.67875190291, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.25425081823266, 374.40282749015313, 396.9801509924504, 403.4130340354784, 415.7921238801283, 12511.374431278433, 15890.602734931632, 19910.10404531794, 21285.0, 21561.79544988728, 20916.790832091676, 21008.159673613038, 21135.048922798473, 21270.255541056027, 21296.254631087915, 5763.798267060664, 6126.509879209652, 6126.693665316717, 6129.846753831145, 6148.477379422732, 5307.363116426034, 5933.614315069528, 6699.229588597325, 6742.561733487308, 6819.863602727943, 6383.4893208543435, 6720.0, 6729.899051514231, 6737.528373013891, 6745.0556922030955, 6495.0, 6535.281119076922, 6559.901601475934, 6585.637789921552, 6588.472922166239, 5193.896122077537, 5501.202325662796, 5505.862353441196, 5649.23735295734, 5734.713264336767, 24613.87693061541, 25289.0, 25330.56715074873, 25471.235862924143, 25698.50276201657, 2739.7123302053196, 2748.244232835986, 2772.1960631416864, 2814.7185281471893, 2851.7148285171525, 14770.483033093898, 15371.923965322432, 15396.384144634201, 16010.519684409486, 16115.19424028794, 1823.8632102592358, 1827.2416946966994, 1841.1829900252635, 1869.9813001869943, 1884.6136542008992, 107767.46116269447, 114199.0, 124346.0, 128703.0, 129258.0, 10610.0, 10968.396738179317, 11628.53485860573, 11735.823962640567, 11911.166218364631, 14790.334434950453, 14879.776803347959, 14935.17856517902, 15625.921870390803, 15672.294746736425, 8473.3644976627, 8546.61540230691, 8689.652413903374, 8772.824543509094, 8790.956045219733, 8380.706675266458, 8396.958015209884, 8432.241098301183, 8558.058613552505, 8563.743087707378, 4661.300804879295, 4710.057988402334, 4718.970842537742, 4725.149473094876, 4737.336772851803, 1986.5331647062928, 2035.7862424445516, 2036.7148599196125, 2037.0934933954545, 2065.1532871522604, 814.8655471847197, 1000.4797505297205, 1002.8746406699163, 1009.8131845608586, 1025.3284098915221, 16011.0, 19809.504762381057, 20181.798182018287, 20944.581108377748, 20992.3512070754, 961.5000199896015, 984.5717113055844, 1004.7488127968008, 1019.4800651667555, 1020.5203554329453, 10343.1382351176, 10710.03609675133, 10738.355698658106, 10745.570177192825, 10785.352878827296, 722425.0, 730798.3460082666, 737544.0, 756094.0, 757198.4980525766, 108756.0, 136132.0, 143634.0, 153205.0, 154525.22737386465, 974.6101559376165, 1008.6620981971122, 1029.2846471702096, 1034.4310629153936, 1034.6689059500889, 17261.39585114565, 17889.910550447687, 17914.820851791836, 18319.908400458444, 18499.90750046295, 44365.55634443614, 57807.13289300748, 58843.70578147082, 60148.49628759316, 60414.69792651009, 88741.55629221813, 88882.0, 89341.55329223312, 89530.0, 89792.82390775581, 7252.4560657949805, 7489.251074892467, 8077.31342835842, 8120.431569790058, 8512.574371281287, 11232.831507527557, 12605.24368537854, 12782.0, 13431.529896453578, 13839.238841863391, 11044.502997364978, 11235.84333455943, 11523.654290371302, 11640.883591164318, 11843.170978031456, 10622.52198651078, 10724.946375268073, 11043.668689939315, 11480.94259528697, 11868.169228153947, 10227.0, 11093.611723589636, 11566.65300041, 11839.881601183877, 12032.639020829389, 6269.905951410824, 7144.214136444883, 7646.9617651911385, 7696.230376962259, 7876.8818467721885, 10815.945920270347, 11111.833322500008, 11329.263597866113, 11447.02700270453, 11711.648650540497], "value": 9984.667065046226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.6428392901776, 1438.3096113865345, 1452.9346179421925, 1469.404891019137, 1473.5873955292516, 7947.602619869005, 8339.0, 8352.164783521644, 8361.540115293656, 8363.289120424764, 7358.22738612446, 7624.733134340299, 7630.732924347635, 7684.846303073935, 8157.306628936532, 2100.7689154193026, 2237.966430503544, 2319.211468100845, 2319.7912187903084, 2327.2901764961766, 2348.5655153796515, 2349.048635302705, 2352.3178278299274, 2355.6231003039516, 2356.646503024543, 1756.5784211789141, 2259.0737797503025, 2295.701558797354, 2300.148944890393, 2304.0783686525356, 1559.8830087743409, 2229.554089182162, 2300.1144559344607, 2305.4121199094125, 2314.2247347138727, 2268.319504148749, 2316.6756654068445, 2332.043862016582, 2335.334429687548, 2342.7891489766002, 8241.299489543397, 8321.750347489586, 8322.126176751415, 8322.50064996096, 8323.209295116954, 4990.925136122924, 5141.665791723526, 5144.305518754958, 5157.48425157485, 5162.148245539482, 3328.251143492719, 3349.6650334966553, 3524.6475352464804, 3583.3549961007006, 3613.5483064616924, 1189.619321817019, 1225.3750587200502, 1226.7975783995719, 1272.7009152849073, 1274.910756247063, 10742.140628749681, 10777.461126943621, 10783.245172837904, 10815.675529734042, 10883.455827208609, 3480.9905127513243, 4276.2089013532595, 4555.635549156126, 4606.95393046072, 4694.718316900997, 8580.957095214484, 8620.655173793104, 8622.870656940151, 8641.697540586048, 8642.827143457096, 5083.923741143886, 5089.134847076006, 5093.134167191586, 5094.592432605383, 5104.438511763703, 4639.721616702941, 4701.247800351927, 4737.928931066037, 4781.474037855833, 4823.155947709207, 3615.0, 3661.908452288714, 3703.0, 3752.2870654575545, 3757.229767897574, 1146.7362506623356, 1160.843286156375, 1161.7269941563725, 1165.2717051842599, 1173.7593793272358, 589.970501474929, 731.1591669580025, 832.9296853543168, 897.4974014551872, 905.7463910105181, 4564.7717614119165, 5297.231901374356, 5476.835694929158, 5508.3114610673665, 5520.806771762969, 982.4841957972122, 991.5835349153373, 994.9253805964581, 996.7557948302567, 1025.0723095598346, 3462.376772181032, 3528.8412021459094, 3649.6532829381167, 3674.154944362758, 3757.8496860125288, 8925.553722313989, 9369.250459963187, 9496.572654230577, 9503.0, 9530.90469095314, 9257.398269112486, 9464.1009104135, 9479.099485548863, 9485.098915603006, 9491.145796878314, 7358.337749602561, 7577.128630207487, 7583.165851756303, 7586.886196707053, 7591.4685971981435, 4828.8792780180775, 5178.171492561172, 5223.660462069954, 5298.0, 5449.6185267032515, 7219.205887352282, 8655.87016194745, 8823.558822058743, 8959.0, 8960.0, 8856.3800533962, 9053.68312109073, 9080.954595227246, 9175.954120229357, 9189.356745027784, 7000.439964802906, 7036.648167591497, 7085.078939737801, 7172.0676312079095, 7184.640767961477, 7704.768856934301, 7793.0, 7795.22047795216, 7800.336971357271, 7809.765707028798, 6775.491838112062, 6807.965960170168, 6990.965045174741, 7110.217876033736, 7131.928680713127, 6601.240857301472, 6700.02849586817, 6838.692258848463, 6857.828554285983, 6931.618760967994, 5352.277442545206, 6019.849503762441, 6189.721462534287, 6277.246730392382, 6277.403646653561, 4130.958690413057, 4738.099761045391, 4783.258594917794, 4785.330053792542, 4820.25286080658, 4729.952700472952, 4807.495213002724, 4835.8065677372515, 4892.951070489392, 5022.974885125551], "value": 4289.540980619522, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.84928330101354, 363.15928625232584, 367.62135000949013, 380.7125620156783, 380.9085819403344, 4296.066769953525, 4503.324501324799, 4607.124646317197, 5064.063148317564, 5211.264086354666, 4927.753612319379, 4978.5270399312, 5068.452083541517, 5124.974375128119, 5150.716710580926, 4004.5594984551676, 4005.8998525036814, 4007.098402859348, 4027.0536423940353, 4073.8370465181433, 3193.3613277344507, 3854.0, 4031.0449432025443, 4059.330210515276, 4129.463169787939, 3346.9497957530534, 3513.595936467301, 3977.303971804937, 4021.3163762160502, 4054.513458384983, 3506.386382383073, 3790.279846829121, 3984.7049708844597, 4027.7583344999102, 4030.9798451007705, 3124.53132030195, 3249.723773479257, 3527.664871837171, 3536.664016918389, 3567.1795487038125, 4357.281048626973, 4795.726521233117, 4939.407271127488, 5083.847484575469, 5092.567131793802, 3962.899663178491, 4006.8797936061965, 4643.628509719214, 4668.0, 4698.107359601665, 4526.818927242939, 5027.572656324217, 5059.16523773577, 5387.299651045379, 5458.880929409462, 3817.48463957365, 3975.662068724133, 3987.581303963071, 3998.6001399859783, 4028.5769994150487, 5231.163013917755, 5410.377806552257, 5629.8592535186535, 5741.076739292301, 5742.674216942187, 4066.6543343816106, 4074.5314288856566, 4074.633283004544, 4085.9182816343505, 4094.160697057096, 3925.21495700861, 4073.961139909304, 4105.932457561055, 4124.979375103106, 4151.356539736345, 4107.507099148122, 4405.889852753643, 4577.427821522309, 4639.095376401637, 4729.43246810385, 4629.629629629621, 4875.975620121877, 5425.186222066643, 5576.832695019156, 5600.187972744011, 1277.8977681785434, 1309.849367322751, 1313.5993521975697, 1314.454501381935, 1326.7147563273943, 870.6212797433137, 920.9125133112343, 943.8725772020827, 952.9761755956157, 975.6585195181772, 4249.491430542175, 4320.4599425071865, 4515.59729263965, 4872.634552408584, 4984.700917944935, 4648.604868586141, 5144.742762861842, 5390.9191362129595, 5407.972960135174, 5456.590755693339, 4117.171030941194, 4480.305552639346, 4565.589096981221, 4865.805367785249, 4978.278149668277, 2309.8845057747044, 2735.8372691605987, 2800.439912017564, 2804.775617950559, 2812.1141840320233, 4573.428321459817, 4635.0, 5068.746562671851, 5408.594355423359, 5648.85877853057, 4698.483166851644, 5307.62846600742, 5508.173773933942, 5534.703098214277, 5546.972265138648, 4837.612990960714, 5240.554552863049, 5611.579131565149, 5611.9719401403545, 5634.60557760961, 4587.954120458753, 5217.9478205217465, 5262.8947421052135, 5279.419263880894, 5599.796043850592, 4656.231721765871, 5088.6946783193125, 5570.498655120897, 5590.888182236251, 5640.266765320482, 5361.651492652965, 5622.522085622768, 5868.501177399969, 5880.353161152356, 5901.439363260483, 3437.9028792436093, 3845.096677144831, 3872.3997780344093, 3881.0103423626792, 3885.630865067927, 5248.396434410091, 5716.628419152742, 5717.285339332583, 5729.914051289317, 5749.620091178171, 4857.8299759508245, 5052.267421223975, 5351.545118664957, 5548.833534993957, 5553.4724201200825, 5413.160960051198, 5477.959187754314, 5521.806736764194, 5528.723563821713, 5529.889402211853, 5060.3927528696795, 5118.590512759045, 5278.313819203632, 5285.471452854684, 5406.75669594877, 5086.21163719624, 5152.995165942605, 5216.791328346823, 5515.200295957144, 5517.2551705519245, 4507.864764057083, 4689.742064186366, 4972.204447288416, 5333.653312534673, 5334.866628334323], "value": 3994.512971088556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.73981366708, 742.2132539508121, 764.6138699956521, 823.5017814222396, 848.5036253791532, 14901.552953411401, 15356.385744570232, 15811.525654230392, 15846.128462934534, 15969.201539922986, 13588.72822543551, 13839.861601383984, 13849.376778044987, 13874.4450221991, 14007.509737159202, 699.5033526196406, 870.1559487297311, 872.2237208884098, 873.981811189963, 876.1457578860592, 684.2404930527111, 701.7964790210858, 706.0750416953781, 855.3883972959364, 873.9519326437044, 922.5018490015384, 935.5228833295, 936.7096200177966, 936.8360536906048, 940.501534186882, 927.082188633255, 927.958241879117, 928.5032507608464, 929.3355250995503, 932.8367535681263, 531.4711861697597, 541.339565729809, 549.2502733768417, 696.9930300696979, 702.2065066474902, 12479.93760031203, 12521.686957826036, 14286.571402857931, 14844.10935343872, 14877.107373557621, 14180.716385672333, 14340.354684039243, 14530.418783248657, 14554.490592829306, 14584.854151458456, 11757.23577967438, 11780.424568130504, 11894.048476121889, 12089.637310880687, 12128.393580320948, 3622.2703285082825, 3702.9629703702885, 3790.8294126764085, 3791.6587507124214, 3852.8844134676006, 89828.0, 99889.00332990022, 99957.0, 100690.99309006889, 101835.81641835831, 11112.833307500232, 11243.26918750295, 11247.268927519684, 11257.887421125684, 11267.436628168558, 23164.305070847902, 23313.7668623315, 23313.883430582737, 23334.2999710009, 23372.0, 7554.660040298199, 7774.611269436506, 7805.960970195113, 7833.882491762628, 8061.717839875576, 4206.957930420718, 4308.095299986975, 4311.568843115726, 4340.717853339523, 4395.582419670126, 3579.4451859961746, 3687.2256826066828, 3689.206820533598, 3694.3165514379925, 3715.3498137825773, 578.4620303118056, 645.2805122288709, 664.2726214794792, 666.2904007232282, 667.2926697700453, 584.3601256624075, 691.218922617439, 711.8433944532195, 730.5470608222936, 739.737393225408, 9594.42433453995, 9982.935153583636, 10098.798024039477, 10190.592376305012, 10195.133413659922, 665.9833504162337, 682.7644462660375, 709.9599087337076, 720.8306048078697, 723.4248772226093, 4904.337914381585, 4952.486647707556, 4982.128127577659, 4994.300797888299, 4998.575121114746, 79941.60029199817, 82449.58775206086, 101649.0, 102912.0, 103382.0, 74093.5181296371, 78795.21204787878, 79281.60359198166, 80283.0, 82196.0, 51093.0, 79849.0, 80554.0, 80619.59690201511, 82220.58889705632, 9683.467409292556, 9691.321607487409, 9701.6604418845, 9744.317897747089, 9835.85246221293, 46898.53101468942, 47916.76041619769, 48102.0, 49056.0, 51633.0, 59941.40058599358, 69482.0, 69575.65212173907, 69777.0, 70382.0, 12833.486660533474, 13244.668883277995, 13269.071165018742, 13318.933405332911, 13707.423646280806, 14602.0, 14734.557963261119, 14922.179280139697, 15317.004394714308, 15461.922690386926, 13276.977124835044, 13613.421093279054, 13750.0, 13752.31238438094, 13795.517156899461, 13444.327783610584, 13561.118527295694, 13706.177629342272, 13763.449462021808, 14036.087654302437, 13308.600741977756, 13386.732265354443, 13432.261225632685, 13906.58280251594, 13965.231912244924, 10387.480625968823, 11125.833112503156, 11178.970783928387, 11488.48301826403, 11846.0, 10762.192835537522, 10912.345259284151, 10925.289856159325, 10960.068394186264, 10966.342019478856], "value": 7472.314904539255, "unit": "score"}], "name": "dromaeo_css", "value": 7205.839883527998, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0, 113.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 106.0, 133.0, 118.0, 130.0, 127.0, 138.0, 159.0, 111.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 183.0, 183.0, 181.0, 182.0, 183.0, 181.0, 182.0, 184.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 88.0, 59.0, 59.0, 60.0, 58.0, 75.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 70.0, 68.0, 69.0, 81.0, 67.0, 69.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 83.0, 86.0, 85.0, 87.0, 83.0, 90.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 149.0, 150.0, 91.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 85.0, 86.0, 87.0, 85.0, 86.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 56.0, 55.0, 57.0, 55.0, 54.0, 56.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 70.0, 67.0, 78.0, 72.0, 70.0, 70.0, 70.0, 74.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 90.0, 90.0, 86.0, 87.0, 88.0, 86.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 139.0, 139.0, 140.0, 139.0, 139.0, 135.0, 183.0, 147.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 174.0, 181.0, 172.0, 175.0, 169.0, 172.0, 173.0, 170.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 67.0, 66.0, 68.0, 66.0, 69.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1442.5000000000002, "alertThreshold": 2.0}]} 09:01:57 INFO - Return code: 0 09:01:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:57 ERROR - # TBPL SUCCESS # 09:01:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:57 INFO - 2017-01-17 09:01:57.107 screenresolution[1663:11928] starting screenresolution argv=screenresolution get 09:01:57 INFO - 2017-01-17 09:01:57.110 screenresolution[1663:11928] Display 0: 1600x1200x32@60 09:01:57 INFO - 2017-01-17 09:01:57.116 screenresolution[1664:11931] starting screenresolution argv=screenresolution list 09:01:57 INFO - Available Modes on Display 0 09:01:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:57 INFO - Intel Iris: 09:01:57 INFO - Chipset Model: Intel Iris 09:01:57 INFO - Type: GPU 09:01:57 INFO - Bus: Built-In 09:01:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:57 INFO - Vendor: Intel (0x8086) 09:01:57 INFO - Device ID: 0x0a2e 09:01:57 INFO - Revision ID: 0x0009 09:01:57 INFO - Displays: 09:01:57 INFO - Display: 09:01:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:57 INFO - Display Serial Number: 1600x1200 60 09:01:57 INFO - Main Display: Yes 09:01:57 INFO - Mirror: Off 09:01:57 INFO - Online: Yes 09:01:57 INFO - Rotation: Supported 09:01:57 INFO - Return code: 0 09:01:57 INFO - Running post-action listener: _resource_record_post_action 09:01:57 INFO - [mozharness: 2017-01-17 17:01:57.350480Z] Finished run-tests step (success) 09:01:57 INFO - Running post-run listener: _resource_record_post_run 09:01:57 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32009216; Write bytes: 557422592; Read time: 195; Write time: 1655 09:01:57 INFO - TinderboxPrint: CPU usage
53.6% 09:01:57 INFO - TinderboxPrint: I/O read bytes / time
32,009,216 / 195 09:01:57 INFO - TinderboxPrint: I/O write bytes / time
557,422,592 / 1,655 09:01:57 INFO - TinderboxPrint: CPU idle
2,231.7 (46.4%) 09:01:57 INFO - TinderboxPrint: CPU system
958.1 (19.9%) 09:01:57 INFO - TinderboxPrint: CPU user
1,615.9 (33.6%) 09:01:57 INFO - TinderboxPrint: Swap in / out
280,281,088 / 0 09:01:57 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 244075008; Write bytes: 236425216; Read time: 17559; Write time: 483 09:01:57 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30002176; Write bytes: 300658688; Read time: 175; Write time: 1121 09:01:57 INFO - Running post-run listener: _upload_blobber_files 09:01:57 INFO - Blob upload gear active. 09:01:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:57 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'] 09:01:57 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 09:01:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:59 INFO - (blobuploader) - INFO - Done attempting. 09:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:00 INFO - (blobuploader) - INFO - Done attempting. 09:02:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:02:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:01 INFO - (blobuploader) - INFO - Done attempting. 09:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:04 INFO - (blobuploader) - INFO - Done attempting. 09:02:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:04 INFO - Return code: 0 09:02:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/01767c5e275e8df7bd1e722a6e5b35df09dae1762e7317c4206e686aeb1dc1a154e284bc58951567e2a997a7266f8fef9dc44b69384e43149ccdef8d4eb02e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1bb107c96e7e13dfa96ad1fcda4bea0fee1a41d8638b856b86b0449b89c462b8074ba08f1e36963e373413c75d7efe19d9ae1d512a1a9d3c8a5583175dcf3163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e63bd033e30ebb4dbd2ecb9ef32ea49a674bb3914122953f56580e7b524475c43541eb59a6cad77a8cecc83a31e9b97a4ac3af7b84c216395e0c0715228fd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e621cc6f02324690c953d949b96db58b90909ba3cc1744480681228ac98363f500f2152648a6e91c52e33ccbb88ae2c1f28c957ca57155fd32356c6997d5ae65"} 09:02:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:04 INFO - Contents: 09:02:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/01767c5e275e8df7bd1e722a6e5b35df09dae1762e7317c4206e686aeb1dc1a154e284bc58951567e2a997a7266f8fef9dc44b69384e43149ccdef8d4eb02e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1bb107c96e7e13dfa96ad1fcda4bea0fee1a41d8638b856b86b0449b89c462b8074ba08f1e36963e373413c75d7efe19d9ae1d512a1a9d3c8a5583175dcf3163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e63bd033e30ebb4dbd2ecb9ef32ea49a674bb3914122953f56580e7b524475c43541eb59a6cad77a8cecc83a31e9b97a4ac3af7b84c216395e0c0715228fd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e621cc6f02324690c953d949b96db58b90909ba3cc1744480681228ac98363f500f2152648a6e91c52e33ccbb88ae2c1f28c957ca57155fd32356c6997d5ae65"} 09:02:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:04 INFO - Copying logs to upload dir... 09:02:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.337371 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 09:02:04.145906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 09:02:04.149210) ========= 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.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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/01767c5e275e8df7bd1e722a6e5b35df09dae1762e7317c4206e686aeb1dc1a154e284bc58951567e2a997a7266f8fef9dc44b69384e43149ccdef8d4eb02e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1bb107c96e7e13dfa96ad1fcda4bea0fee1a41d8638b856b86b0449b89c462b8074ba08f1e36963e373413c75d7efe19d9ae1d512a1a9d3c8a5583175dcf3163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e63bd033e30ebb4dbd2ecb9ef32ea49a674bb3914122953f56580e7b524475c43541eb59a6cad77a8cecc83a31e9b97a4ac3af7b84c216395e0c0715228fd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e621cc6f02324690c953d949b96db58b90909ba3cc1744480681228ac98363f500f2152648a6e91c52e33ccbb88ae2c1f28c957ca57155fd32356c6997d5ae65"} build_url:https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/RjE4wcgpQUutU_UA6z1OxA/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/01767c5e275e8df7bd1e722a6e5b35df09dae1762e7317c4206e686aeb1dc1a154e284bc58951567e2a997a7266f8fef9dc44b69384e43149ccdef8d4eb02e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1bb107c96e7e13dfa96ad1fcda4bea0fee1a41d8638b856b86b0449b89c462b8074ba08f1e36963e373413c75d7efe19d9ae1d512a1a9d3c8a5583175dcf3163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e63bd033e30ebb4dbd2ecb9ef32ea49a674bb3914122953f56580e7b524475c43541eb59a6cad77a8cecc83a31e9b97a4ac3af7b84c216395e0c0715228fd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e621cc6f02324690c953d949b96db58b90909ba3cc1744480681228ac98363f500f2152648a6e91c52e33ccbb88ae2c1f28c957ca57155fd32356c6997d5ae65"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 09:02:04.184262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:02:04.184666) ========= 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.1MEK3to0IM/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.6mvkm8HJVV/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005005 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:02:04.233527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 09:02:04.233857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 09:02:04.234206) ========= ========= Total master_lag: 0.19 =========