builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0216 starttime: 1480944703.95 results: success (0) buildid: 20161205032438 builduid: 2602dd485acc4387b777bd4f4aa3f427 revision: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:43.955034) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:43.955457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:43.955760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:44.331855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:44.332221) ========= 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.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 --2016-12-05 05:31:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 35.4M=0s 2016-12-05 05:31:44 (35.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110290 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:44.486605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:44.486913) ========= 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.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.026064 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:44.571377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-05 05:31:44.571725) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac --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 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 2016-12-05 05:31:44,691 truncating revision to first 12 chars 2016-12-05 05:31:44,691 Setting DEBUG logging. 2016-12-05 05:31:44,692 attempt 1/10 2016-12-05 05:31:44,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/954a21ff3d44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 05:31:46,472 unpacking tar archive at: graphics-954a21ff3d44/testing/mozharness/ program finished with exit code 0 elapsedTime=2.054676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-05 05:31:46.650474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:46.650742) ========= script_repo_revision: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:46.651103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:46.651381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 05:31:46.672328) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-05 05:31:46.672688) ========= /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.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:31:46 INFO - MultiFileLogger online at 20161205 05:31:46 in /builds/slave/test 05:31:46 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 05:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:46 INFO - {'append_to_log': False, 05:31:46 INFO - 'base_work_dir': '/builds/slave/test', 05:31:46 INFO - 'blob_upload_branch': 'Graphics', 05:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:46 INFO - 'branch': 'Graphics', 05:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:46 INFO - 'config_files': ('talos/mac_config.py',), 05:31:46 INFO - 'default_actions': ('clobber', 05:31:46 INFO - 'read-buildbot-config', 05:31:46 INFO - 'download-and-extract', 05:31:46 INFO - 'populate-webroot', 05:31:46 INFO - 'create-virtualenv', 05:31:46 INFO - 'install', 05:31:46 INFO - 'run-tests'), 05:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:46 INFO - 'download_minidump_stackwalk': True, 05:31:46 INFO - 'download_symbols': 'ondemand', 05:31:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:46 INFO - 'installer_path': 'installer.exe', 05:31:46 INFO - 'log_level': 'info', 05:31:46 INFO - 'log_name': 'talos', 05:31:46 INFO - 'log_to_console': True, 05:31:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:46 INFO - 'opt_config_files': (), 05:31:46 INFO - 'pip_index': False, 05:31:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:46 INFO - 'cmd': ('bash', 05:31:46 INFO - '-c', 05:31:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:46 INFO - 'enabled': True, 05:31:46 INFO - 'halt_on_failure': False, 05:31:46 INFO - 'name': 'check_screen_resolution'},), 05:31:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:46 INFO - 'cmd': ('bash', 05:31:46 INFO - '-c', 05:31:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:46 INFO - 'enabled': True, 05:31:46 INFO - 'halt_on_failure': False, 05:31:46 INFO - 'name': 'check_screen_resolution'},), 05:31:46 INFO - 'run_cmd_checks_enabled': True, 05:31:46 INFO - 'sps_profile': False, 05:31:46 INFO - 'sps_profile_interval': 0, 05:31:46 INFO - 'suite': 'dromaeojs', 05:31:46 INFO - 'system_bits': '32', 05:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:46 INFO - 'title': 't-yosemite-r7-0216', 05:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:46 INFO - 'use_talos_json': True, 05:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:46 INFO - 'work_dir': 'build'} 05:31:46 INFO - [mozharness: 2016-12-05 13:31:46.897927Z] Running clobber step. 05:31:46 INFO - Running pre-action listener: _resource_record_pre_action 05:31:46 INFO - Running main action method: clobber 05:31:46 INFO - rmtree: /builds/slave/test/build 05:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:49 INFO - Running post-action listener: _resource_record_post_action 05:31:49 INFO - [mozharness: 2016-12-05 13:31:49.229041Z] Finished clobber step (success) 05:31:49 INFO - [mozharness: 2016-12-05 13:31:49.229271Z] Running read-buildbot-config step. 05:31:49 INFO - Running pre-action listener: _resource_record_pre_action 05:31:49 INFO - Running main action method: read_buildbot_config 05:31:49 INFO - Using buildbot properties: 05:31:49 INFO - { 05:31:49 INFO - "project": "", 05:31:49 INFO - "product": "firefox", 05:31:49 INFO - "script_repo_revision": "default", 05:31:49 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 05:31:49 INFO - "repository": "", 05:31:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 05:31:49 INFO - "buildid": "20161205032438", 05:31:49 INFO - "pgo_build": "False", 05:31:49 INFO - "basedir": "/builds/slave/test", 05:31:49 INFO - "buildnumber": 5, 05:31:49 INFO - "slavename": "t-yosemite-r7-0216", 05:31:49 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:31:49 INFO - "platform": "yosemite_r7", 05:31:49 INFO - "scheduler": "tests-graphics-macosx64-talos", 05:31:49 INFO - "branch": "graphics", 05:31:49 INFO - "repo_path": "projects/graphics", 05:31:49 INFO - "revision": "954a21ff3d449fddeb02cd5c9758ef89dc34d4ac", 05:31:49 INFO - "stage_platform": "macosx64", 05:31:49 INFO - "builduid": "2602dd485acc4387b777bd4f4aa3f427", 05:31:49 INFO - "slavebuilddir": "test" 05:31:49 INFO - } 05:31:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:31:49 INFO - Running post-action listener: _resource_record_post_action 05:31:49 INFO - [mozharness: 2016-12-05 13:31:49.234975Z] Finished read-buildbot-config step (success) 05:31:49 INFO - [mozharness: 2016-12-05 13:31:49.235158Z] Running download-and-extract step. 05:31:49 INFO - Running pre-action listener: _resource_record_pre_action 05:31:49 INFO - Running main action method: download_and_extract 05:31:49 INFO - mkdir: /builds/slave/test/build/tests 05:31: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')]} 05:31:49 INFO - trying https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:31:49 INFO - Downloading https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/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 05:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/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 05:31:50 INFO - Downloaded 1199 bytes. 05:31:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:31:50 INFO - Using the following test package requirements: 05:31:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:31:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:31:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'jsshell-mac.zip'], 05:31:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:31:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:31:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:31:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:31:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:31:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:31:50 INFO - Http code: 200 05:31:50 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 05:31:50 INFO - x-amz-cf-id: lD4eM6efRUG4hay2x1LcdiCu1_20Oy3kh81pTZSpPYqO2GtXHxMe_Q== 05:31:50 INFO - x-amz-version-id: iipLAJwrQOju9JuKLyYj7FccMPK9Mt1L 05:31:51 INFO - Expected file size: 16282644 05:31:51 INFO - Obtained file size: 16282644 05:31:58 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 05:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:31:58 INFO - Http code: 200 05:31:58 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:31:58 INFO - x-amz-cf-id: NP9Ym3LwqKwb1KPzSD5tpf2DIDyMkMffHFDB6cm6uNuMp9U8VOvH-Q== 05:31:58 INFO - x-amz-version-id: iipLAJwrQOju9JuKLyYj7FccMPK9Mt1L 05:31:58 INFO - Expected file size: 16282644 05:31:58 INFO - Obtained file size: 16282644 05:32:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:32:06 INFO - Http code: 200 05:32:06 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 05:32:06 INFO - x-amz-cf-id: n_HN6pLTMSatLjrdeTVH42Ub4F6Ghuur0f8cybDajeuCngPOjMJ2mw== 05:32:06 INFO - x-amz-version-id: OPCsQFfImY62Yt7Tt_A0RrNxzNA_pjjZ 05:32:06 INFO - Expected file size: 14409702 05:32:06 INFO - Obtained file size: 14409702 05:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:07 INFO - trying https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/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 05:32:09 INFO - Downloaded 107768371 bytes. 05:32:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:09 INFO - mkdir: /builds/slave/test/properties 05:32:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:09 INFO - Contents: 05:32:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:10 INFO - Running post-action listener: _resource_record_post_action 05:32:10 INFO - Running post-action listener: set_extra_try_arguments 05:32:10 INFO - [mozharness: 2016-12-05 13:32:10.693703Z] Finished download-and-extract step (success) 05:32:10 INFO - [mozharness: 2016-12-05 13:32:10.693852Z] Running populate-webroot step. 05:32:10 INFO - Running pre-action listener: _resource_record_pre_action 05:32:10 INFO - Running main action method: populate_webroot 05:32:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:10 INFO - '--tppagecycles', 05:32:10 INFO - '7'], 05:32:10 INFO - 'tests': ['tsvgm']}}, 05:32:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['damp', 'tps']}, 05:32:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'tests': ['damp', 'tps']}, 05:32:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['dromaeo_dom']}, 05:32:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['basic_compositor_video']}, 05:32:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['a11yr', 05:32:10 INFO - 'ts_paint', 05:32:10 INFO - 'tpaint', 05:32:10 INFO - 'sessionrestore', 05:32:10 INFO - 'sessionrestore_no_auto_restore', 05:32:10 INFO - 'tabpaint']}, 05:32:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['tsvgx', 05:32:10 INFO - 'tsvgr_opacity', 05:32:10 INFO - 'tart', 05:32:10 INFO - 'tscrollx', 05:32:10 INFO - 'cart', 05:32:10 INFO - 'tsvg_static']}, 05:32:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:10 INFO - 'tsvgr_opacity', 05:32:10 INFO - 'tart', 05:32:10 INFO - 'tscrollx', 05:32:10 INFO - 'cart', 05:32:10 INFO - 'tsvg_static']}, 05:32:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'talos_options': ['--disable-e10s'], 05:32:10 INFO - 'tests': ['tp5o']}, 05:32:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:32:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'talos_options': ['--disable-e10s', 05:32:10 INFO - '--xperf_path', 05:32:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:10 INFO - 'tests': ['tp5n']}, 05:32:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:32:10 INFO - 'talos_options': ['--xperf_path', 05:32:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:10 INFO - 'tests': ['tp5n']}}, 05:32:10 INFO - 'talos.zip': {'path': '', 05:32:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:10 INFO - Running post-action listener: _resource_record_post_action 05:32:10 INFO - [mozharness: 2016-12-05 13:32:10.712227Z] Finished populate-webroot step (success) 05:32:10 INFO - [mozharness: 2016-12-05 13:32:10.712357Z] Running create-virtualenv step. 05:32:10 INFO - Running pre-action listener: _resource_record_pre_action 05:32:10 INFO - Running main action method: create_virtualenv 05:32:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:32:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:10 INFO - Using real prefix '/tools/python27' 05:32:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:14 INFO - Installing pip.................done. 05:32:14 INFO - Return code: 0 05:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:14 INFO - Reading from file tmpfile_stdout 05:32:14 INFO - Output received: 05:32:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:32:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:14 INFO - 'HOME': '/Users/cltbld', 05:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PAGER': '/bin/cat', 05:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:14 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - 'XPC_FLAGS': '0x0', 05:32:14 INFO - 'XPC_SERVICE_NAME': '0', 05:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:32:14 INFO - Cleaning up... 05:32:14 INFO - Return code: 0 05:32:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:14 INFO - 'HOME': '/Users/cltbld', 05:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PAGER': '/bin/cat', 05:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:14 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - 'XPC_FLAGS': '0x0', 05:32:14 INFO - 'XPC_SERVICE_NAME': '0', 05:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:15 INFO - Downloading/unpacking psutil>=3.1.1 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:18 INFO - Installing collected packages: psutil 05:32:18 INFO - Running setup.py install for psutil 05:32:18 INFO - building 'psutil._psutil_osx' extension 05:32:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:32:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:32:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:32:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:32:19 INFO - building 'psutil._psutil_posix' extension 05:32:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:32:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:19 INFO - ^ 05:32:19 INFO - 1 warning generated. 05:32:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:20 INFO - Successfully installed psutil 05:32:20 INFO - Cleaning up... 05:32:20 INFO - Return code: 0 05:32:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:20 INFO - 'HOME': '/Users/cltbld', 05:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:20 INFO - 'LOGNAME': 'cltbld', 05:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:20 INFO - 'MOZ_NO_REMOTE': '1', 05:32:20 INFO - 'NO_EM_RESTART': '1', 05:32:20 INFO - 'PAGER': '/bin/cat', 05:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:20 INFO - 'PWD': '/builds/slave/test', 05:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:20 INFO - 'SHELL': '/bin/bash', 05:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:20 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:20 INFO - 'USER': 'cltbld', 05:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:20 INFO - 'XPC_FLAGS': '0x0', 05:32:20 INFO - 'XPC_SERVICE_NAME': '0', 05:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:22 INFO - Installing collected packages: mozsystemmonitor 05:32:22 INFO - Running setup.py install for mozsystemmonitor 05:32:23 INFO - Successfully installed mozsystemmonitor 05:32:23 INFO - Cleaning up... 05:32:23 INFO - Return code: 0 05:32:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:23 INFO - 'HOME': '/Users/cltbld', 05:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:23 INFO - 'LOGNAME': 'cltbld', 05:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:23 INFO - 'MOZ_NO_REMOTE': '1', 05:32:23 INFO - 'NO_EM_RESTART': '1', 05:32:23 INFO - 'PAGER': '/bin/cat', 05:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:23 INFO - 'PWD': '/builds/slave/test', 05:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:23 INFO - 'SHELL': '/bin/bash', 05:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:23 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:23 INFO - 'USER': 'cltbld', 05:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:23 INFO - 'XPC_FLAGS': '0x0', 05:32:23 INFO - 'XPC_SERVICE_NAME': '0', 05:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:26 INFO - warning: no files found matching '*.txt' 05:32:26 INFO - no previously-included directories found matching 'build' 05:32:26 INFO - no previously-included directories found matching 'dist' 05:32:26 INFO - no previously-included directories found matching '.git*' 05:32:26 INFO - Installing collected packages: jsonschema, functools32 05:32:26 INFO - Running setup.py install for functools32 05:32:26 INFO - warning: no files found matching '*.txt' 05:32:26 INFO - no previously-included directories found matching 'build' 05:32:26 INFO - no previously-included directories found matching 'dist' 05:32:26 INFO - no previously-included directories found matching '.git*' 05:32:26 INFO - Successfully installed jsonschema functools32 05:32:26 INFO - Cleaning up... 05:32:26 INFO - Return code: 0 05:32:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:26 INFO - 'HOME': '/Users/cltbld', 05:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:26 INFO - 'LOGNAME': 'cltbld', 05:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:26 INFO - 'MOZ_NO_REMOTE': '1', 05:32:26 INFO - 'NO_EM_RESTART': '1', 05:32:26 INFO - 'PAGER': '/bin/cat', 05:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:26 INFO - 'PWD': '/builds/slave/test', 05:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:26 INFO - 'SHELL': '/bin/bash', 05:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:26 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:26 INFO - 'USER': 'cltbld', 05:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:26 INFO - 'XPC_FLAGS': '0x0', 05:32:26 INFO - 'XPC_SERVICE_NAME': '0', 05:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:31 INFO - Downloading docopt-0.6.1.tar.gz 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:31 INFO - Running setup.py install for blobuploader 05:32:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:31 INFO - Running setup.py install for requests 05:32:31 INFO - Running setup.py install for docopt 05:32:32 INFO - Successfully installed blobuploader requests docopt 05:32:32 INFO - Cleaning up... 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-nFZI_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-WN0VKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-zal3YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-OQnRmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-WE1WJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-evv5tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:32 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-h94EF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-LtbP4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-gnzBpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-PkrP0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-zUPS4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-ZPaSVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-RZTtM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-d49RC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-qmoFfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:33 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-OtdKNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:34 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-8gY3Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:34 INFO - Running setup.py install for manifestparser 05:32:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Running setup.py install for mozcrash 05:32:34 INFO - Running setup.py install for mozdebug 05:32:34 INFO - Running setup.py install for mozdevice 05:32:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Running setup.py install for mozfile 05:32:34 INFO - Running setup.py install for mozhttpd 05:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozinfo 05:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozInstall 05:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozleak 05:32:35 INFO - Running setup.py install for mozlog 05:32:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for moznetwork 05:32:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozprocess 05:32:35 INFO - Running setup.py install for mozprofile 05:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for mozrunner 05:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for mozscreenshot 05:32:36 INFO - Running setup.py install for moztest 05:32:36 INFO - Running setup.py install for mozversion 05:32:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:36 INFO - Cleaning up... 05:32:36 INFO - Return code: 0 05:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:36 INFO - 'HOME': '/Users/cltbld', 05:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:36 INFO - 'LOGNAME': 'cltbld', 05:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:36 INFO - 'MOZ_NO_REMOTE': '1', 05:32:36 INFO - 'NO_EM_RESTART': '1', 05:32:36 INFO - 'PAGER': '/bin/cat', 05:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:36 INFO - 'PWD': '/builds/slave/test', 05:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:36 INFO - 'SHELL': '/bin/bash', 05:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:36 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:36 INFO - 'USER': 'cltbld', 05:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:36 INFO - 'XPC_FLAGS': '0x0', 05:32:36 INFO - 'XPC_SERVICE_NAME': '0', 05:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-PbAbWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-KI0ilq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-iuW3ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-wD_InV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-QDK0ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-FIu8ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-7q4qr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Yv0mEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Z2N6Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:37 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-JPphOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-lj2JKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Pxw1zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-jKf0JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-9T1BPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-zmTzXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-MMZGCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:38 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-34NmBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:41 INFO - Downloading blessings-1.6.tar.gz 05:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:41 INFO - Installing collected packages: blessings 05:32:41 INFO - Running setup.py install for blessings 05:32:41 INFO - Successfully installed blessings 05:32:41 INFO - Cleaning up... 05:32:41 INFO - Return code: 0 05:32:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Current package versions: 05:32:42 INFO - blessings == 1.6 05:32:42 INFO - blobuploader == 1.2.4 05:32:42 INFO - docopt == 0.6.1 05:32:42 INFO - functools32 == 3.2.3-2 05:32:42 INFO - jsonschema == 2.5.1 05:32:42 INFO - manifestparser == 1.1 05:32:42 INFO - mozInstall == 1.12 05:32:42 INFO - mozcrash == 1.0 05:32:42 INFO - mozdebug == 0.1 05:32:42 INFO - mozdevice == 0.49 05:32:42 INFO - mozfile == 1.2 05:32:42 INFO - mozhttpd == 0.7 05:32:42 INFO - mozinfo == 0.9 05:32:42 INFO - mozleak == 0.1 05:32:42 INFO - mozlog == 3.4 05:32:42 INFO - moznetwork == 0.27 05:32:42 INFO - mozprocess == 0.23 05:32:42 INFO - mozprofile == 0.28 05:32:42 INFO - mozrunner == 6.13 05:32:42 INFO - mozscreenshot == 0.1 05:32:42 INFO - mozsystemmonitor == 0.3 05:32:42 INFO - moztest == 0.7 05:32:42 INFO - mozversion == 1.4 05:32:42 INFO - psutil == 3.1.1 05:32:42 INFO - requests == 1.2.3 05:32:42 INFO - wsgiref == 0.1.2 05:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:42 INFO - 'HOME': '/Users/cltbld', 05:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:42 INFO - 'LOGNAME': 'cltbld', 05:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:42 INFO - 'MOZ_NO_REMOTE': '1', 05:32:42 INFO - 'NO_EM_RESTART': '1', 05:32:42 INFO - 'PAGER': '/bin/cat', 05:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:42 INFO - 'PWD': '/builds/slave/test', 05:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:42 INFO - 'SHELL': '/bin/bash', 05:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:42 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:42 INFO - 'USER': 'cltbld', 05:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:42 INFO - 'XPC_FLAGS': '0x0', 05:32:42 INFO - 'XPC_SERVICE_NAME': '0', 05:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:42 INFO - Cleaning up... 05:32:42 INFO - Return code: 0 05:32:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ab7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc541459c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, '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.apwHSXpYBl/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.cQrm8lnxgB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 05:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:42 INFO - 'HOME': '/Users/cltbld', 05:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:42 INFO - 'LOGNAME': 'cltbld', 05:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:42 INFO - 'MOZ_NO_REMOTE': '1', 05:32:42 INFO - 'NO_EM_RESTART': '1', 05:32:42 INFO - 'PAGER': '/bin/cat', 05:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:42 INFO - 'PWD': '/builds/slave/test', 05:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:42 INFO - 'SHELL': '/bin/bash', 05:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:32:42 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:42 INFO - 'USER': 'cltbld', 05:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:42 INFO - 'XPC_FLAGS': '0x0', 05:32:42 INFO - 'XPC_SERVICE_NAME': '0', 05:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:42 INFO - Cleaning up... 05:32:42 INFO - Return code: 0 05:32:42 INFO - Running post-action listener: _resource_record_post_action 05:32:42 INFO - Running post-action listener: _start_resource_monitoring 05:32:42 INFO - Starting resource monitoring. 05:32:42 INFO - [mozharness: 2016-12-05 13:32:42.590797Z] Finished create-virtualenv step (success) 05:32:42 INFO - [mozharness: 2016-12-05 13:32:42.591818Z] Running install step. 05:32:42 INFO - Running pre-action listener: _resource_record_pre_action 05:32:42 INFO - Running main action method: install 05:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Output received: 05:32:42 INFO - Usage: mozinstall [options] installer 05:32:42 INFO - Options: 05:32:42 INFO - -h, --help show this help message and exit 05:32:42 INFO - -d DEST, --destination=DEST 05:32:42 INFO - Directory to install application into. [default: 05:32:42 INFO - "/builds/slave/test"] 05:32:42 INFO - --app=APP Application being installed. [default: firefox] 05:32:42 INFO - mkdir: /builds/slave/test/build/application 05:32:42 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'] 05:32:42 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 05:33:15 INFO - Reading from file tmpfile_stdout 05:33:15 INFO - Output received: 05:33:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:33:15 INFO - Running post-action listener: _resource_record_post_action 05:33:15 INFO - [mozharness: 2016-12-05 13:33:15.279878Z] Finished install step (success) 05:33:15 INFO - [mozharness: 2016-12-05 13:33:15.280058Z] Running run-tests step. 05:33:15 INFO - Running pre-action listener: _resource_record_pre_action 05:33:15 INFO - Running main action method: run_tests 05:33:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:15 INFO - 2016-12-05 05:33:15.294 screenresolution[1654:7507] starting screenresolution argv=screenresolution get 05:33:15 INFO - 2016-12-05 05:33:15.297 screenresolution[1654:7507] Display 0: 1600x1200x32@60 05:33:15 INFO - 2016-12-05 05:33:15.303 screenresolution[1655:7509] starting screenresolution argv=screenresolution list 05:33:15 INFO - Available Modes on Display 0 05:33:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:15 INFO - Intel Iris: 05:33:15 INFO - Chipset Model: Intel Iris 05:33:15 INFO - Type: GPU 05:33:15 INFO - Bus: Built-In 05:33:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:15 INFO - Vendor: Intel (0x8086) 05:33:15 INFO - Device ID: 0x0a2e 05:33:15 INFO - Revision ID: 0x0009 05:33:15 INFO - Displays: 05:33:15 INFO - Display: 05:33:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:15 INFO - Display Serial Number: 1600x1200 60 05:33:15 INFO - Main Display: Yes 05:33:15 INFO - Mirror: Off 05:33:15 INFO - Online: Yes 05:33:15 INFO - Rotation: Supported 05:33:15 INFO - Return code: 0 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:15 INFO - Python 2.7.3 05:33:15 INFO - Return code: 0 05:33:15 INFO - grabbing minidump binary from tooltool 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:15 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 0x108957d30>, '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 0x1087bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10894fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:15 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 05:33:15 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 05:33:15 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 05:33:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:15 INFO - Return code: 0 05:33:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:15 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/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 05:33:15 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/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0216 --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 05:33:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.apwHSXpYBl/Render', 05:33:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:15 INFO - 'HOME': '/Users/cltbld', 05:33:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:15 INFO - 'LOGNAME': 'cltbld', 05:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:15 INFO - 'MOZ_NO_REMOTE': '1', 05:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'NO_EM_RESTART': '1', 05:33:15 INFO - 'PAGER': '/bin/cat', 05:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:15 INFO - 'PWD': '/builds/slave/test', 05:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:15 INFO - 'SHELL': '/bin/bash', 05:33:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQrm8lnxgB/Listeners', 05:33:15 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 05:33:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:15 INFO - 'USER': 'cltbld', 05:33:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:15 INFO - 'XPC_FLAGS': '0x0', 05:33:15 INFO - 'XPC_SERVICE_NAME': '0', 05:33:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:15 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/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 05:33:15 INFO - mozversion application_buildid: 20161205032438 05:33:15 INFO - mozversion application_changeset: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac 05:33:15 INFO - mozversion application_display_name: Nightly 05:33:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:15 INFO - mozversion application_name: Firefox 05:33:15 INFO - mozversion application_remotingname: firefox 05:33:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 05:33:15 INFO - mozversion application_vendor: Mozilla 05:33:15 INFO - mozversion application_version: 53.0a1 05:33:15 INFO - mozversion platform_buildid: 20161205032438 05:33:15 INFO - mozversion platform_changeset: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac 05:33:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 05:33:15 INFO - mozversion platform_version: 53.0a1 05:33:15 INFO - using testdate: 1480944795 05:33:15 INFO - actual date: 1480944795 05:33:15 INFO - starting webserver on 'localhost:49235' 05:33:15 INFO - SUITE-START | Running 2 tests 05:33:15 INFO - TEST-START | dromaeo_css 05:33:15 INFO - operating with platform_type : mac_ 05:33:15 INFO - Initialising browser for dromaeo_css test... 05:33:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpAnm603/profile http://localhost:49235/getInfo.html) 05:33:18 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:33:18 INFO - PROCESS | 1665 | colorDepth:24 05:33:18 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:33:18 INFO - PROCESS | 1665 | __metrics 05:33:18 INFO - PROCESS | 1665 | 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" 05:33:18 INFO - PROCESS | 1665 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:20 INFO - TEST-INFO | 1665: exit 0 05:33:20 INFO - Browser initialized. 05:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:20 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpAnm603/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:32 INFO - PROCESS | 1667 | RSS: Main: 244027392 05:33:32 INFO - PROCESS | 1667 | 05:34:24 INFO - PROCESS | 1667 | 1480944864129 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 05:36:38 INFO - PROCESS | 1667 | RSS: Main: 468066304 05:36:38 INFO - PROCESS | 1667 | 05:39:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 05:39:42 INFO - PROCESS | 1667 | RSS: Main: 368050176 05:39:42 INFO - PROCESS | 1667 | 05:42:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 05:42:45 INFO - PROCESS | 1667 | RSS: Main: 342081536 05:42:45 INFO - PROCESS | 1667 | 05:45:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 05:45:48 INFO - PROCESS | 1667 | RSS: Main: 369737728 05:45:48 INFO - PROCESS | 1667 | 05:48:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 05:48:53 INFO - PROCESS | 1667 | RSS: Main: 331038720 05:48:53 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 05:51:56 INFO - PROCESS | 1667 | RSS: Main: 382173184 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | __start_tp_report 05:51:56 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:51:56 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:51:56 INFO - PROCESS | 1667 | |i|pagename|runs| 05:51:56 INFO - PROCESS | 1667 | |0;dojo.html;2665.546857034304;3059.8164110153393;3254.641989381169;3302.719268862147;3313.1054615253865;5438.782448702047;5494.36814766302;5518.558515318775;5588.273524441822;5604.551635869136;5504.697241651707;5537.529310008644;5613.971930140354;5622.634528755628;5642.238297829802;5030.899382012376;5037.1940489521685;5067.189249720045;5101.872453188663;5133.204353325222;5098.694078355292;5152.510511501401;5157.896842063175;5162.303089082963;5202.7658755355915;5013.849584512471;5146.150885103953;5150.536451719326;5162.148245539482;5264.42091369949;5043.949560504385;5044.218146187347;5054.2923990640975;5110.310108135392;5115.693058416507;5034.723090230036;5097.362829646294;5115.309433226504;5134.691918484903;5146.459621739738;5555.694436805974;5584;5605.243292155547;5621.156826476062;5639.6334238274385;5905.114232865061;5999.040153575407;6038.969805150946;6119.326874043852;6161.969190154021;6175.814725558241;6198.597091189104;6229.595076320024;6240.594361366497;6244.718987645567;5714.257146570919;5721.542276617861;5732.713364331808;5735.483806457439;5759.020966435716;6114.67123069571;6172.074188871616;6177.783777567854;6275.717592708339;6290.4653104485715;4762.738049407316;5962.522998160137;6007.459328660441;6100.739137556996;6141.477974372139;6159.692015399212;6199.256089269226;6207.875842483125;6212.534059945522;6232.002879539343;6093.75624974996;6141.508679305645;6151.5386346024225;6168.691565421711;6196.411340922605;5950.702464876739;6017.976943919544;6026.487748541335;6087.239095113111;6094.481969032593;4815.783289751969;4856.3201151838775;4860.538248866352;4871.634627402959;4874.975625121922;4314.827406903752;4321.0709697415205;4442.800073996678;4453.866384008485;4460.8661740147845;5415.539679127318;5653.123765816305;5684.062129748628;5688.544916406678;5759.971200143972;5436.619436639477;5937.317208521075;6205.472534834499;6235.064740288993;6242.906356404657;5563.805266815642;5706.972744905874;5739.971300143473;5740.655560666373;5750.396208398141;5236.371635403776;5304.443033481506;5304.602154838402;5309.601779866448;5318.122509785842;6144.433169541739;6188.721507532172;6210.627362358273;6242.188515492957;6279.843003924939;5088.491150884882;6128.448439640454;6212.596181248205;6227.782027629011;6246.875062498815;4685.882852928567;6024.186734790923;6254.030625253093;6258.186435763321;6272.780452684134;5835.358110607915;5864.501517370901;5928.614640048383;5935.851603709942;5942.376050514807;5930.7924222652;6022.969885150546;6032.969835150796;6044.304904935989;6048.304444988883;5677.886442271214;5767.134929760402;5826.067829147316;5834.095715164156;5839.416058394127;5825.097109947965;5846.064629659234;5849.678267695318;5854.414558544111;5856.150858125633;4835.661503694849;5770.6249093808765;5834.94165058344;5856.092305692625;5859.824205273849;5836.153757705024;5982.940170598238;5990.1913241713555;6033.728482218223;6092;5863.472287494146;5864.67744274052;5876.412358764261;5877.676727780014;5885.61743486672 05:51:56 INFO - PROCESS | 1667 | |1;ext.html;429.9273313083856;465.87491208730916;478.7654049515738;487.05268253247425;505.17656220360817;35101;40663;40752.59247407529;42754.35868461976;42905.92735181614;41821.58178418215;42142.367864482054;42259.78870105645;42271.78864105683;42320.365194522106;8516.23353898149;9308.534573271343;9486.478243696594;9501.144896959273;9501.334906556544;8503.277221436185;11107.333559986426;11378.658640240807;11386.772264554704;11556.30662160269;11355.091592672567;11414.258073225214;11415.543378264902;11450.541978320898;11494.195406321562;8522.105178956182;8723.432976856484;11238.831417528743;11282.717932051683;11326.320420774697;10974.561017559288;11286.322820630789;11330.150238732045;11429.885701142965;11488.77022459546;39055.60944390576;39319.80340098281;39419.802900985596;39441.802790985865;39469.605303947166;3292.1769557610596;3329.9833500832583;3453.4992426098074;3801.885943421702;3972.7219094663387;29177.41645167106;29486.705132948824;30181.547276790865;30210;30309.848450757825;3110.9066727998197;3249.39886121066;3276.9016929492154;3321.534985102088;3324;449921;451175.74412128056;459217;463225;464457;57241.42758572444;57481.137782932456;57575.13637295444;57671;57797.71101144551;59641.70179149076;59969.70015149896;60079.098813517834;60117.69941150266;60201.69899150476;15212.250591182155;15412.537623871078;15423;15426.997245179027;15438.15090170029;10924.617638382619;11204.943975280072;11210.943945280385;12167;12226.449809758582;15327;15957.361705531648;15997.600059998593;16003.439879604159;16218.75671864923;5739.397363276879;6847.21257055445;6886.24251332353;6916.6541672916155;6933.168019837652;748.356413484403;827.6441130314023;980.6959842448864;1044.6657069737762;1139.6865861888048;24377.512449750906;26488.802298187646;27854.72145278562;28262.010829620864;29297.707022929924;1062.0422124383554;1072.5066469423996;1095.6822521468844;1143.9428028598536;1189.8929096381366;14715.632109197355;15046.849531504546;15139.772903406458;15427.152859330137;15562.533124006299;578256;578701;582398;582701;585168;55871.72064139653;55912.72043639837;55988;56059.87880242372;56115;1221.2001139253803;1270.9237445753283;1338.3709656461447;1373.0251521419905;1390.3951780975308;26295.9770968924;29828.552571711876;31620.36759264756;31806.84096579502;32149;51133.48866511287;51847.96304073822;51855.2221716667;51920.48079519308;51987.480125198264;534796;538013;540248;545090;547559;24986.875065624554;25880.870595647655;25894.741052589987;38141.809290953366;38600.80699596484;37432.625673742914;37677.4348384769;42381;46098.76950615225;47710.76144619255;37296.62703372932;38485.69085854858;38676.226475470896;39025;39496.60503395044;36991.81504092462;37145.071373215884;38008.049798754146;38759;38908.41637375498;37796.811015945845;37861.81069094637;40283.39574906437;41260;41470.377944330256;38401.42397863978;40153.59846401498;40155.39766903557;41374.37938430866;42455.575444246395;23801.928913199295;29652.996845426453;31613.199449024338;32253;32329.030129096165 05:51:56 INFO - PROCESS | 1667 | |2;jquery.html;361.5932076414034;365.30774182923375;371.21488052768393;386.56125297787;393.03705920494775;19250.90374548129;19363.128659210335;19850.305239316625;20243.291484798054;20461;11586.478608462618;11962.222455540406;11968.401579921012;11971;12421.875781242208;5180.11937970544;5391.32608423947;5460.017196904556;5477.808276710316;5482.451754824526;3874.321993651114;4083.12212874232;4610.446746390421;5306.204069389584;5405.567554595643;4082.3672330788627;4128.112455821998;6648.501362397816;6649.60102393858;6661.933380666204;5990.131430942489;6003.72983215752;6599.505037122211;6663;6685.699143538553;5817.447342502498;5821.592488525805;5824.126381042835;5831.271091113611;5838.241028666246;12955.935220323838;12973.286469244187;13047.869521304856;13176.945844332431;13212.009099317589;2153.7415510138726;2171.652535594297;2185.0713446785053;2197.747259065212;2855.457463082008;10023.849642255373;10328.79342413155;10763.892361076367;11439.370834604093;14111.153330800082;1490.5786515462853;1760.1991094052175;1783.8662100342526;1794.7397627343962;1839.448165550343;120859;126579;127108;127368.36315818454;128989;7887.763367098996;9231.076892310715;9729.659461918798;9802.901970980342;11275.718107047389;11782.528698852122;12242.75514489723;12349.629511114501;12351.38243087842;12365.938170309271;7705.691772329044;7866.174051724601;7873.488223265584;7915.168907264654;7973.800654983555;8045.356371490267;8066.516009039477;8233.79415514617;8239.134890836376;8241.876371854307;3393.694567488938;3647.996800879779;3772.0946972726347;3902.804859757001;3953.4267531207815;1630.9021458712516;1867.4771064102074;1908.3606991657673;1937.2638397408894;1956.4815323939167;769.1692971590669;835.4736515994884;844.8310337932438;860.9225169734754;870.7866572689732;16726.916365418096;21003.684944725843;21561.460963475725;21627.67558486624;21787.12851485923;871.9258862996589;910.7358865928807;912.8676341930383;915.7390143808982;950.1306304731231;9880.703578892644;11459.942700286445;11494.597689080842;11512.94243528777;11526.827097593543;471973;475842;481657;529178;553308;102126;122622;135346.323268385;138740;140234.2988285052;923.9538023098818;977.7848873247874;988.8071825994006;990.1682586627268;993.857064375959;12958.740825183631;19135.138918748413;19587.118579663664;19605.70591441101;19702.31041913526;44233.55766442423;47210.76394618005;52989.940201194986;53296;53480.8971801911;70062.64968675125;76840.61579692065;77980.61009695142;78081.2191878074;78626;7994.680212791656;8018.1981801821685;8079.192080791874;8215.917840821754;8250.257476827115;12010.939945300217;12809.295488748208;12881;13212.867871321549;13514.256715880721;11137.387443690352;11228.799792059224;11362.375069370933;11430.657080287605;11450.656480305604;10851.511681974172;10937;10971.451427428756;11343.943280283545;11411.60059397917;11230;11384.48769805344;11540.192186546861;11552.075833933097;11564.826527601925;8046.436749427718;8140.063892652184;8190.672373105009;8219.30135938428;8223;8925.807965335149;9626.95186524063;11255.718607034562;11256.718582035515;11399.601013964471 05:51:56 INFO - PROCESS | 1667 | |3;mootools.html;1310.2858941876677;1394.6304229379216;1449.4274761469223;1470.5882352941178;1794.6141579560401;7379.852402951945;7747.806304842375;8024.43828931975;8240.91759082409;8294.087650358455;8139.145389734082;8254.711085112021;8263.752087437386;8270.545120018396;8271.379646526504;2045.2228153301724;2295.0819672131156;2327.418145463634;2327.7904988551027;2331.895064722092;2134.0503475953205;2260.5026894083358;2338.0414030247603;2338.4270853640883;2353.1175809071597;2297.5864344417996;2315.9652605210936;2318.5710643531;2319.5824751544715;2321.117975169433;2303.8041766449874;2322.094383190557;2322.198841399723;2323.8954247058755;2333.2766842278947;2280.8289378296695;2332.090484710964;2333.918312859059;2336.030547322859;2336.3691803213205;8270.917290827136;8330.125336839666;8337.624806883705;8350.958245208796;8383.371247156487;5005.0990821652085;5181.455947125535;5182.689038657692;5191.402988656278;5204.141316682742;3266.138301168335;3371.1740623547144;3423.7945723256685;3547.7161827053774;3566.32239874423;1064.4837253931837;1070.1920050362005;1091.939943303118;1092.6721983404946;1098.8351747237898;10233.692989210336;10548.94725526375;10559.73600659982;10586.258961872749;10718.088962438202;3564.554430696163;4374.993751437124;4438.511763705989;4503.909921801545;4506.1663592235545;8500.914990850137;8606.483610983361;8615.224629783224;8616.655333786704;8621.224089831945;5063.240513922868;5064.51887070735;5068.923966140511;5082.593392528589;5086.491350864884;4575.633949284049;4688.2733176357715;4756.7859446325;4757.95242047582;4773.331733557305;3616.31290054894;3633.1462106404974;3658.7987660678386;3663.377225871608;3688.0226739913946;959.5921733263335;1129.203911242572;1136.2046567402851;1137.5677242647907;1143.5311522275827;774.7598244544209;775.5191781095645;855.3542075732782;875.7635438431588;885.9766969150642;5227.764750586232;5383.5423988961375;5480.232767412565;5636.210930469655;5641.661500309912;411.4692047259002;419.8278705730697;422.7083312514417;436.1342734671674;439.4726328405862;3685.686716629063;3711.7958512281543;3815.4467602197524;3822.503074600284;3858.78776667286;8062.355011599058;9790.608375665037;9963.25275604318;10004.449755263531;10097.899021009844;9953.153981911473;10033.14718248957;10049.29654924163;10050.447225402528;10057.446840423701;7411.59236242001;7590.1650818409935;7649.31156195945;7815.999999999886;7838.372930165573;5059.620528460307;5389.326334208224;5479.835604931858;5555;5576.302962129734;9160;9191.172794448265;9240.768980775265;9345.532723363669;9373.671921482715;9243.121903419164;9309.581068852054;9339.392939458914;9449.43303401798;9473;6587.934120658923;6767.627780471925;6782.762603309058;6783.694733737092;6786.185657720907;7610.12483564375;7733.806654833674;7825.921740782747;7826.452148349561;7832.177621349904;6188.504919606511;6940.13248343957;6952.2352541221435;6976.965115174392;7087.362137407658;6818.454523637998;6922.826929326606;6924.480663950325;6959.582425054513;6961.930380696331;6520.641364724986;6584.8353791155605;6591.736330546916;6615;6618.0403841443685;4606.401167848158;4751.714897106184;4756.120117778222;4814.061258054646;4887.413510378778;4743.644226682944;4809.519048095162;4868.561829435368;4920.261960705922;5026.095302845523 05:51:56 INFO - PROCESS | 1667 | |4;prototype.html;245.97909177719893;286.3928471640123;297.00799330237015;307.1890209846007;313.81955375659004;4305.375720520527;4391.858116889608;4776.832810851616;5194.428612852593;5322.361316641999;4423.77881105945;5198.54296892566;5222.738863056841;5224.45143259958;5281.603879709018;3221.3557288542384;3641.799701016443;3979.2240513099955;4000.3399439092514;4057.2899742544937;3764.628284180962;3980.2437536868047;3988.0029992501873;3991.800409979504;4047.7166598338126;3049;3310.874302737069;3875.748076375027;3903.521263997368;3936.7047471439755;3382.6448222936483;3456.6024907135625;3569.6613769836313;3867.690584753213;3893.2213557288514;2580.316216202708;3374.7300215982664;3396.524486571882;3409.880654177117;3448.327576122657;4215.747055176668;4516.893361126545;4742.099001189763;4907.828226012108;4961.603071754251;4155.8753237402925;4486.798094085774;4540.275834499307;4556.951901062774;4562.292844609057;4750.50119737426;5273.446288139767;5434.972825135849;5464.316960379952;5575.2473416088715;2697.892084316625;3711.4247291669835;3743.6709967961256;3748.5126933498746;3754.699624030071;5501.367342755634;5502.724863756796;5631.352394474647;5694.857628559278;5697.914531282034;3181.3637272545584;3834.309824231609;3842.5773164951834;3863.74885632433;3866.149447121629;2965.7627389808763;3258.5926759155104;3550.8637236084205;3870.5355357356734;3878.108035151931;3654.945175822365;3889.922201555953;3941.428492868518;4312.978435107804;4484.452863761997;4837;5459.672419654833;5467.418840659375;5496.395396506381;5498.202760599691;1019.6635110413546;1239.3369547292154;1244.925304481734;1252.330003448169;1258.2010423381219;804.3404408385185;845.9932680110649;846.8905733489149;851.535912927456;862.3963225742006;4161.91676166475;4740.14677358072;4945.9613481168635;4958.851234462972;4967.925481117786;5004.374453193351;5191.143461328914;5432.837014889559;5469.863253418617;5520.751566179531;4445.844395446208;4463.888402789957;4728.621710263171;4769.848563551356;4830.946550913931;2715.4840580289683;2763.392053748172;2779.2357101796765;2782.6939036705944;2782.7060416906234;4604.355390245301;4801.855944321676;5264.526192642604;5408.026555220098;5550.58370622205;4931.364517353676;5142.151544995108;5303.946960530346;5366.597505187126;5380.385884234792;4602.884927876763;4866.228672778554;5119.283300337881;5335.518983672611;5418.485243901823;4718.197906355859;5229.869253268699;5319.46805319465;5373.811916582901;5416.133418653154;4629.768511574475;4697.177993850994;5163.734884953211;5218.347706536683;5660.51885589713;4673.7429441381055;5584.329880414376;5734.827955161351;5924.585279030426;5928.407159284037;3405.5402520660386;3865.9420108698955;3876.844926203033;3907.6092390760696;3912.9021774454727;4826.734529600905;5554.777808887599;5766.855828604318;5804.709764511673;5842.620229685057;4820.783064762024;4909.803607855789;5007.574356179765;5481.451854814487;5493.324536016553;5523.6685798852195;5630.915536267041;5645.491905728504;5646.971765141148;5653.604247702621;5177.498525427583;5356.437574054668;5527.39198688152;5558.694271815089;5588.636738611977;4918.729469879191;5543.530964294546;5550.310931295455;5591.924441557208;5639.351474580476;4421.40311058003;4646.303054541846;4853.781579828846;5466.851961088216;5486.50621444056 05:51:56 INFO - PROCESS | 1667 | |5;yui.html;690.9219427450707;704.5913370245255;715.982100447489;743.3978477433279;784.9372050235982;14384.784228236571;15336.079835209881;15352.539423817276;15359.308831102599;15370.308336124886;13697.58907232782;13826.723465530684;13829.377678004488;13847.584572462842;13874.583762487116;818.1777313799638;830.5930094253832;832.9250367466957;833.204289903141;833.7123692326168;661.1999480628446;680.8536164724583;686.5365878032309;803.4737247103157;820.122468958215;859.5659192108008;885.1988950000228;887.7469921072495;888.5424006636588;889.5730049576207;877.188600544497;880.0891077734547;881.9735407937773;882.898466676334;883.796726752844;501.2481377585326;520.2638266852399;520.456123351099;522.5271129627655;655.9409653131194;11069.889301106967;12099.092568057431;13790.862091379158;13854.376553055035;14224.85775142256;11798.351090690008;13606.863931360658;13987.300634968211;14127.364268607937;14356.712865742731;11620;11627.360495172763;11631.360275184861;11778.466460061947;11907.761844763056;3632.727545434103;3643.508126402928;3672.7245456590863;3735.1409175889426;3834.9424758628643;107657.92342076557;108181;109060;109127.63287487756;109821.90178098196;9036.096390360912;10668.359898406121;10868.836967445495;10978.066864316463;11299.999999999836;20958.056887440103;21084.262050828147;21109.26117585908;21390.358289251348;21424.78575214259;7719.382449404035;7728.149903510609;7781.688732450752;7824.530528168328;8128.187181281824;3634.200475895299;4211.642010429086;4222.472190976128;4278.529361770203;4299.161663475592;3233.579634647481;3374.8481318340732;3448.620651728308;3450.171958729937;3488.476728490696;687.9484038697118;688.0779755128052;690.082190686386;694.3230350408312;702.6732569355172;628.6448156791398;637.1653134393958;656.3633275722541;658.5719282466436;680;7632.580208088609;9140.537513997728;9254.537273136317;9261.536923153815;9307.488088155082;606.927168739754;630.5208041888199;653.7221680785647;659.1365311442026;677.8508728079814;4245.006604888604;4543.727376357429;4569.817207311737;4608.631309495232;4621.168189725881;85975;102744.48627756962;105109;108847.45576272227;111100;78054;94373;95474;96458.03541964632;99518.00481995087;58635.12047319294;70413;71837.56324873578;75250.62374688091;76508.61745691235;8480.279176270085;9430.29272804556;9693.9030609693;9887.456189909624;9943.701688949342;50121.24818127804;51693.48306516887;51840.481595185076;51932.1437320951;53087.73456132694;62356;62722.37277627348;69532.30467695258;71875.28124718895;72540.27459725547;12701.36493175356;12748.61754147377;12863.549775757803;12957.546485872948;12970.092093553361;10862.674119776419;14580.781288280896;14819.777703334674;14914.943353719034;15036.248187590358;13669.726605468033;14019.439222430989;14029.298535073001;14072.718545629235;14364;13769;14191.574252772434;14200.28998550089;14384;14483.420663173356;12320.81518777237;12625.305608191271;12877.742445151232;13105.344732763515;13311.53409630697;11148.777024459627;11199.272047316897;11337.886621133683;11369.886301136883;11811.940940295244;9573.473458959825;10332.741681458023;10688.824229334923;11410.486528106421;11570 05:51:56 INFO - PROCESS | 1667 | __end_tp_report 05:51:56 INFO - PROCESS | 1667 | __start_cc_report 05:51:56 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,3574 05:51:56 INFO - PROCESS | 1667 | __end_cc_report 05:51:56 INFO - PROCESS | 1667 | __startTimestamp1480945916918__endTimestamp 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:51:56 INFO - PROCESS | 1667 | Number of tests: 6 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5600.37 Median:5770.62 stddev:651.61 (11.3%) stddev-sans-first:611.58 05:51:56 INFO - PROCESS | 1667 | Values: 2665.5 3059.8 3254.6 3302.7 3313.1 5438.8 5494.4 5518.6 5588.3 5604.6 5504.7 5537.5 5614.0 5622.6 5642.2 5030.9 5037.2 5067.2 5101.9 5133.2 5098.7 5152.5 5157.9 5162.3 5202.8 5013.8 5146.2 5150.5 5162.1 5264.4 5043.9 5044.2 5054.3 5110.3 5115.7 5034.7 5097.4 5115.3 5134.7 5146.5 5555.7 5584.0 5605.2 5621.2 5639.6 5905.1 5999.0 6039.0 6119.3 6162.0 6175.8 6198.6 6229.6 6240.6 6244.7 5714.3 5721.5 5732.7 5735.5 5759.0 6114.7 6172.1 6177.8 6275.7 6290.5 4762.7 5962.5 6007.5 6100.7 6141.5 6159.7 6199.3 6207.9 6212.5 6232.0 6093.8 6141.5 6151.5 6168.7 6196.4 5950.7 6018.0 6026.5 6087.2 6094.5 4815.8 4856.3 4860.5 4871.6 4875.0 4314.8 4321.1 4442.8 4453.9 4460.9 5415.5 5653.1 5684.1 5688.5 5760.0 5436.6 5937.3 6205.5 6235.1 6242.9 5563.8 5707.0 5740.0 5740.7 5750.4 5236.4 5304.4 5304.6 5309.6 5318.1 6144.4 6188.7 6210.6 6242.2 6279.8 5088.5 6128.4 6212.6 6227.8 6246.9 4685.9 6024.2 6254.0 6258.2 6272.8 5835.4 5864.5 5928.6 5935.9 5942.4 5930.8 6023.0 6033.0 6044.3 6048.3 5677.9 5767.1 5826.1 5834.1 5839.4 5825.1 5846.1 5849.7 5854.4 5856.2 4835.7 5770.6 5834.9 5856.1 5859.8 5836.2 5982.9 5990.2 6033.7 6092.0 5863.5 5864.7 5876.4 5877.7 5885.6 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:66748.03 Median:38271.62 stddev:140984.39 (368.4%) stddev-sans-first:141291.96 05:51:56 INFO - PROCESS | 1667 | Values: 429.9 465.9 478.8 487.1 505.2 35101.0 40663.0 40752.6 42754.4 42905.9 41821.6 42142.4 42259.8 42271.8 42320.4 8516.2 9308.5 9486.5 9501.1 9501.3 8503.3 11107.3 11378.7 11386.8 11556.3 11355.1 11414.3 11415.5 11450.5 11494.2 8522.1 8723.4 11238.8 11282.7 11326.3 10974.6 11286.3 11330.2 11429.9 11488.8 39055.6 39319.8 39419.8 39441.8 39469.6 3292.2 3330.0 3453.5 3801.9 3972.7 29177.4 29486.7 30181.5 30210.0 30309.8 3110.9 3249.4 3276.9 3321.5 3324.0 449921.0 451175.7 459217.0 463225.0 464457.0 57241.4 57481.1 57575.1 57671.0 57797.7 59641.7 59969.7 60079.1 60117.7 60201.7 15212.3 15412.5 15423.0 15427.0 15438.2 10924.6 11204.9 11210.9 12167.0 12226.4 15327.0 15957.4 15997.6 16003.4 16218.8 5739.4 6847.2 6886.2 6916.7 6933.2 748.4 827.6 980.7 1044.7 1139.7 24377.5 26488.8 27854.7 28262.0 29297.7 1062.0 1072.5 1095.7 1143.9 1189.9 14715.6 15046.8 15139.8 15427.2 15562.5 578256.0 578701.0 582398.0 582701.0 585168.0 55871.7 55912.7 55988.0 56059.9 56115.0 1221.2 1270.9 1338.4 1373.0 1390.4 26296.0 29828.6 31620.4 31806.8 32149.0 51133.5 51848.0 51855.2 51920.5 51987.5 534796.0 538013.0 540248.0 545090.0 547559.0 24986.9 25880.9 25894.7 38141.8 38600.8 37432.6 37677.4 42381.0 46098.8 47710.8 37296.6 38485.7 38676.2 39025.0 39496.6 36991.8 37145.1 38008.0 38759.0 38908.4 37796.8 37861.8 40283.4 41260.0 41470.4 38401.4 40153.6 40155.4 41374.4 42455.6 23801.9 29653.0 31613.2 32253.0 32329.0 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:31697.10 Median:2006.65 stddev:85421.03 (4256.9%) stddev-sans-first:85628.25 05:51:56 INFO - PROCESS | 1667 | Values: 361.6 365.3 371.2 386.6 393.0 19250.9 19363.1 19850.3 20243.3 20461.0 11586.5 11962.2 11968.4 11971.0 12421.9 5180.1 5391.3 5460.0 5477.8 5482.5 3874.3 4083.1 4610.4 5306.2 5405.6 4082.4 4128.1 6648.5 6649.6 6661.9 5990.1 6003.7 6599.5 6663.0 6685.7 5817.4 5821.6 5824.1 5831.3 5838.2 12955.9 12973.3 13047.9 13176.9 13212.0 2153.7 2171.7 2185.1 2197.7 2855.5 10023.8 10328.8 10763.9 11439.4 14111.2 1490.6 1760.2 1783.9 1794.7 1839.4 120859.0 126579.0 127108.0 127368.4 128989.0 7887.8 9231.1 9729.7 9802.9 11275.7 11782.5 12242.8 12349.6 12351.4 12365.9 7705.7 7866.2 7873.5 7915.2 7973.8 8045.4 8066.5 8233.8 8239.1 8241.9 3393.7 3648.0 3772.1 3902.8 3953.4 1630.9 1867.5 1908.4 1937.3 1956.5 769.2 835.5 844.8 860.9 870.8 16726.9 21003.7 21561.5 21627.7 21787.1 871.9 910.7 912.9 915.7 950.1 9880.7 11459.9 11494.6 11512.9 11526.8 471973.0 475842.0 481657.0 529178.0 553308.0 102126.0 122622.0 135346.3 138740.0 140234.3 924.0 977.8 988.8 990.2 993.9 12958.7 19135.1 19587.1 19605.7 19702.3 44233.6 47210.8 52989.9 53296.0 53480.9 70062.6 76840.6 77980.6 78081.2 78626.0 7994.7 8018.2 8079.2 8215.9 8250.3 12010.9 12809.3 12881.0 13212.9 13514.3 11137.4 11228.8 11362.4 11430.7 11450.7 10851.5 10937.0 10971.5 11343.9 11411.6 11230.0 11384.5 11540.2 11552.1 11564.8 8046.4 8140.1 8190.7 8219.3 8223.0 8925.8 9627.0 11255.7 11256.7 11399.6 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5317.01 Median:5042.86 stddev:2926.17 (58.0%) stddev-sans-first:2918.88 05:51:56 INFO - PROCESS | 1667 | Values: 1310.3 1394.6 1449.4 1470.6 1794.6 7379.9 7747.8 8024.4 8240.9 8294.1 8139.1 8254.7 8263.8 8270.5 8271.4 2045.2 2295.1 2327.4 2327.8 2331.9 2134.1 2260.5 2338.0 2338.4 2353.1 2297.6 2316.0 2318.6 2319.6 2321.1 2303.8 2322.1 2322.2 2323.9 2333.3 2280.8 2332.1 2333.9 2336.0 2336.4 8270.9 8330.1 8337.6 8351.0 8383.4 5005.1 5181.5 5182.7 5191.4 5204.1 3266.1 3371.2 3423.8 3547.7 3566.3 1064.5 1070.2 1091.9 1092.7 1098.8 10233.7 10548.9 10559.7 10586.3 10718.1 3564.6 4375.0 4438.5 4503.9 4506.2 8500.9 8606.5 8615.2 8616.7 8621.2 5063.2 5064.5 5068.9 5082.6 5086.5 4575.6 4688.3 4756.8 4758.0 4773.3 3616.3 3633.1 3658.8 3663.4 3688.0 959.6 1129.2 1136.2 1137.6 1143.5 774.8 775.5 855.4 875.8 886.0 5227.8 5383.5 5480.2 5636.2 5641.7 411.5 419.8 422.7 436.1 439.5 3685.7 3711.8 3815.4 3822.5 3858.8 8062.4 9790.6 9963.3 10004.4 10097.9 9953.2 10033.1 10049.3 10050.4 10057.4 7411.6 7590.2 7649.3 7816.0 7838.4 5059.6 5389.3 5479.8 5555.0 5576.3 9160.0 9191.2 9240.8 9345.5 9373.7 9243.1 9309.6 9339.4 9449.4 9473.0 6587.9 6767.6 6782.8 6783.7 6786.2 7610.1 7733.8 7825.9 7826.5 7832.2 6188.5 6940.1 6952.2 6977.0 7087.4 6818.5 6922.8 6924.5 6959.6 6961.9 6520.6 6584.8 6591.7 6615.0 6618.0 4606.4 4751.7 4756.1 4814.1 4887.4 4743.6 4809.5 4868.6 4920.3 5026.1 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4315.89 Median:4773.34 stddev:1352.97 (28.3%) stddev-sans-first:1321.83 05:51:56 INFO - PROCESS | 1667 | Values: 246.0 286.4 297.0 307.2 313.8 4305.4 4391.9 4776.8 5194.4 5322.4 4423.8 5198.5 5222.7 5224.5 5281.6 3221.4 3641.8 3979.2 4000.3 4057.3 3764.6 3980.2 3988.0 3991.8 4047.7 3049.0 3310.9 3875.7 3903.5 3936.7 3382.6 3456.6 3569.7 3867.7 3893.2 2580.3 3374.7 3396.5 3409.9 3448.3 4215.7 4516.9 4742.1 4907.8 4961.6 4155.9 4486.8 4540.3 4557.0 4562.3 4750.5 5273.4 5435.0 5464.3 5575.2 2697.9 3711.4 3743.7 3748.5 3754.7 5501.4 5502.7 5631.4 5694.9 5697.9 3181.4 3834.3 3842.6 3863.7 3866.1 2965.8 3258.6 3550.9 3870.5 3878.1 3654.9 3889.9 3941.4 4313.0 4484.5 4837.0 5459.7 5467.4 5496.4 5498.2 1019.7 1239.3 1244.9 1252.3 1258.2 804.3 846.0 846.9 851.5 862.4 4161.9 4740.1 4946.0 4958.9 4967.9 5004.4 5191.1 5432.8 5469.9 5520.8 4445.8 4463.9 4728.6 4769.8 4830.9 2715.5 2763.4 2779.2 2782.7 2782.7 4604.4 4801.9 5264.5 5408.0 5550.6 4931.4 5142.2 5303.9 5366.6 5380.4 4602.9 4866.2 5119.3 5335.5 5418.5 4718.2 5229.9 5319.5 5373.8 5416.1 4629.8 4697.2 5163.7 5218.3 5660.5 4673.7 5584.3 5734.8 5924.6 5928.4 3405.5 3865.9 3876.8 3907.6 3912.9 4826.7 5554.8 5766.9 5804.7 5842.6 4820.8 4909.8 5007.6 5481.5 5493.3 5523.7 5630.9 5645.5 5647.0 5653.6 5177.5 5356.4 5527.4 5558.7 5588.6 4918.7 5543.5 5550.3 5591.9 5639.4 4421.4 4646.3 4853.8 5466.9 5486.5 05:51:56 INFO - PROCESS | 1667 | 05:51:56 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:20334.67 Median:4261.77 stddev:29665.16 (696.1%) stddev-sans-first:29711.71 05:51:56 INFO - PROCESS | 1667 | Values: 690.9 704.6 716.0 743.4 784.9 14384.8 15336.1 15352.5 15359.3 15370.3 13697.6 13826.7 13829.4 13847.6 13874.6 818.2 830.6 832.9 833.2 833.7 661.2 680.9 686.5 803.5 820.1 859.6 885.2 887.7 888.5 889.6 877.2 880.1 882.0 882.9 883.8 501.2 520.3 520.5 522.5 655.9 11069.9 12099.1 13790.9 13854.4 14224.9 11798.4 13606.9 13987.3 14127.4 14356.7 11620.0 11627.4 11631.4 11778.5 11907.8 3632.7 3643.5 3672.7 3735.1 3834.9 107657.9 108181.0 109060.0 109127.6 109821.9 9036.1 10668.4 10868.8 10978.1 11300.0 20958.1 21084.3 21109.3 21390.4 21424.8 7719.4 7728.1 7781.7 7824.5 8128.2 3634.2 4211.6 4222.5 4278.5 4299.2 3233.6 3374.8 3448.6 3450.2 3488.5 687.9 688.1 690.1 694.3 702.7 628.6 637.2 656.4 658.6 680.0 7632.6 9140.5 9254.5 9261.5 9307.5 606.9 630.5 653.7 659.1 677.9 4245.0 4543.7 4569.8 4608.6 4621.2 85975.0 102744.5 105109.0 108847.5 111100.0 78054.0 94373.0 95474.0 96458.0 99518.0 58635.1 70413.0 71837.6 75250.6 76508.6 8480.3 9430.3 9693.9 9887.5 9943.7 50121.2 51693.5 51840.5 51932.1 53087.7 62356.0 62722.4 69532.3 71875.3 72540.3 12701.4 12748.6 12863.5 12957.5 12970.1 10862.7 14580.8 14819.8 14914.9 15036.2 13669.7 14019.4 14029.3 14072.7 14364.0 13769.0 14191.6 14200.3 14384.0 14483.4 12320.8 12625.3 12877.7 13105.3 13311.5 11148.8 11199.3 11337.9 11369.9 11811.9 9573.5 10332.7 10688.8 11410.5 11570.0 05:51:56 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:51:56 INFO - PROCESS | 1667 | 05:51:57 INFO - TEST-INFO | 1667: exit 0 05:51:57 INFO - TEST-OK | dromaeo_css | took 1121701ms 05:51:57 INFO - TEST-START | kraken 05:51:57 INFO - operating with platform_type : mac_ 05:51:57 INFO - Initialising browser for kraken test... 05:51:57 INFO - TEST-INFO | started process 1785 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpYFHRvQ/profile http://localhost:49235/getInfo.html) 05:52:00 INFO - PROCESS | 1785 | __metrics Screen width/height:1600/1200 05:52:00 INFO - PROCESS | 1785 | colorDepth:24 05:52:00 INFO - PROCESS | 1785 | Browser inner width/height: 1024/689 05:52:00 INFO - PROCESS | 1785 | __metrics 05:52:00 INFO - PROCESS | 1785 | 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" 05:52:00 INFO - PROCESS | 1785 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:01 INFO - TEST-INFO | 1785: exit 0 05:52:01 INFO - Browser initialized. 05:52:01 INFO - Running cycle 1/1 for kraken test... 05:52:01 INFO - TEST-INFO | started process 1786 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpYFHRvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:13 INFO - PROCESS | 1786 | RSS: Main: 245620736 05:52:13 INFO - PROCESS | 1786 | 05:52:16 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:17 INFO - PROCESS | 1786 | RSS: Main: 295407616 05:52:17 INFO - PROCESS | 1786 | 05:52:19 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 05:52:20 INFO - PROCESS | 1786 | RSS: Main: 296361984 05:52:20 INFO - PROCESS | 1786 | 05:52:23 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 05:52:24 INFO - PROCESS | 1786 | RSS: Main: 388898816 05:52:24 INFO - PROCESS | 1786 | 05:52:26 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 05:52:26 INFO - PROCESS | 1786 | RSS: Main: 289476608 05:52:26 INFO - PROCESS | 1786 | 05:52:29 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:29 INFO - PROCESS | 1786 | RSS: Main: 291983360 05:52:29 INFO - PROCESS | 1786 | 05:52:32 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:33 INFO - PROCESS | 1786 | RSS: Main: 334127104 05:52:33 INFO - PROCESS | 1786 | 05:52:35 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:36 INFO - PROCESS | 1786 | RSS: Main: 336486400 05:52:36 INFO - PROCESS | 1786 | 05:52:39 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 05:52:39 INFO - PROCESS | 1786 | RSS: Main: 332767232 05:52:39 INFO - PROCESS | 1786 | 05:52:41 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:42 INFO - PROCESS | 1786 | RSS: Main: 310632448 05:52:42 INFO - PROCESS | 1786 | 05:52:44 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:44 INFO - PROCESS | 1786 | RSS: Main: 313831424 05:52:44 INFO - PROCESS | 1786 | 05:52:46 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:47 INFO - PROCESS | 1786 | RSS: Main: 315285504 05:52:47 INFO - PROCESS | 1786 | 05:52:50 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:51 INFO - PROCESS | 1786 | RSS: Main: 333922304 05:52:51 INFO - PROCESS | 1786 | 05:52:54 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:54 INFO - PROCESS | 1786 | RSS: Main: 327987200 05:52:54 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 05:52:56 INFO - PROCESS | 1786 | RSS: Main: 372453376 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | __start_tp_report 05:52:56 INFO - PROCESS | 1786 | _x_x_mozilla_page_load 05:52:56 INFO - PROCESS | 1786 | _x_x_mozilla_page_load_details 05:52:56 INFO - PROCESS | 1786 | |i|pagename|runs| 05:52:56 INFO - PROCESS | 1786 | |0;ai-astar;113;113;114;114;113;113;113;112;114;113 05:52:56 INFO - PROCESS | 1786 | |1;audio-beat-detection;150;117;114;156;113;117;119;114;135;113 05:52:56 INFO - PROCESS | 1786 | |2;audio-dft;182;180;183;182;185;183;183;180;182;183 05:52:56 INFO - PROCESS | 1786 | |3;audio-fft;78;59;58;86;63;61;59;59;72;58 05:52:56 INFO - PROCESS | 1786 | |4;audio-oscillator;80;70;85;70;90;98;116;79;68;82 05:52:56 INFO - PROCESS | 1786 | |5;imaging-gaussian-blur;87;84;87;85;88;83;87;83;86;84 05:52:56 INFO - PROCESS | 1786 | |6;imaging-darkroom;93;93;93;93;92;93;94;94;93;93 05:52:56 INFO - PROCESS | 1786 | |7;imaging-desaturate;85;83;86;86;85;85;87;91;127;85 05:52:56 INFO - PROCESS | 1786 | |8;json-parse-financial;58;57;54;55;55;56;56;56;56;57 05:52:56 INFO - PROCESS | 1786 | |9;json-stringify-tinderbox;65;77;68;74;72;70;75;101;102;70 05:52:56 INFO - PROCESS | 1786 | |10;stanford-crypto-aes;90;88;88;90;89;87;88;88;87;89 05:52:56 INFO - PROCESS | 1786 | |11;stanford-crypto-ccm;149;166;156;156;157;158;150;149;198;161 05:52:56 INFO - PROCESS | 1786 | |12;stanford-crypto-pbkdf2;175;173;175;175;174;175;174;172;176;180 05:52:56 INFO - PROCESS | 1786 | |13;stanford-crypto-sha256-iterative;71;70;71;70;70;70;69;69;72;82 05:52:56 INFO - PROCESS | 1786 | __end_tp_report 05:52:56 INFO - PROCESS | 1786 | __start_cc_report 05:52:56 INFO - PROCESS | 1786 | _x_x_mozilla_cycle_collect,2021 05:52:56 INFO - PROCESS | 1786 | __end_cc_report 05:52:56 INFO - PROCESS | 1786 | __startTimestamp1480945976970__endTimestamp 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | ------- Summary: start ------- 05:52:56 INFO - PROCESS | 1786 | Number of tests: 14 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 05:52:56 INFO - PROCESS | 1786 | Values: 113.0 113.0 114.0 114.0 113.0 113.0 113.0 112.0 114.0 113.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:118.00 stddev:16.26 (13.8%) stddev-sans-first:14.47 05:52:56 INFO - PROCESS | 1786 | Values: 150.0 117.0 114.0 156.0 113.0 117.0 119.0 114.0 135.0 113.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:1.49 (0.8%) stddev-sans-first:1.58 05:52:56 INFO - PROCESS | 1786 | Values: 182.0 180.0 183.0 182.0 185.0 183.0 183.0 180.0 182.0 183.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#3] audio-fft Cycles:10 Average:65.30 Median:62.00 stddev:9.91 (16.0%) stddev-sans-first:9.39 05:52:56 INFO - PROCESS | 1786 | Values: 78.0 59.0 58.0 86.0 63.0 61.0 59.0 59.0 72.0 58.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:81.00 stddev:14.72 (18.2%) stddev-sans-first:15.55 05:52:56 INFO - PROCESS | 1786 | Values: 80.0 70.0 85.0 70.0 90.0 98.0 116.0 79.0 68.0 82.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.84 (2.1%) stddev-sans-first:1.86 05:52:56 INFO - PROCESS | 1786 | Values: 87.0 84.0 87.0 85.0 88.0 83.0 87.0 83.0 86.0 84.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:52:56 INFO - PROCESS | 1786 | Values: 93.0 93.0 93.0 93.0 92.0 93.0 94.0 94.0 93.0 93.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:85.50 stddev:13.17 (15.4%) stddev-sans-first:13.84 05:52:56 INFO - PROCESS | 1786 | Values: 85.0 83.0 86.0 86.0 85.0 85.0 87.0 91.0 127.0 85.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:0.97 05:52:56 INFO - PROCESS | 1786 | Values: 58.0 57.0 54.0 55.0 55.0 56.0 56.0 56.0 56.0 57.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:71.00 stddev:13.17 (18.5%) stddev-sans-first:13.18 05:52:56 INFO - PROCESS | 1786 | Values: 65.0 77.0 68.0 74.0 72.0 70.0 75.0 101.0 102.0 70.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:88.50 stddev:1.07 (1.2%) stddev-sans-first:0.97 05:52:56 INFO - PROCESS | 1786 | Values: 90.0 88.0 88.0 90.0 89.0 87.0 88.0 88.0 87.0 89.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:157.50 stddev:14.41 (9.1%) stddev-sans-first:14.72 05:52:56 INFO - PROCESS | 1786 | Values: 149.0 166.0 156.0 156.0 157.0 158.0 150.0 149.0 198.0 161.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:2.13 (1.2%) stddev-sans-first:2.26 05:52:56 INFO - PROCESS | 1786 | Values: 175.0 173.0 175.0 175.0 174.0 175.0 174.0 172.0 176.0 180.0 05:52:56 INFO - PROCESS | 1786 | 05:52:56 INFO - PROCESS | 1786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.50 stddev:3.84 (5.4%) stddev-sans-first:4.07 05:52:56 INFO - PROCESS | 1786 | Values: 71.0 70.0 71.0 70.0 70.0 70.0 69.0 69.0 72.0 82.0 05:52:56 INFO - PROCESS | 1786 | -------- Summary: end -------- 05:52:56 INFO - PROCESS | 1786 | 05:52:58 INFO - TEST-INFO | 1786: exit 0 05:52:58 INFO - TEST-OK | kraken | took 60500ms 05:52:58 INFO - SUITE-END | took 1182s 05:52:58 INFO - Completed test suite (00:19:42) 05:52:58 INFO - javascript benchmark 05:52:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2665.546857034304, 3059.8164110153393, 3254.641989381169, 3302.719268862147, 3313.1054615253865, 5438.782448702047, 5494.36814766302, 5518.558515318775, 5588.273524441822, 5604.551635869136, 5504.697241651707, 5537.529310008644, 5613.971930140354, 5622.634528755628, 5642.238297829802, 5030.899382012376, 5037.1940489521685, 5067.189249720045, 5101.872453188663, 5133.204353325222, 5098.694078355292, 5152.510511501401, 5157.896842063175, 5162.303089082963, 5202.7658755355915, 5013.849584512471, 5146.150885103953, 5150.536451719326, 5162.148245539482, 5264.42091369949, 5043.949560504385, 5044.218146187347, 5054.2923990640975, 5110.310108135392, 5115.693058416507, 5034.723090230036, 5097.362829646294, 5115.309433226504, 5134.691918484903, 5146.459621739738, 5555.694436805974, 5584.0, 5605.243292155547, 5621.156826476062, 5639.6334238274385, 5905.114232865061, 5999.040153575407, 6038.969805150946, 6119.326874043852, 6161.969190154021, 6175.814725558241, 6198.597091189104, 6229.595076320024, 6240.594361366497, 6244.718987645567, 5714.257146570919, 5721.542276617861, 5732.713364331808, 5735.483806457439, 5759.020966435716, 6114.67123069571, 6172.074188871616, 6177.783777567854, 6275.717592708339, 6290.4653104485715, 4762.738049407316, 5962.522998160137, 6007.459328660441, 6100.739137556996, 6141.477974372139, 6159.692015399212, 6199.256089269226, 6207.875842483125, 6212.534059945522, 6232.002879539343, 6093.75624974996, 6141.508679305645, 6151.5386346024225, 6168.691565421711, 6196.411340922605, 5950.702464876739, 6017.976943919544, 6026.487748541335, 6087.239095113111, 6094.481969032593, 4815.783289751969, 4856.3201151838775, 4860.538248866352, 4871.634627402959, 4874.975625121922, 4314.827406903752, 4321.0709697415205, 4442.800073996678, 4453.866384008485, 4460.8661740147845, 5415.539679127318, 5653.123765816305, 5684.062129748628, 5688.544916406678, 5759.971200143972, 5436.619436639477, 5937.317208521075, 6205.472534834499, 6235.064740288993, 6242.906356404657, 5563.805266815642, 5706.972744905874, 5739.971300143473, 5740.655560666373, 5750.396208398141, 5236.371635403776, 5304.443033481506, 5304.602154838402, 5309.601779866448, 5318.122509785842, 6144.433169541739, 6188.721507532172, 6210.627362358273, 6242.188515492957, 6279.843003924939, 5088.491150884882, 6128.448439640454, 6212.596181248205, 6227.782027629011, 6246.875062498815, 4685.882852928567, 6024.186734790923, 6254.030625253093, 6258.186435763321, 6272.780452684134, 5835.358110607915, 5864.501517370901, 5928.614640048383, 5935.851603709942, 5942.376050514807, 5930.7924222652, 6022.969885150546, 6032.969835150796, 6044.304904935989, 6048.304444988883, 5677.886442271214, 5767.134929760402, 5826.067829147316, 5834.095715164156, 5839.416058394127, 5825.097109947965, 5846.064629659234, 5849.678267695318, 5854.414558544111, 5856.150858125633, 4835.661503694849, 5770.6249093808765, 5834.94165058344, 5856.092305692625, 5859.824205273849, 5836.153757705024, 5982.940170598238, 5990.1913241713555, 6033.728482218223, 6092.0, 5863.472287494146, 5864.67744274052, 5876.412358764261, 5877.676727780014, 5885.61743486672], "value": 5558.193804119879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.9273313083856, 465.87491208730916, 478.7654049515738, 487.05268253247425, 505.17656220360817, 35101.0, 40663.0, 40752.59247407529, 42754.35868461976, 42905.92735181614, 41821.58178418215, 42142.367864482054, 42259.78870105645, 42271.78864105683, 42320.365194522106, 8516.23353898149, 9308.534573271343, 9486.478243696594, 9501.144896959273, 9501.334906556544, 8503.277221436185, 11107.333559986426, 11378.658640240807, 11386.772264554704, 11556.30662160269, 11355.091592672567, 11414.258073225214, 11415.543378264902, 11450.541978320898, 11494.195406321562, 8522.105178956182, 8723.432976856484, 11238.831417528743, 11282.717932051683, 11326.320420774697, 10974.561017559288, 11286.322820630789, 11330.150238732045, 11429.885701142965, 11488.77022459546, 39055.60944390576, 39319.80340098281, 39419.802900985596, 39441.802790985865, 39469.605303947166, 3292.1769557610596, 3329.9833500832583, 3453.4992426098074, 3801.885943421702, 3972.7219094663387, 29177.41645167106, 29486.705132948824, 30181.547276790865, 30210.0, 30309.848450757825, 3110.9066727998197, 3249.39886121066, 3276.9016929492154, 3321.534985102088, 3324.0, 449921.0, 451175.74412128056, 459217.0, 463225.0, 464457.0, 57241.42758572444, 57481.137782932456, 57575.13637295444, 57671.0, 57797.71101144551, 59641.70179149076, 59969.70015149896, 60079.098813517834, 60117.69941150266, 60201.69899150476, 15212.250591182155, 15412.537623871078, 15423.0, 15426.997245179027, 15438.15090170029, 10924.617638382619, 11204.943975280072, 11210.943945280385, 12167.0, 12226.449809758582, 15327.0, 15957.361705531648, 15997.600059998593, 16003.439879604159, 16218.75671864923, 5739.397363276879, 6847.21257055445, 6886.24251332353, 6916.6541672916155, 6933.168019837652, 748.356413484403, 827.6441130314023, 980.6959842448864, 1044.6657069737762, 1139.6865861888048, 24377.512449750906, 26488.802298187646, 27854.72145278562, 28262.010829620864, 29297.707022929924, 1062.0422124383554, 1072.5066469423996, 1095.6822521468844, 1143.9428028598536, 1189.8929096381366, 14715.632109197355, 15046.849531504546, 15139.772903406458, 15427.152859330137, 15562.533124006299, 578256.0, 578701.0, 582398.0, 582701.0, 585168.0, 55871.72064139653, 55912.72043639837, 55988.0, 56059.87880242372, 56115.0, 1221.2001139253803, 1270.9237445753283, 1338.3709656461447, 1373.0251521419905, 1390.3951780975308, 26295.9770968924, 29828.552571711876, 31620.36759264756, 31806.84096579502, 32149.0, 51133.48866511287, 51847.96304073822, 51855.2221716667, 51920.48079519308, 51987.480125198264, 534796.0, 538013.0, 540248.0, 545090.0, 547559.0, 24986.875065624554, 25880.870595647655, 25894.741052589987, 38141.809290953366, 38600.80699596484, 37432.625673742914, 37677.4348384769, 42381.0, 46098.76950615225, 47710.76144619255, 37296.62703372932, 38485.69085854858, 38676.226475470896, 39025.0, 39496.60503395044, 36991.81504092462, 37145.071373215884, 38008.049798754146, 38759.0, 38908.41637375498, 37796.811015945845, 37861.81069094637, 40283.39574906437, 41260.0, 41470.377944330256, 38401.42397863978, 40153.59846401498, 40155.39766903557, 41374.37938430866, 42455.575444246395, 23801.928913199295, 29652.996845426453, 31613.199449024338, 32253.0, 32329.030129096165], "value": 19955.035522743157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5932076414034, 365.30774182923375, 371.21488052768393, 386.56125297787, 393.03705920494775, 19250.90374548129, 19363.128659210335, 19850.305239316625, 20243.291484798054, 20461.0, 11586.478608462618, 11962.222455540406, 11968.401579921012, 11971.0, 12421.875781242208, 5180.11937970544, 5391.32608423947, 5460.017196904556, 5477.808276710316, 5482.451754824526, 3874.321993651114, 4083.12212874232, 4610.446746390421, 5306.204069389584, 5405.567554595643, 4082.3672330788627, 4128.112455821998, 6648.501362397816, 6649.60102393858, 6661.933380666204, 5990.131430942489, 6003.72983215752, 6599.505037122211, 6663.0, 6685.699143538553, 5817.447342502498, 5821.592488525805, 5824.126381042835, 5831.271091113611, 5838.241028666246, 12955.935220323838, 12973.286469244187, 13047.869521304856, 13176.945844332431, 13212.009099317589, 2153.7415510138726, 2171.652535594297, 2185.0713446785053, 2197.747259065212, 2855.457463082008, 10023.849642255373, 10328.79342413155, 10763.892361076367, 11439.370834604093, 14111.153330800082, 1490.5786515462853, 1760.1991094052175, 1783.8662100342526, 1794.7397627343962, 1839.448165550343, 120859.0, 126579.0, 127108.0, 127368.36315818454, 128989.0, 7887.763367098996, 9231.076892310715, 9729.659461918798, 9802.901970980342, 11275.718107047389, 11782.528698852122, 12242.75514489723, 12349.629511114501, 12351.38243087842, 12365.938170309271, 7705.691772329044, 7866.174051724601, 7873.488223265584, 7915.168907264654, 7973.800654983555, 8045.356371490267, 8066.516009039477, 8233.79415514617, 8239.134890836376, 8241.876371854307, 3393.694567488938, 3647.996800879779, 3772.0946972726347, 3902.804859757001, 3953.4267531207815, 1630.9021458712516, 1867.4771064102074, 1908.3606991657673, 1937.2638397408894, 1956.4815323939167, 769.1692971590669, 835.4736515994884, 844.8310337932438, 860.9225169734754, 870.7866572689732, 16726.916365418096, 21003.684944725843, 21561.460963475725, 21627.67558486624, 21787.12851485923, 871.9258862996589, 910.7358865928807, 912.8676341930383, 915.7390143808982, 950.1306304731231, 9880.703578892644, 11459.942700286445, 11494.597689080842, 11512.94243528777, 11526.827097593543, 471973.0, 475842.0, 481657.0, 529178.0, 553308.0, 102126.0, 122622.0, 135346.323268385, 138740.0, 140234.2988285052, 923.9538023098818, 977.7848873247874, 988.8071825994006, 990.1682586627268, 993.857064375959, 12958.740825183631, 19135.138918748413, 19587.118579663664, 19605.70591441101, 19702.31041913526, 44233.55766442423, 47210.76394618005, 52989.940201194986, 53296.0, 53480.8971801911, 70062.64968675125, 76840.61579692065, 77980.61009695142, 78081.2191878074, 78626.0, 7994.680212791656, 8018.1981801821685, 8079.192080791874, 8215.917840821754, 8250.257476827115, 12010.939945300217, 12809.295488748208, 12881.0, 13212.867871321549, 13514.256715880721, 11137.387443690352, 11228.799792059224, 11362.375069370933, 11430.657080287605, 11450.656480305604, 10851.511681974172, 10937.0, 10971.451427428756, 11343.943280283545, 11411.60059397917, 11230.0, 11384.48769805344, 11540.192186546861, 11552.075833933097, 11564.826527601925, 8046.436749427718, 8140.063892652184, 8190.672373105009, 8219.30135938428, 8223.0, 8925.807965335149, 9626.95186524063, 11255.718607034562, 11256.718582035515, 11399.601013964471], "value": 8948.03073950798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.2858941876677, 1394.6304229379216, 1449.4274761469223, 1470.5882352941178, 1794.6141579560401, 7379.852402951945, 7747.806304842375, 8024.43828931975, 8240.91759082409, 8294.087650358455, 8139.145389734082, 8254.711085112021, 8263.752087437386, 8270.545120018396, 8271.379646526504, 2045.2228153301724, 2295.0819672131156, 2327.418145463634, 2327.7904988551027, 2331.895064722092, 2134.0503475953205, 2260.5026894083358, 2338.0414030247603, 2338.4270853640883, 2353.1175809071597, 2297.5864344417996, 2315.9652605210936, 2318.5710643531, 2319.5824751544715, 2321.117975169433, 2303.8041766449874, 2322.094383190557, 2322.198841399723, 2323.8954247058755, 2333.2766842278947, 2280.8289378296695, 2332.090484710964, 2333.918312859059, 2336.030547322859, 2336.3691803213205, 8270.917290827136, 8330.125336839666, 8337.624806883705, 8350.958245208796, 8383.371247156487, 5005.0990821652085, 5181.455947125535, 5182.689038657692, 5191.402988656278, 5204.141316682742, 3266.138301168335, 3371.1740623547144, 3423.7945723256685, 3547.7161827053774, 3566.32239874423, 1064.4837253931837, 1070.1920050362005, 1091.939943303118, 1092.6721983404946, 1098.8351747237898, 10233.692989210336, 10548.94725526375, 10559.73600659982, 10586.258961872749, 10718.088962438202, 3564.554430696163, 4374.993751437124, 4438.511763705989, 4503.909921801545, 4506.1663592235545, 8500.914990850137, 8606.483610983361, 8615.224629783224, 8616.655333786704, 8621.224089831945, 5063.240513922868, 5064.51887070735, 5068.923966140511, 5082.593392528589, 5086.491350864884, 4575.633949284049, 4688.2733176357715, 4756.7859446325, 4757.95242047582, 4773.331733557305, 3616.31290054894, 3633.1462106404974, 3658.7987660678386, 3663.377225871608, 3688.0226739913946, 959.5921733263335, 1129.203911242572, 1136.2046567402851, 1137.5677242647907, 1143.5311522275827, 774.7598244544209, 775.5191781095645, 855.3542075732782, 875.7635438431588, 885.9766969150642, 5227.764750586232, 5383.5423988961375, 5480.232767412565, 5636.210930469655, 5641.661500309912, 411.4692047259002, 419.8278705730697, 422.7083312514417, 436.1342734671674, 439.4726328405862, 3685.686716629063, 3711.7958512281543, 3815.4467602197524, 3822.503074600284, 3858.78776667286, 8062.355011599058, 9790.608375665037, 9963.25275604318, 10004.449755263531, 10097.899021009844, 9953.153981911473, 10033.14718248957, 10049.29654924163, 10050.447225402528, 10057.446840423701, 7411.59236242001, 7590.1650818409935, 7649.31156195945, 7815.999999999886, 7838.372930165573, 5059.620528460307, 5389.326334208224, 5479.835604931858, 5555.0, 5576.302962129734, 9160.0, 9191.172794448265, 9240.768980775265, 9345.532723363669, 9373.671921482715, 9243.121903419164, 9309.581068852054, 9339.392939458914, 9449.43303401798, 9473.0, 6587.934120658923, 6767.627780471925, 6782.762603309058, 6783.694733737092, 6786.185657720907, 7610.12483564375, 7733.806654833674, 7825.921740782747, 7826.452148349561, 7832.177621349904, 6188.504919606511, 6940.13248343957, 6952.2352541221435, 6976.965115174392, 7087.362137407658, 6818.454523637998, 6922.826929326606, 6924.480663950325, 6959.582425054513, 6961.930380696331, 6520.641364724986, 6584.8353791155605, 6591.736330546916, 6615.0, 6618.0403841443685, 4606.401167848158, 4751.714897106184, 4756.120117778222, 4814.061258054646, 4887.413510378778, 4743.644226682944, 4809.519048095162, 4868.561829435368, 4920.261960705922, 5026.095302845523], "value": 4231.925104726236, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [245.97909177719893, 286.3928471640123, 297.00799330237015, 307.1890209846007, 313.81955375659004, 4305.375720520527, 4391.858116889608, 4776.832810851616, 5194.428612852593, 5322.361316641999, 4423.77881105945, 5198.54296892566, 5222.738863056841, 5224.45143259958, 5281.603879709018, 3221.3557288542384, 3641.799701016443, 3979.2240513099955, 4000.3399439092514, 4057.2899742544937, 3764.628284180962, 3980.2437536868047, 3988.0029992501873, 3991.800409979504, 4047.7166598338126, 3049.0, 3310.874302737069, 3875.748076375027, 3903.521263997368, 3936.7047471439755, 3382.6448222936483, 3456.6024907135625, 3569.6613769836313, 3867.690584753213, 3893.2213557288514, 2580.316216202708, 3374.7300215982664, 3396.524486571882, 3409.880654177117, 3448.327576122657, 4215.747055176668, 4516.893361126545, 4742.099001189763, 4907.828226012108, 4961.603071754251, 4155.8753237402925, 4486.798094085774, 4540.275834499307, 4556.951901062774, 4562.292844609057, 4750.50119737426, 5273.446288139767, 5434.972825135849, 5464.316960379952, 5575.2473416088715, 2697.892084316625, 3711.4247291669835, 3743.6709967961256, 3748.5126933498746, 3754.699624030071, 5501.367342755634, 5502.724863756796, 5631.352394474647, 5694.857628559278, 5697.914531282034, 3181.3637272545584, 3834.309824231609, 3842.5773164951834, 3863.74885632433, 3866.149447121629, 2965.7627389808763, 3258.5926759155104, 3550.8637236084205, 3870.5355357356734, 3878.108035151931, 3654.945175822365, 3889.922201555953, 3941.428492868518, 4312.978435107804, 4484.452863761997, 4837.0, 5459.672419654833, 5467.418840659375, 5496.395396506381, 5498.202760599691, 1019.6635110413546, 1239.3369547292154, 1244.925304481734, 1252.330003448169, 1258.2010423381219, 804.3404408385185, 845.9932680110649, 846.8905733489149, 851.535912927456, 862.3963225742006, 4161.91676166475, 4740.14677358072, 4945.9613481168635, 4958.851234462972, 4967.925481117786, 5004.374453193351, 5191.143461328914, 5432.837014889559, 5469.863253418617, 5520.751566179531, 4445.844395446208, 4463.888402789957, 4728.621710263171, 4769.848563551356, 4830.946550913931, 2715.4840580289683, 2763.392053748172, 2779.2357101796765, 2782.6939036705944, 2782.7060416906234, 4604.355390245301, 4801.855944321676, 5264.526192642604, 5408.026555220098, 5550.58370622205, 4931.364517353676, 5142.151544995108, 5303.946960530346, 5366.597505187126, 5380.385884234792, 4602.884927876763, 4866.228672778554, 5119.283300337881, 5335.518983672611, 5418.485243901823, 4718.197906355859, 5229.869253268699, 5319.46805319465, 5373.811916582901, 5416.133418653154, 4629.768511574475, 4697.177993850994, 5163.734884953211, 5218.347706536683, 5660.51885589713, 4673.7429441381055, 5584.329880414376, 5734.827955161351, 5924.585279030426, 5928.407159284037, 3405.5402520660386, 3865.9420108698955, 3876.844926203033, 3907.6092390760696, 3912.9021774454727, 4826.734529600905, 5554.777808887599, 5766.855828604318, 5804.709764511673, 5842.620229685057, 4820.783064762024, 4909.803607855789, 5007.574356179765, 5481.451854814487, 5493.324536016553, 5523.6685798852195, 5630.915536267041, 5645.491905728504, 5646.971765141148, 5653.604247702621, 5177.498525427583, 5356.437574054668, 5527.39198688152, 5558.694271815089, 5588.636738611977, 4918.729469879191, 5543.530964294546, 5550.310931295455, 5591.924441557208, 5639.351474580476, 4421.40311058003, 4646.303054541846, 4853.781579828846, 5466.851961088216, 5486.50621444056], "value": 3884.888091813739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.9219427450707, 704.5913370245255, 715.982100447489, 743.3978477433279, 784.9372050235982, 14384.784228236571, 15336.079835209881, 15352.539423817276, 15359.308831102599, 15370.308336124886, 13697.58907232782, 13826.723465530684, 13829.377678004488, 13847.584572462842, 13874.583762487116, 818.1777313799638, 830.5930094253832, 832.9250367466957, 833.204289903141, 833.7123692326168, 661.1999480628446, 680.8536164724583, 686.5365878032309, 803.4737247103157, 820.122468958215, 859.5659192108008, 885.1988950000228, 887.7469921072495, 888.5424006636588, 889.5730049576207, 877.188600544497, 880.0891077734547, 881.9735407937773, 882.898466676334, 883.796726752844, 501.2481377585326, 520.2638266852399, 520.456123351099, 522.5271129627655, 655.9409653131194, 11069.889301106967, 12099.092568057431, 13790.862091379158, 13854.376553055035, 14224.85775142256, 11798.351090690008, 13606.863931360658, 13987.300634968211, 14127.364268607937, 14356.712865742731, 11620.0, 11627.360495172763, 11631.360275184861, 11778.466460061947, 11907.761844763056, 3632.727545434103, 3643.508126402928, 3672.7245456590863, 3735.1409175889426, 3834.9424758628643, 107657.92342076557, 108181.0, 109060.0, 109127.63287487756, 109821.90178098196, 9036.096390360912, 10668.359898406121, 10868.836967445495, 10978.066864316463, 11299.999999999836, 20958.056887440103, 21084.262050828147, 21109.26117585908, 21390.358289251348, 21424.78575214259, 7719.382449404035, 7728.149903510609, 7781.688732450752, 7824.530528168328, 8128.187181281824, 3634.200475895299, 4211.642010429086, 4222.472190976128, 4278.529361770203, 4299.161663475592, 3233.579634647481, 3374.8481318340732, 3448.620651728308, 3450.171958729937, 3488.476728490696, 687.9484038697118, 688.0779755128052, 690.082190686386, 694.3230350408312, 702.6732569355172, 628.6448156791398, 637.1653134393958, 656.3633275722541, 658.5719282466436, 680.0, 7632.580208088609, 9140.537513997728, 9254.537273136317, 9261.536923153815, 9307.488088155082, 606.927168739754, 630.5208041888199, 653.7221680785647, 659.1365311442026, 677.8508728079814, 4245.006604888604, 4543.727376357429, 4569.817207311737, 4608.631309495232, 4621.168189725881, 85975.0, 102744.48627756962, 105109.0, 108847.45576272227, 111100.0, 78054.0, 94373.0, 95474.0, 96458.03541964632, 99518.00481995087, 58635.12047319294, 70413.0, 71837.56324873578, 75250.62374688091, 76508.61745691235, 8480.279176270085, 9430.29272804556, 9693.9030609693, 9887.456189909624, 9943.701688949342, 50121.24818127804, 51693.48306516887, 51840.481595185076, 51932.1437320951, 53087.73456132694, 62356.0, 62722.37277627348, 69532.30467695258, 71875.28124718895, 72540.27459725547, 12701.36493175356, 12748.61754147377, 12863.549775757803, 12957.546485872948, 12970.092093553361, 10862.674119776419, 14580.781288280896, 14819.777703334674, 14914.943353719034, 15036.248187590358, 13669.726605468033, 14019.439222430989, 14029.298535073001, 14072.718545629235, 14364.0, 13769.0, 14191.574252772434, 14200.28998550089, 14384.0, 14483.420663173356, 12320.81518777237, 12625.305608191271, 12877.742445151232, 13105.344732763515, 13311.53409630697, 11148.777024459627, 11199.272047316897, 11337.886621133683, 11369.886301136883, 11811.940940295244, 9573.473458959825, 10332.741681458023, 10688.824229334923, 11410.486528106421, 11570.0], "value": 7299.820778457002, "unit": "score"}], "name": "dromaeo_css", "value": 7014.53465054968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 114.0, 156.0, 113.0, 117.0, 119.0, 114.0, 135.0, 113.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 183.0, 182.0, 185.0, 183.0, 183.0, 180.0, 182.0, 183.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 86.0, 63.0, 61.0, 59.0, 59.0, 72.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 85.0, 70.0, 90.0, 98.0, 116.0, 79.0, 68.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 83.0, 87.0, 83.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 86.0, 85.0, 85.0, 87.0, 91.0, 127.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 54.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 68.0, 74.0, 72.0, 70.0, 75.0, 101.0, 102.0, 70.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 88.0, 90.0, 89.0, 87.0, 88.0, 88.0, 87.0, 89.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 166.0, 156.0, 156.0, 157.0, 158.0, 150.0, 149.0, 198.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 175.0, 175.0, 174.0, 175.0, 174.0, 172.0, 176.0, 180.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 70.0, 70.0, 70.0, 69.0, 69.0, 72.0, 82.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1466.0000000000002, "alertThreshold": 2.0}]} 05:52:58 INFO - Return code: 0 05:52:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:58 INFO - # TBPL SUCCESS # 05:52:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:58 INFO - 2016-12-05 05:52:58.252 screenresolution[1796:9940] starting screenresolution argv=screenresolution get 05:52:58 INFO - 2016-12-05 05:52:58.255 screenresolution[1796:9940] Display 0: 1600x1200x32@60 05:52:58 INFO - 2016-12-05 05:52:58.261 screenresolution[1797:9943] starting screenresolution argv=screenresolution list 05:52:58 INFO - Available Modes on Display 0 05:52:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:58 INFO - Intel Iris: 05:52:58 INFO - Chipset Model: Intel Iris 05:52:58 INFO - Type: GPU 05:52:58 INFO - Bus: Built-In 05:52:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:58 INFO - Vendor: Intel (0x8086) 05:52:58 INFO - Device ID: 0x0a2e 05:52:58 INFO - Revision ID: 0x0009 05:52:58 INFO - Displays: 05:52:58 INFO - Display: 05:52:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:58 INFO - Display Serial Number: 1600x1200 60 05:52:58 INFO - Main Display: Yes 05:52:58 INFO - Mirror: Off 05:52:58 INFO - Online: Yes 05:52:58 INFO - Rotation: Supported 05:52:58 INFO - Return code: 0 05:52:58 INFO - Running post-action listener: _resource_record_post_action 05:52:58 INFO - [mozharness: 2016-12-05 13:52:58.510527Z] Finished run-tests step (success) 05:52:58 INFO - Running post-run listener: _resource_record_post_run 05:52:58 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37643264; Write bytes: 702028288; Read time: 232; Write time: 2114 05:52:58 INFO - TinderboxPrint: CPU usage
53.6% 05:52:58 INFO - TinderboxPrint: I/O read bytes / time
37,643,264 / 232 05:52:58 INFO - TinderboxPrint: I/O write bytes / time
702,028,288 / 2,114 05:52:58 INFO - TinderboxPrint: CPU idle
2,258.2 (46.4%) 05:52:58 INFO - TinderboxPrint: CPU system
973.9 (20.0%) 05:52:58 INFO - TinderboxPrint: CPU user
1,629.5 (33.5%) 05:52:58 INFO - TinderboxPrint: Swap in / out
421,490,688 / 0 05:52:58 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 374106624; Write bytes: 368486400; Read time: 27569; Write time: 800 05:52:58 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 31370240; Write bytes: 310471168; Read time: 179; Write time: 1242 05:52:58 INFO - Running post-run listener: _upload_blobber_files 05:52:58 INFO - Blob upload gear active. 05:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:58 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 05:52:58 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'] 05:52:58 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 05:52:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:00 INFO - (blobuploader) - INFO - Done attempting. 05:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:01 INFO - (blobuploader) - INFO - Done attempting. 05:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:04 INFO - (blobuploader) - INFO - Done attempting. 05:53:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:04 INFO - Return code: 0 05:53:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c018689ad8b3d422ad9ae5d7d8b730d0bcfe7c644bdb646eb96d66eebaa9dd2a8407b2522045b6ad2a9de26a33cf752ceb8a8ca95cb966ddc3dfe780afcf6917", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e5dee08b0ecc67af54202618ea88406b0bfa6d6c944f20b294f31430fd5e704de6e5175d37efcf3036145eb4da8c5f47cbcecd47e246d04fb0e65713efc879ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/327786c00c7dbdc763831cab1428864aed5a0542993868e982646d3c45dc894721050f41e387c0694a0ed6091a36fd5793b05a3bb96482963744ae19e64eac05"} 05:53:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:04 INFO - Contents: 05:53:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c018689ad8b3d422ad9ae5d7d8b730d0bcfe7c644bdb646eb96d66eebaa9dd2a8407b2522045b6ad2a9de26a33cf752ceb8a8ca95cb966ddc3dfe780afcf6917", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e5dee08b0ecc67af54202618ea88406b0bfa6d6c944f20b294f31430fd5e704de6e5175d37efcf3036145eb4da8c5f47cbcecd47e246d04fb0e65713efc879ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/327786c00c7dbdc763831cab1428864aed5a0542993868e982646d3c45dc894721050f41e387c0694a0ed6091a36fd5793b05a3bb96482963744ae19e64eac05"} 05:53:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:04 INFO - Copying logs to upload dir... 05:53:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.813838 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-05 05:53:04.546648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 05:53:04.550371) ========= 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.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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/c018689ad8b3d422ad9ae5d7d8b730d0bcfe7c644bdb646eb96d66eebaa9dd2a8407b2522045b6ad2a9de26a33cf752ceb8a8ca95cb966ddc3dfe780afcf6917", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e5dee08b0ecc67af54202618ea88406b0bfa6d6c944f20b294f31430fd5e704de6e5175d37efcf3036145eb4da8c5f47cbcecd47e246d04fb0e65713efc879ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/327786c00c7dbdc763831cab1428864aed5a0542993868e982646d3c45dc894721050f41e387c0694a0ed6091a36fd5793b05a3bb96482963744ae19e64eac05"} build_url:https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/VfibmM3fR9WdhUUcT3qk8Q/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/c018689ad8b3d422ad9ae5d7d8b730d0bcfe7c644bdb646eb96d66eebaa9dd2a8407b2522045b6ad2a9de26a33cf752ceb8a8ca95cb966ddc3dfe780afcf6917", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e5dee08b0ecc67af54202618ea88406b0bfa6d6c944f20b294f31430fd5e704de6e5175d37efcf3036145eb4da8c5f47cbcecd47e246d04fb0e65713efc879ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/327786c00c7dbdc763831cab1428864aed5a0542993868e982646d3c45dc894721050f41e387c0694a0ed6091a36fd5793b05a3bb96482963744ae19e64eac05"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 05:53:04.584782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:53:04.585114) ========= 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.apwHSXpYBl/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.cQrm8lnxgB/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 05:53:04.634023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 05:53:04.634367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 05:53:04.634765) ========= ========= Total master_lag: 0.25 =========