builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1477757848.87 results: success (0) buildid: 20161029063803 builduid: 4ab4933d5a474c8c9fb474ac4aa33324 revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:28.873970) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:28.874396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:28.874667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:28.899582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:28.900168) ========= 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.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-10-29 09:17:28-- 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% 145M=0s 2016-10-29 09:17:28 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080830 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:29.008497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:29.009003) ========= 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.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.025210 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:29.058987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:29.059340) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-10-29 09:17:29,144 truncating revision to first 12 chars 2016-10-29 09:17:29,145 Setting DEBUG logging. 2016-10-29 09:17:29,145 attempt 1/10 2016-10-29 09:17:29,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/969c3295d3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 09:17:29,845 unpacking tar archive at: mozilla-central-969c3295d3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.976609 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:30.057774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:30.058097) ========= script_repo_revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:30.058487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:30.058751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:17:30.076973) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-29 09:17:30.077241) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:17:30 INFO - MultiFileLogger online at 20161029 09:17:30 in /builds/slave/test 09:17:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:17:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:30 INFO - {'append_to_log': False, 09:17:30 INFO - 'base_work_dir': '/builds/slave/test', 09:17:30 INFO - 'blob_upload_branch': 'Firefox', 09:17:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:30 INFO - 'branch': 'Firefox', 09:17:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:30 INFO - 'config_files': ('talos/mac_config.py',), 09:17:30 INFO - 'default_actions': ('clobber', 09:17:30 INFO - 'read-buildbot-config', 09:17:30 INFO - 'download-and-extract', 09:17:30 INFO - 'populate-webroot', 09:17:30 INFO - 'create-virtualenv', 09:17:30 INFO - 'install', 09:17:30 INFO - 'run-tests'), 09:17:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:30 INFO - 'download_minidump_stackwalk': True, 09:17:30 INFO - 'download_symbols': 'ondemand', 09:17:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:30 INFO - 'installer_path': 'installer.exe', 09:17:30 INFO - 'log_level': 'info', 09:17:30 INFO - 'log_name': 'talos', 09:17:30 INFO - 'log_to_console': True, 09:17:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:30 INFO - 'opt_config_files': (), 09:17:30 INFO - 'pip_index': False, 09:17:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:30 INFO - 'cmd': ('bash', 09:17:30 INFO - '-c', 09:17:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:30 INFO - 'enabled': True, 09:17:30 INFO - 'halt_on_failure': False, 09:17:30 INFO - 'name': 'check_screen_resolution'},), 09:17:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:30 INFO - 'cmd': ('bash', 09:17:30 INFO - '-c', 09:17:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:30 INFO - 'enabled': True, 09:17:30 INFO - 'halt_on_failure': False, 09:17:30 INFO - 'name': 'check_screen_resolution'},), 09:17:30 INFO - 'run_cmd_checks_enabled': True, 09:17:30 INFO - 'sps_profile': False, 09:17:30 INFO - 'sps_profile_interval': 0, 09:17:30 INFO - 'suite': 'dromaeojs', 09:17:30 INFO - 'system_bits': '32', 09:17:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:30 INFO - 'title': 't-yosemite-r7-0317', 09:17:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:30 INFO - 'use_talos_json': True, 09:17:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:30 INFO - 'work_dir': 'build'} 09:17:30 INFO - [mozharness: 2016-10-29 16:17:30.278976Z] Running clobber step. 09:17:30 INFO - Running pre-action listener: _resource_record_pre_action 09:17:30 INFO - Running main action method: clobber 09:17:30 INFO - rmtree: /builds/slave/test/build 09:17:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:32 INFO - Running post-action listener: _resource_record_post_action 09:17:32 INFO - [mozharness: 2016-10-29 16:17:32.375544Z] Finished clobber step (success) 09:17:32 INFO - [mozharness: 2016-10-29 16:17:32.375695Z] Running read-buildbot-config step. 09:17:32 INFO - Running pre-action listener: _resource_record_pre_action 09:17:32 INFO - Running main action method: read_buildbot_config 09:17:32 INFO - Using buildbot properties: 09:17:32 INFO - { 09:17:32 INFO - "project": "", 09:17:32 INFO - "product": "firefox", 09:17:32 INFO - "script_repo_revision": "production", 09:17:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:17:32 INFO - "repository": "", 09:17:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:17:32 INFO - "buildid": "20161029063803", 09:17:32 INFO - "pgo_build": "False", 09:17:32 INFO - "basedir": "/builds/slave/test", 09:17:32 INFO - "buildnumber": 128, 09:17:32 INFO - "slavename": "t-yosemite-r7-0317", 09:17:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:17:32 INFO - "platform": "yosemite_r7", 09:17:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:17:32 INFO - "branch": "mozilla-central", 09:17:32 INFO - "repo_path": "mozilla-central", 09:17:32 INFO - "revision": "969c3295d3aa77931cca26eddb047d9d74bd9858", 09:17:32 INFO - "stage_platform": "macosx64", 09:17:32 INFO - "builduid": "4ab4933d5a474c8c9fb474ac4aa33324", 09:17:32 INFO - "slavebuilddir": "test" 09:17:32 INFO - } 09:17:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:17:32 INFO - Running post-action listener: _resource_record_post_action 09:17:32 INFO - [mozharness: 2016-10-29 16:17:32.379103Z] Finished read-buildbot-config step (success) 09:17:32 INFO - [mozharness: 2016-10-29 16:17:32.379231Z] Running download-and-extract step. 09:17:32 INFO - Running pre-action listener: _resource_record_pre_action 09:17:32 INFO - Running main action method: download_and_extract 09:17:32 INFO - mkdir: /builds/slave/test/build/tests 09:17: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')]} 09:17:32 INFO - trying https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:17:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:17:33 INFO - Downloaded 1199 bytes. 09:17:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:17:33 INFO - Using the following test package requirements: 09:17:33 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:17:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:17:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'jsshell-mac.zip'], 09:17:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:17:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:17:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:17:33 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:17:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:17:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:17:33 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:17:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:33 INFO - Fetch https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:17:34 INFO - Http code: 200 09:17:34 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:17:34 INFO - x-amz-cf-id: dTULuswIcDLW1Xe-vrPYkf7QHMcBXphNsQWhY1Ac1oHrTlPN1fQK7g== 09:17:34 INFO - x-amz-version-id: 2lMPW5ch_qbv0e6gF5QE4hEUdBlKX5DD 09:17:34 INFO - Expected file size: 16391696 09:17:34 INFO - Obtained file size: 16391696 09:17:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:17:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:17:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:41 INFO - Fetch https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:17:41 INFO - Http code: 200 09:17:41 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:17:41 INFO - x-amz-cf-id: dLigeJQMk47GfzRLSmFrnRzhvGUzo2kpcrYn_DlRufFBjCEp9VUM3g== 09:17:41 INFO - x-amz-version-id: 2lMPW5ch_qbv0e6gF5QE4hEUdBlKX5DD 09:17:42 INFO - Expected file size: 16391696 09:17:42 INFO - Obtained file size: 16391696 09:17:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:17:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:17:48 INFO - Fetch https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:17:49 INFO - Http code: 200 09:17:49 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:17:49 INFO - x-amz-cf-id: FZK1ZlAAb7Ntc9GEfIOsuJ8SMfys89mFV6R0SFi0LJUmCOv5KJdMOA== 09:17:49 INFO - x-amz-version-id: k0meVR8cQV0i73WbyAYq6hsCxrKTmseM 09:17:49 INFO - Expected file size: 14409038 09:17:49 INFO - Obtained file size: 14409038 09:17:50 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')]} 09:17:50 INFO - trying https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:17:50 INFO - Downloading https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:17:53 INFO - Downloaded 112035721 bytes. 09:17:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:17:53 INFO - mkdir: /builds/slave/test/properties 09:17:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:53 INFO - Contents: 09:17:53 INFO - build_url:https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - Running post-action listener: set_extra_try_arguments 09:17:53 INFO - [mozharness: 2016-10-29 16:17:53.761389Z] Finished download-and-extract step (success) 09:17:53 INFO - [mozharness: 2016-10-29 16:17:53.761507Z] Running populate-webroot step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: populate_webroot 09:17:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:53 INFO - '--tppagecycles', 09:17:53 INFO - '7'], 09:17:53 INFO - 'tests': ['tsvgm']}}, 09:17:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s', 09:17:53 INFO - '--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}, 09:17:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}}, 09:17:53 INFO - 'talos.zip': {'path': '', 09:17:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - [mozharness: 2016-10-29 16:17:53.780389Z] Finished populate-webroot step (success) 09:17:53 INFO - [mozharness: 2016-10-29 16:17:53.780493Z] Running create-virtualenv step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: create_virtualenv 09:17:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:53 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 09:17:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:53 INFO - Using real prefix '/tools/python27' 09:17:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:57 INFO - Installing pip.................done. 09:17:57 INFO - Return code: 0 09:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:17:57 INFO - Reading from file tmpfile_stdout 09:17:57 INFO - Output received: 09:17:57 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) 09:17:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:57 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')]} 09:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:57 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')]} 09:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:57 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:17:57 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 09:17:57 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 09:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:57 INFO - 'HOME': '/Users/cltbld', 09:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:57 INFO - 'LOGNAME': 'cltbld', 09:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:57 INFO - 'MOZ_NO_REMOTE': '1', 09:17:57 INFO - 'NO_EM_RESTART': '1', 09:17:57 INFO - 'PAGER': '/bin/cat', 09:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:57 INFO - 'PWD': '/builds/slave/test', 09:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:57 INFO - 'SHELL': '/bin/bash', 09:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:17:57 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:57 INFO - 'USER': 'cltbld', 09:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:57 INFO - 'XPC_FLAGS': '0x0', 09:17:57 INFO - 'XPC_SERVICE_NAME': '0', 09:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:57 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 09:17:57 INFO - Cleaning up... 09:17:58 INFO - Return code: 0 09:17:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:17:58 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')]} 09:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:58 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')]} 09:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:58 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:17:58 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 09:17:58 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 09:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:58 INFO - 'HOME': '/Users/cltbld', 09:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:58 INFO - 'LOGNAME': 'cltbld', 09:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:58 INFO - 'MOZ_NO_REMOTE': '1', 09:17:58 INFO - 'NO_EM_RESTART': '1', 09:17:58 INFO - 'PAGER': '/bin/cat', 09:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:58 INFO - 'PWD': '/builds/slave/test', 09:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:58 INFO - 'SHELL': '/bin/bash', 09:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:17:58 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:58 INFO - 'USER': 'cltbld', 09:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:58 INFO - 'XPC_FLAGS': '0x0', 09:17:58 INFO - 'XPC_SERVICE_NAME': '0', 09:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:58 INFO - Downloading/unpacking psutil>=3.1.1 09:17:58 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 09:17:58 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 09:17:58 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 09:17:58 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 09:17:58 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 09:17:58 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 09:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:01 INFO - Installing collected packages: psutil 09:18:01 INFO - Running setup.py install for psutil 09:18:01 INFO - building 'psutil._psutil_osx' extension 09:18:01 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 09:18:02 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 09:18:02 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 09:18:02 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 09:18:02 INFO - building 'psutil._psutil_posix' extension 09:18:02 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 09:18:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:18:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:18:02 INFO - ^ 09:18:02 INFO - 1 warning generated. 09:18:02 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 09:18:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:02 INFO - Successfully installed psutil 09:18:02 INFO - Cleaning up... 09:18:02 INFO - Return code: 0 09:18:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:02 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:02 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 09:18:02 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 09:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:02 INFO - 'HOME': '/Users/cltbld', 09:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:02 INFO - 'LOGNAME': 'cltbld', 09:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:02 INFO - 'MOZ_NO_REMOTE': '1', 09:18:02 INFO - 'NO_EM_RESTART': '1', 09:18:02 INFO - 'PAGER': '/bin/cat', 09:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:02 INFO - 'PWD': '/builds/slave/test', 09:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:02 INFO - 'SHELL': '/bin/bash', 09:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:02 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:02 INFO - 'USER': 'cltbld', 09:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:02 INFO - 'XPC_FLAGS': '0x0', 09:18:02 INFO - 'XPC_SERVICE_NAME': '0', 09:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:03 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 09:18:03 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 09:18:03 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 09:18:03 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 09:18:03 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 09:18:03 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 09:18:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:05 INFO - Installing collected packages: mozsystemmonitor 09:18:05 INFO - Running setup.py install for mozsystemmonitor 09:18:06 INFO - Successfully installed mozsystemmonitor 09:18:06 INFO - Cleaning up... 09:18:06 INFO - Return code: 0 09:18:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:06 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')]} 09:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:06 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')]} 09:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:06 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:06 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 09:18:06 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 09:18:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:06 INFO - 'HOME': '/Users/cltbld', 09:18:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:06 INFO - 'LOGNAME': 'cltbld', 09:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:06 INFO - 'MOZ_NO_REMOTE': '1', 09:18:06 INFO - 'NO_EM_RESTART': '1', 09:18:06 INFO - 'PAGER': '/bin/cat', 09:18:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:06 INFO - 'PWD': '/builds/slave/test', 09:18:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:06 INFO - 'SHELL': '/bin/bash', 09:18:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:06 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:06 INFO - 'USER': 'cltbld', 09:18:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:06 INFO - 'XPC_FLAGS': '0x0', 09:18:06 INFO - 'XPC_SERVICE_NAME': '0', 09:18:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:06 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 09:18:06 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 09:18:06 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 09:18:06 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 09:18:06 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 09:18:06 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 09:18:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:08 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 09:18:08 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 09:18:08 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 09:18:08 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 09:18:08 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 09:18:08 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 09:18:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:09 INFO - warning: no files found matching '*.txt' 09:18:09 INFO - no previously-included directories found matching 'build' 09:18:09 INFO - no previously-included directories found matching 'dist' 09:18:09 INFO - no previously-included directories found matching '.git*' 09:18:09 INFO - Installing collected packages: jsonschema, functools32 09:18:09 INFO - Running setup.py install for functools32 09:18:09 INFO - warning: no files found matching '*.txt' 09:18:09 INFO - no previously-included directories found matching 'build' 09:18:09 INFO - no previously-included directories found matching 'dist' 09:18:09 INFO - no previously-included directories found matching '.git*' 09:18:09 INFO - Successfully installed jsonschema functools32 09:18:09 INFO - Cleaning up... 09:18:09 INFO - Return code: 0 09:18:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:09 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')]} 09:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:09 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')]} 09:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:09 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:09 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 09:18:09 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 09:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:09 INFO - 'HOME': '/Users/cltbld', 09:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:09 INFO - 'LOGNAME': 'cltbld', 09:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:09 INFO - 'MOZ_NO_REMOTE': '1', 09:18:09 INFO - 'NO_EM_RESTART': '1', 09:18:09 INFO - 'PAGER': '/bin/cat', 09:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:09 INFO - 'PWD': '/builds/slave/test', 09:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:09 INFO - 'SHELL': '/bin/bash', 09:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:09 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:09 INFO - 'USER': 'cltbld', 09:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:09 INFO - 'XPC_FLAGS': '0x0', 09:18:09 INFO - 'XPC_SERVICE_NAME': '0', 09:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:09 INFO - Cleaning up... 09:18:09 INFO - Return code: 0 09:18:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:09 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')]} 09:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:09 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')]} 09:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:09 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:09 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 09:18:09 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 09:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:09 INFO - 'HOME': '/Users/cltbld', 09:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:09 INFO - 'LOGNAME': 'cltbld', 09:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:09 INFO - 'MOZ_NO_REMOTE': '1', 09:18:09 INFO - 'NO_EM_RESTART': '1', 09:18:09 INFO - 'PAGER': '/bin/cat', 09:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:09 INFO - 'PWD': '/builds/slave/test', 09:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:09 INFO - 'SHELL': '/bin/bash', 09:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:09 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:09 INFO - 'USER': 'cltbld', 09:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:09 INFO - 'XPC_FLAGS': '0x0', 09:18:09 INFO - 'XPC_SERVICE_NAME': '0', 09:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:10 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 09:18:10 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 09:18:10 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 09:18:10 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 09:18:10 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 09:18:10 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 09:18:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:12 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 09:18:12 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 09:18:12 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 09:18:12 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 09:18:12 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 09:18:12 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 09:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:13 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 09:18:13 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 09:18:13 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 09:18:13 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 09:18:13 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 09:18:13 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 09:18:13 INFO - Downloading docopt-0.6.1.tar.gz 09:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:13 INFO - Running setup.py install for blobuploader 09:18:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:14 INFO - Running setup.py install for requests 09:18:14 INFO - Running setup.py install for docopt 09:18:14 INFO - Successfully installed blobuploader requests docopt 09:18:14 INFO - Cleaning up... 09:18:14 INFO - Return code: 0 09:18:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:14 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:14 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 09:18:14 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 09:18:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:14 INFO - 'HOME': '/Users/cltbld', 09:18:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:14 INFO - 'LOGNAME': 'cltbld', 09:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:14 INFO - 'MOZ_NO_REMOTE': '1', 09:18:14 INFO - 'NO_EM_RESTART': '1', 09:18:14 INFO - 'PAGER': '/bin/cat', 09:18:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:14 INFO - 'PWD': '/builds/slave/test', 09:18:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:14 INFO - 'SHELL': '/bin/bash', 09:18:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:14 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:14 INFO - 'USER': 'cltbld', 09:18:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:14 INFO - 'XPC_FLAGS': '0x0', 09:18:14 INFO - 'XPC_SERVICE_NAME': '0', 09:18:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Fw5qs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-I8WA7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Wczz1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-xw199B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Cc2Nnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Iuj8Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-S_GdJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-o0T8Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_y06rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VmEvpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-1sMOVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-PxZYY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WDHcNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tyWK9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-GeM4P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vpMXE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-PhP3x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:16 INFO - Running setup.py install for manifestparser 09:18:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:16 INFO - Running setup.py install for mozcrash 09:18:17 INFO - Running setup.py install for mozdebug 09:18:17 INFO - Running setup.py install for mozdevice 09:18:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Running setup.py install for mozfile 09:18:17 INFO - Running setup.py install for mozhttpd 09:18:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Running setup.py install for mozinfo 09:18:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Running setup.py install for mozInstall 09:18:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:17 INFO - Running setup.py install for mozleak 09:18:18 INFO - Running setup.py install for mozlog 09:18:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Running setup.py install for moznetwork 09:18:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Running setup.py install for mozprocess 09:18:18 INFO - Running setup.py install for mozprofile 09:18:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Running setup.py install for mozrunner 09:18:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:18 INFO - Running setup.py install for mozscreenshot 09:18:19 INFO - Running setup.py install for moztest 09:18:19 INFO - Running setup.py install for mozversion 09:18:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:19 INFO - Cleaning up... 09:18:19 INFO - Return code: 0 09:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:19 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:19 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 09:18:19 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 09:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:19 INFO - 'HOME': '/Users/cltbld', 09:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:19 INFO - 'LOGNAME': 'cltbld', 09:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:19 INFO - 'MOZ_NO_REMOTE': '1', 09:18:19 INFO - 'NO_EM_RESTART': '1', 09:18:19 INFO - 'PAGER': '/bin/cat', 09:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:19 INFO - 'PWD': '/builds/slave/test', 09:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:19 INFO - 'SHELL': '/bin/bash', 09:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:19 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:19 INFO - 'USER': 'cltbld', 09:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:19 INFO - 'XPC_FLAGS': '0x0', 09:18:19 INFO - 'XPC_SERVICE_NAME': '0', 09:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-G_7Hp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:19 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)) 09:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-RpPeZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-r7tjtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:19 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)) 09:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-3akLnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fPfpHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-j8gWSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Ns7RVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ysYYLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-v8vEEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-q4IDtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-j28Stg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-uIDNyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:20 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)) 09:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-hNfhJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:21 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)) 09:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5Gwa0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-kcZVUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:21 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)) 09:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VE3smv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:21 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)) 09:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VmuEuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:21 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)) 09:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:21 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)) 09:18:21 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:21 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:23 INFO - Downloading blessings-1.6.tar.gz 09:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:24 INFO - Installing collected packages: blessings 09:18:24 INFO - Running setup.py install for blessings 09:18:24 INFO - Successfully installed blessings 09:18:24 INFO - Cleaning up... 09:18:24 INFO - Return code: 0 09:18:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:24 INFO - Reading from file tmpfile_stdout 09:18:24 INFO - Current package versions: 09:18:24 INFO - blessings == 1.6 09:18:24 INFO - blobuploader == 1.2.4 09:18:24 INFO - docopt == 0.6.1 09:18:24 INFO - functools32 == 3.2.3-2 09:18:24 INFO - jsonschema == 2.5.1 09:18:24 INFO - manifestparser == 1.1 09:18:24 INFO - mozInstall == 1.12 09:18:24 INFO - mozcrash == 0.17 09:18:24 INFO - mozdebug == 0.1 09:18:24 INFO - mozdevice == 0.48 09:18:24 INFO - mozfile == 1.2 09:18:24 INFO - mozhttpd == 0.7 09:18:24 INFO - mozinfo == 0.9 09:18:24 INFO - mozleak == 0.1 09:18:24 INFO - mozlog == 3.4 09:18:24 INFO - moznetwork == 0.27 09:18:24 INFO - mozprocess == 0.23 09:18:24 INFO - mozprofile == 0.28 09:18:24 INFO - mozrunner == 6.12 09:18:24 INFO - mozscreenshot == 0.1 09:18:24 INFO - mozsystemmonitor == 0.3 09:18:24 INFO - moztest == 0.7 09:18:24 INFO - mozversion == 1.4 09:18:24 INFO - psutil == 3.1.1 09:18:24 INFO - requests == 1.2.3 09:18:24 INFO - wsgiref == 0.1.2 09:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:24 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 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:24 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 09:18:24 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 09:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:24 INFO - 'HOME': '/Users/cltbld', 09:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:24 INFO - 'LOGNAME': 'cltbld', 09:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:24 INFO - 'MOZ_NO_REMOTE': '1', 09:18:24 INFO - 'NO_EM_RESTART': '1', 09:18:24 INFO - 'PAGER': '/bin/cat', 09:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:24 INFO - 'PWD': '/builds/slave/test', 09:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:24 INFO - 'SHELL': '/bin/bash', 09:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:24 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:24 INFO - 'USER': 'cltbld', 09:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:24 INFO - 'XPC_FLAGS': '0x0', 09:18:24 INFO - 'XPC_SERVICE_NAME': '0', 09:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 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)) 09:18:24 INFO - Cleaning up... 09:18:24 INFO - Return code: 0 09:18:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1023a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102318570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdada59f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, '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.VvRWtliehs/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.dH9SDP9up3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 09:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:24 INFO - 'HOME': '/Users/cltbld', 09:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:24 INFO - 'LOGNAME': 'cltbld', 09:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:24 INFO - 'MOZ_NO_REMOTE': '1', 09:18:24 INFO - 'NO_EM_RESTART': '1', 09:18:24 INFO - 'PAGER': '/bin/cat', 09:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:24 INFO - 'PWD': '/builds/slave/test', 09:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:24 INFO - 'SHELL': '/bin/bash', 09:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:18:24 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:24 INFO - 'USER': 'cltbld', 09:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:24 INFO - 'XPC_FLAGS': '0x0', 09:18:24 INFO - 'XPC_SERVICE_NAME': '0', 09:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:25 INFO - Cleaning up... 09:18:25 INFO - Return code: 0 09:18:25 INFO - Running post-action listener: _resource_record_post_action 09:18:25 INFO - Running post-action listener: _start_resource_monitoring 09:18:25 INFO - Starting resource monitoring. 09:18:25 INFO - [mozharness: 2016-10-29 16:18:25.236333Z] Finished create-virtualenv step (success) 09:18:25 INFO - [mozharness: 2016-10-29 16:18:25.237303Z] Running install step. 09:18:25 INFO - Running pre-action listener: _resource_record_pre_action 09:18:25 INFO - Running main action method: install 09:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:25 INFO - Reading from file tmpfile_stdout 09:18:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:25 INFO - Reading from file tmpfile_stdout 09:18:25 INFO - Output received: 09:18:25 INFO - Usage: mozinstall [options] installer 09:18:25 INFO - Options: 09:18:25 INFO - -h, --help show this help message and exit 09:18:25 INFO - -d DEST, --destination=DEST 09:18:25 INFO - Directory to install application into. [default: 09:18:25 INFO - "/builds/slave/test"] 09:18:25 INFO - --app=APP Application being installed. [default: firefox] 09:18:25 INFO - mkdir: /builds/slave/test/build/application 09:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:19:00 INFO - Reading from file tmpfile_stdout 09:19:00 INFO - Output received: 09:19:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:19:00 INFO - Running post-action listener: _resource_record_post_action 09:19:00 INFO - [mozharness: 2016-10-29 16:19:00.113329Z] Finished install step (success) 09:19:00 INFO - [mozharness: 2016-10-29 16:19:00.113477Z] Running run-tests step. 09:19:00 INFO - Running pre-action listener: _resource_record_pre_action 09:19:00 INFO - Running main action method: run_tests 09:19:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:00 INFO - 2016-10-29 09:19:00.127 screenresolution[1640:7553] starting screenresolution argv=screenresolution get 09:19:00 INFO - 2016-10-29 09:19:00.130 screenresolution[1640:7553] Display 0: 1600x1200x32@60 09:19:00 INFO - 2016-10-29 09:19:00.136 screenresolution[1641:7555] starting screenresolution argv=screenresolution list 09:19:00 INFO - Available Modes on Display 0 09:19:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:00 INFO - Intel Iris: 09:19:00 INFO - Chipset Model: Intel Iris 09:19:00 INFO - Type: GPU 09:19:00 INFO - Bus: Built-In 09:19:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:00 INFO - Vendor: Intel (0x8086) 09:19:00 INFO - Device ID: 0x0a2e 09:19:00 INFO - Revision ID: 0x0009 09:19:00 INFO - Displays: 09:19:00 INFO - Display: 09:19:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:00 INFO - Display Serial Number: 1600x1200 60 09:19:00 INFO - Main Display: Yes 09:19:00 INFO - Mirror: Off 09:19:00 INFO - Online: Yes 09:19:00 INFO - Rotation: Supported 09:19:00 INFO - Return code: 0 09:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:00 INFO - Python 2.7.3 09:19:00 INFO - Return code: 0 09:19:00 INFO - grabbing minidump binary from tooltool 09:19:00 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')]} 09:19:00 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 0x1021b6d30>, '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 0x101fdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:00 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 09:19:00 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 09:19:00 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 09:19:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:00 INFO - Return code: 0 09:19:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:19:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:19:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 09:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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 09:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvRWtliehs/Render', 09:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:00 INFO - 'HOME': '/Users/cltbld', 09:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:00 INFO - 'LOGNAME': 'cltbld', 09:19:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:00 INFO - 'MOZ_NO_REMOTE': '1', 09:19:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:00 INFO - 'NO_EM_RESTART': '1', 09:19:00 INFO - 'PAGER': '/bin/cat', 09:19:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:00 INFO - 'PWD': '/builds/slave/test', 09:19:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:00 INFO - 'SHELL': '/bin/bash', 09:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dH9SDP9up3/Listeners', 09:19:00 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 09:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:00 INFO - 'USER': 'cltbld', 09:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:00 INFO - 'XPC_FLAGS': '0x0', 09:19:00 INFO - 'XPC_SERVICE_NAME': '0', 09:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 09:19:00 INFO - mozversion application_buildid: 20161029063803 09:19:00 INFO - mozversion application_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 09:19:00 INFO - mozversion application_display_name: Nightly 09:19:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:00 INFO - mozversion application_name: Firefox 09:19:00 INFO - mozversion application_remotingname: firefox 09:19:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:19:00 INFO - mozversion application_vendor: Mozilla 09:19:00 INFO - mozversion application_version: 52.0a1 09:19:00 INFO - mozversion platform_buildid: 20161029063803 09:19:00 INFO - mozversion platform_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 09:19:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:19:00 INFO - mozversion platform_version: 52.0a1 09:19:00 INFO - using testdate: 1477757940 09:19:00 INFO - actual date: 1477757940 09:19:00 INFO - starting webserver on 'localhost:49266' 09:19:00 INFO - SUITE-START | Running 2 tests 09:19:00 INFO - TEST-START | dromaeo_css 09:19:00 INFO - operating with platform_type : mac_ 09:19:00 INFO - Initialising browser for dromaeo_css test... 09:19:00 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpjdMvhS/profile http://localhost:49266/getInfo.html) 09:19:03 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:19:03 INFO - PROCESS | 1651 | colorDepth:24 09:19:03 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:19:03 INFO - PROCESS | 1651 | __metrics 09:19:03 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:03 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:04 INFO - TEST-INFO | 1651: exit 0 09:19:04 INFO - Browser initialized. 09:19:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpjdMvhS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:15 INFO - PROCESS | 1653 | RSS: Main: 234274816 09:19:15 INFO - PROCESS | 1653 | 09:20:07 INFO - PROCESS | 1653 | 1477758007119 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] 09:22:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 09:22:22 INFO - PROCESS | 1653 | RSS: Main: 499896320 09:22:22 INFO - PROCESS | 1653 | 09:25:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 09:25:26 INFO - PROCESS | 1653 | RSS: Main: 373379072 09:25:26 INFO - PROCESS | 1653 | 09:28:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 09:28:29 INFO - PROCESS | 1653 | RSS: Main: 358072320 09:28:29 INFO - PROCESS | 1653 | 09:31:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 09:31:31 INFO - PROCESS | 1653 | RSS: Main: 356818944 09:31:31 INFO - PROCESS | 1653 | 09:34:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 09:34:35 INFO - PROCESS | 1653 | RSS: Main: 342441984 09:34:35 INFO - PROCESS | 1653 | 09:37:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:37:39 INFO - PROCESS | 1653 | RSS: Main: 380571648 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | __start_tp_report 09:37:39 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:37:39 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:37:39 INFO - PROCESS | 1653 | |i|pagename|runs| 09:37:39 INFO - PROCESS | 1653 | |0;dojo.html;3265.330607225519;3277.8197199154038;3312.138843900585;3325.135464779158;3325.401427743005;5428.864278393033;5549.278593782808;5549.639273447233;5571.331440227168;5592.189132575779;5537.750801213945;5541.445855414457;5582.330120385559;5592.664440133584;5654;5106.1574840151425;5115.4884511548735;5159.664621799589;5165.845024649267;5186.7147306898105;4563.520830312803;5087.389513258414;5184.585233181337;5199.844004679866;5234.790608375661;4992.600591952653;5171.586273098162;5174.974125129369;5225.63420560559;5238.423773384925;5011.223260394645;5097.745112744348;5112.156494178456;5133.871653208681;5150.742462876841;5011.498850114959;5030.622703297267;5066.392032956032;5086.3133476980875;5090.618203634705;5456.48163424478;5492.313460817398;5498.230247765316;5519.806806761744;5526.253955716007;5286.312779338661;6109.541784366146;6138.938610613882;6141.969290153565;6145.293291271516;5725.685087320196;5827.096799996008;5832.416758324176;6100.511959043266;6162.198914141178;5641.26663533738;5654.46282603152;5656.066748986454;5680.914786278209;5692.544596432275;6296.5592408531875;6304.5271604628915;6322.241331040213;6332.271788744261;6333.904991425133;5844.678542680108;5900.940990590125;5984.222051133324;5999.610025348338;6000.519958403404;6095.770848210712;6099.817005489843;6125.021800333839;6125.571219981323;6187.783427580013;6029.517638588903;6096.184014628394;6114.38856114385;6130.233720784902;6139.907901381483;6063.060225665029;6134.325224225332;6140.078988151724;6152.046432802833;6152.815415537541;4760.595349395271;4804.567588917014;4811.27830825372;4817.27740838877;4825;4326.891827704269;4334.761588112684;4339.327404252346;4379.0366119453665;4421.491528474202;5573.108302671553;5585.58108141891;5587.106063029895;5602.355729091125;5605.159226116115;6003.159557661931;6007.459328660354;6086.269647642312;6165.722542485599;6182.381761823782;5527.309086364205;5555.970427899351;5573.219749235111;5585.078462053716;5626.409227031185;5271;5278.313819203556;5285.180796976475;5293.417724050351;5297.602679799031;6178.907316390168;6291.6539590321145;6298.7480500780375;6323.272823625342;6323.747050117944;6068.757249709962;6074.90887636677;6109.283207920342;6110.133516259585;6114.633122012693;6315.55791094619;6322.557420980487;6329.050642403677;6333.904991425225;6341.682915854281;5832.650040997553;5997.430244126801;6035.969820150871;6043.09353596964;6048.637081775108;5912.793052243323;5996.370381110095;6000.21997140369;6004.0693692477735;6048.153258543719;5836.328822185334;5848.239728835394;5860.531157507304;5860.648361098177;5862.208601838868;5818.76724930998;5844.94155058444;5850.736716847667;5855.473007429352;5862.560307976833;5711.286089238845;5746.396628353963;5757.596968212185;5761.711914404347;5772.1341798728845;5862;5866.50134738552;5870.589058765845;5885.205497257986;5892.793752218823;5748.166515855094;5772.336181339199;5772.624779389326;5776.306843178845;5785.566082543742 09:37:39 INFO - PROCESS | 1653 | |1;ext.html;465.74616833825564;520.7188118416055;526.1581469648561;526.6366207316951;551.3273805956732;32807.343853122926;38571;39725.80137099314;39786.40320395193;41815.79092104543;40863.79568102163;41205.58794412055;41272.38091428631;41275.58724412762;41286;8383.035950865667;9323.254139668827;9513.857292140588;9514.381565198275;9562.569684364185;8423.452475589067;11209.271397359187;11472.541098356098;11482.081433485342;11602.419879006058;11434.313941163557;11497.425128743529;11503.94248028763;11508.777542288173;11623.360715160663;8453.619587118534;8656.437331573428;11286;11373.658790236223;11386.032187264092;11115.72210694731;11444.542218311257;11482.82775758356;11560.959513643813;11575.53697852085;39031.8048409759;39362.21275574501;39369;39379.21241575181;39448.802755986035;3361.6638336166434;3398.4052790761516;3512.1921957949558;3614.6023937366867;3679.35611268027;29144;29427.852860735773;30798.692013079806;30851;30873;2752.215618548704;3165.876113979527;3267.4608689566194;3295.24209431832;3336.4494858348344;462295.3770462286;465269.67365163297;466731;466908;483098;60839.78320433655;61222.77554448886;61368.69315653393;61545.69227153925;61718.38281617216;62265.68867155726;62381;62438.375616244164;62445;62459.192600924885;15650;15856.920715396349;15891.841081589268;15915.0450972942;15924.442644507619;10957.452127393757;11204.15968802343;11227.607033753779;12180.451879665436;12263.325517096646;13083.934580327228;16175.352985880669;16278.75581866273;16362.590935226715;18054.74315710536;6795.898061529081;7915.366770658334;8018.839623207503;8086.555239461886;8113.837723245502;866.7226487524058;898.2903506230006;982.6020461713018;995.8050339592373;1162.7035106048072;23827.880860595586;28628.427431451255;29368;29834.95577654772;30549.847250763603;872.7992561710842;939.9765005874771;1063.4629512096496;1095.9397233152094;1206.1315852586124;13302.600921972356;14887.70224595502;15306.158161301235;15479.767803482957;16096.597585060234;643547;649133;649612;650233;651670;57479.425205748244;58241;58350;58370;58373.12440313399;1368.8699573540498;1413.4770135049891;1425.8502857199844;1426.6362077670128;1427.7215942891037;28214.576781348707;28764.71235287704;28952.276193095342;29442.263943401587;29787.851060744557;48949;49462.75268623634;49563.008739825724;49596;49640.503594963586;545806;546023;547791;549760;550089;25406.364840879127;25535.489290214464;25912.611310829976;25956.480870382864;26045.609315860656;38818.06677794621;39150;39293.41059884161;47658.761706191246;48161.27758083701;36323.091922702144;38479.807600961816;39332.41001384924;39418;40491.98770030773;31127.279145360288;36395;38790.80604596959;38880;40039.599604004754;38088.61911380962;38504.80747596244;38516.6148338513;38639;38965.41551876781;32093.839530802197;33869.32261354809;34613.307733845686;34812.9556113317;34995.65004349924;20660.483487912923;25208.621870671588;25298.873505632353;25569.269685108313;25573.744262557135 09:37:39 INFO - PROCESS | 1653 | |2;jquery.html;366.50521795575975;371.1463633642622;375.93421151298514;383.79275191396647;398.06454831146806;19163.52091197719;19770.30803921863;19802.405927822187;20250.797492025056;20458.69311960318;18526.629467410676;19253.807461925375;19260.90369548154;19585.41243762686;20096.39710808678;4682;5731.283589551295;5955.553333499983;6020.337762846083;6043.153958445821;5883.205767221413;6003.429674180946;6007.579469437142;6022.367651396606;6022.8795424091495;5524.447555244484;5796.333421656522;5825.563082768788;5980.88038239235;5987.820365389045;5862.120681897707;5902.114682797572;5906;5908;5914.674692891911;5629.690367029812;5890.204822348971;5942.792002279943;5943.286805583314;5949.345571987078;11530.019948304403;12794.936025319907;14053.945954053384;24787.628185577232;25158.748412515823;2114.143771772435;2197.615417301966;2225.5660146271484;2290.4502919299416;2319.3969567912463;9388.671396501159;10203.6428724995;10206.897931020669;12359.764023597658;14659.560213193621;1810.9094545272683;1823.7811462624438;1935.554822390858;1955.8239758421669;1959.8138176873174;106231.46884265529;109756;112553.43723281413;113070.30086088838;113128;10991.120710343153;11093.944530277458;11199.440027998568;11232.269902456477;11369.886301137049;12731.045171612166;13201.735965280832;13688.247146406844;13984.021118521607;14146.363413646204;8106.432549721463;8233.670653173926;8273.627686754111;8358.414910956297;8363.372747043995;8117.634706438106;8141.1451797561585;8145.79635509117;8317.126701696236;8343.207395297437;4359.825606975749;4440.067585806952;4454.910901781946;4529.796159172845;4537.342085397599;1769.2922830867756;1776.7068433708293;1881.7177423386602;1908.2462427341122;1916.150914367642;846.229930763015;875.0461996423801;892.6788353237116;954.2509130332655;955.9665411710696;15621.82836287283;15966.920165399331;21235.68146477804;21281.467963300733;21296.574068518545;803.6222975201646;876.776896229756;917.9724608261763;931.329442801182;932.3939439364467;8366.414350995494;9750.366226195274;10912.417699433538;11329.943350283196;11338.716532086599;449461.75269123446;530510;538549;542572;548165;99482;100886;126448.36775816247;131740.3412982929;132299;926.2404828041076;959.822432849925;964.3876138652007;1002.6991902429243;1005.959761609542;18606.627867442847;19000.904995474935;19022.80977190266;19182.232710691416;19221.327253546617;54762.726186370404;55315.89368212533;55542;55561.7221913904;55754.72122639361;82144.94637634107;82990.58504707438;83742.58128709561;83748.58125709332;85031;7391.2978267064545;7480.513766605153;8008.319292860172;8089.433739638169;8227.670893164206;9722.854157187789;12798.936005319914;12974;13119.75362340576;13138.211707297593;11071.557137714723;11098;11304.943475282571;11318.717032074264;11420;10240.590376384862;10570.2072344576;10797.028267455968;10848.67453976382;10903.29128606638;9515.762105947406;11265.380404077854;11303.1522635801;11583.305001699924;11819;7876.267221211324;7876.330511906552;7997.640106195351;8311.750647480585;8314.542700151549;8269.421140520106;9757.951210243904;11009.61466348674;11282.266652667551;11303.943480282545 09:37:39 INFO - PROCESS | 1653 | |3;mootools.html;1531.012496939474;1568.945086921958;1809.3263731048785;1909.3603642779667;1975.2296604324306;7548.81127971801;7799.805004874881;8097.959510202448;8497.660093596256;8510.787230319238;7677.731279405222;7870.763877083697;8086.231807978247;8275.379346549003;8308.54303013334;1938.37002974034;2118.8410869184795;2336.2523992322463;2336.380859072339;2338.7895089441945;2065;2305.2162264829954;2340.0990618611872;2353.329301149173;2356.1046802215133;2083.6770300603357;2109.778473260301;2112.334614596405;2113.365990202941;2114.143771772435;1928.305809908439;2226.2430773536994;2291.667708182304;2303.0557471436796;2304.2856714418585;2291.4385975435957;2313.0747700919596;2323.314622186442;2329.3710698111413;2330.1378489958656;8350.498970061815;8427.073021967579;8451.957740211321;8458;8486.448380855225;4454.220511410523;5089.847304580869;5255.6583822051825;5262.05283049051;5263.526282634582;3230.450823360011;3463.79217246966;3546.627604101584;3550.928981420383;3568.232829941549;907.9682211122579;1042.0621440703428;1079.3200283821143;1082.258652822811;1084.5878566144893;10848.67453976382;10917.617883374123;10924.235303528756;10937.781244375148;10946.671599852018;4338.674599405057;4583.54164583539;4699.130660827758;4702.482726900038;4705.247160454379;7946.721864734706;9407.106324899123;9411.4823684698;9427.387219830689;9451.858222126673;5222.477752224747;5223.895522089537;5227.817026404134;5228.163493840967;5242.52817246442;3977.6022397759994;4618.607418369409;4802.51974802517;4820.9517904821205;4822.758862056883;3712.554493460802;3739.607341229186;3771.6228377162615;3813.218290250492;3820.6179382061573;1253.6552448076852;1254.103316128954;1255.7802384582844;1271.1419791640606;1272.4210484229654;886.5257087458178;909.3043821476575;924.9213816825511;937.3482754178966;970.7427531704104;5645.6694866896405;5652.886942261214;5803.5979338597535;5848.0350742127075;5992.400759923973;425.20698896557695;432.3406804622975;434.24224727850105;446.57129156009944;451.3883687603316;3078.3843231353817;3284.5201872586044;3853.9016380331473;3949.2101579683604;4051;9441.527923603793;9909.950450247703;9965.55155018026;9980.800383992424;10183.134433573081;10020.849687254697;10025.498725063864;10051.798964020678;10058.59765609382;10058.949705251427;7664.271894170045;7870.921290787019;7877.803054923673;7878.763637090897;7897.526148431112;4626.83806066786;5365.1949915545765;5749.91375129365;5912.260967379078;6109.84725381869;9183.357164998386;9237.353385262966;9321.39410938314;9330.440173589606;9452.338336316667;9255.120763527455;9356.251499880129;9368.718938431857;9403.623855045722;9467.715968520955;7078.964605177147;7204.351608355273;7218.205997340184;7219.45854060937;7223.494355395072;7669.5398276103615;7752.457327987212;7765.990421245202;7822.178671239438;7835.921640783519;7027.191872934473;7077.186123595852;7095.680694368869;7099.538529995534;7190.137183538009;6229.314775374796;6986.47601429905;7010.123734533184;7062.975868499142;7074.575525468488;6539.149910511603;6589.4069533742195;6655.068290439245;6665.50008749336;6669.53313268086;4453.621442177451;4670.696404733681;4756.548127927841;4864.124457597666;4937.1113199624415;4829.396325459317;4930.359053323045;4987.551120399182;5022;5122.899611159407 09:37:39 INFO - PROCESS | 1653 | |4;prototype.html;260.8107031934379;273.55137574378017;280.07435425917333;297.7409653601367;306.52029573717135;4287.978560107195;4982.928670335881;5082.567981721553;5272.947270527294;5310.495502927225;4443.60007599316;5212.853172302097;5240.37115546135;5255.658382205154;5258.368995720519;3470.861165553375;3509.3332266869215;3705.794487768088;3941.251162279165;3987.9601203988022;3611.4763359312883;3739.719521035933;3789.9009287306785;3798.4112462568346;3980.2835489611857;3424.708899743512;3434.2616337487434;3947.5460322063045;3955.821988010532;3974.94663914063;3128.499440089586;3263.7389008879472;3283.688049635281;3515.716763381373;3710.7939919526125;3432.031292931621;3438.6045604755523;3443.9311213775586;3463.79217246966;3466.4626982817704;4824.1316563018645;5019.598432125457;5083.661515702781;5108.646208754683;5116.69299842007;3945.9013524661827;4495.64034877209;4538.686758666159;4542.341360502742;4563.224251877155;5475.534579560742;5495.230667706524;5507.449255074501;5512.645010441746;5583.157558005848;3181.5704879841155;3625.024361722841;3721.7394782365245;3761.2665530221616;3768.4926029588382;5702.781954511617;5717.371089180187;5795.942040579583;5824.912626310609;5834.883302333972;3211.245357341023;3787.62123787619;3805.46723458716;3834.405667121601;3835.753380151462;3268.3790079884748;3426.749236528699;3477.826108694555;3613.4941108244866;3697.9845983938817;3918.8040597970557;4095.7952102395357;4274.7435153890865;4435.711678740871;4496.505384407713;5587.38538760736;5618.6628802272;5619.8595035124445;5622.240997465372;5676.858078548069;1092.9398883061508;1299.1750238598559;1322.2661422910378;1337.6155678872321;1346.8989825763108;709.8464994384126;757.3978686943783;760.5968836516655;802.9882348241258;819.6557445872747;3369.3261347730554;4324.567543245713;4336.441499515301;4393.956060439355;4409.889752756207;3925.430812532167;4777.474477807438;4784.808607655725;4789.856304310876;4802.351682522814;3647.7628954118427;4206.957930420656;4220.07158425146;4319.611234988866;4354.538142176977;2158.758713739606;2243.9804176241187;2278.5101203241384;2407.882520889264;2445.4008767851633;4214.726042807208;4270.402143699885;4552.2488789350045;4599.494055653875;4924.384451943507;4264.460497786829;4583.968607063384;4738.597219236334;4792.448868380111;4860.902781944341;4070.8398106539494;4422.137683151819;5440.537554307928;5959.553033522417;6057.545684073624;5396.78412863481;5774.971125144515;5801.245838041028;5809;5818.040023396092;5524.348312809793;5693.686847223443;5705.060279504988;5709.172170035405;5732.71336433185;4825.876614289701;5099.209622508517;5504.779808807602;5763.33721622002;5961.731722072604;3706.7034637229494;3867.0332416895776;3881.5536213335827;3886.397608370707;3922.9019274518364;4905.607551395951;5463.579469337921;5789.421057894346;5838.2702162229725;5854.619449735754;4737.8341758038305;5564;5596.796688711946;5601.41185175567;5616.297962754656;5567.383329834971;5579.804706835242;5603.55171586264;5610.495055444866;5632.774689012557;4191.3293872980175;4960.900781984412;5402.297701298806;5434.83695489136;5518.972405137949;5518.448155184449;5591.496765291144;5610.018246806874;5615.326160860723;5623.128415095667;4557.589816916494;5442.401335852974;5457.235986961908;5486.286782718221;5487.067198576172 09:37:39 INFO - PROCESS | 1653 | |5;yui.html;785.5326080981815;810.2302812328289;816.3713940265995;825.150095401736;836.6653338664534;14687.118772873635;15161.090334579932;15186.848131518682;15198.164100974442;15235.31441085151;13656.24890631015;13751;13759.105658132214;13779.379927903243;13824.239666818321;696.7944456385353;720.5748608321089;870.0994470722803;878.8462019146656;891.3849443883732;887.4542156573725;896.7758060484879;896.9730908072736;897.9775505612347;898.9685361012366;923.4413180026088;945.3288165402572;946.096477863642;947.9383840050375;948.4404201521102;941.2893265584509;941.3928016429434;941.5433514745378;942.0814705661993;942.6606421688186;550.3066136667827;572.4962033410613;575.2435547255346;576.435093608262;595.4313630482878;11906;12213.145079844415;13808.792868106986;14332.928335358256;14697.338619762137;13845.30773461333;14068.366923488467;14124.858751412457;14180.574582762534;14270.785938210935;11501.884981150166;11514.654560363202;11558.422078896021;11893.405329733565;11913.761724765456;3734.7572407793405;3743.32878242522;3743.700503959704;3764.3224219640456;3900.6294402031763;89934.55032724794;93135.53432232795;94870.05129948682;95896.52051739766;96014.51992739992;10304.948475257575;10309.587616495257;10854;10900.618478353219;11291.49188286529;21747.456313592287;21960.388318452984;22022.44943876416;22105.226317078825;22117;7684.346830519356;7855.175206603339;7868.449208555347;7908.288254057163;7909.327707144842;3552.91117722059;4227.8097485613225;4326.935095973563;4475.1273501666865;4517.75152366623;2990.2374894401787;3457.533233013561;3521.3133438979153;3552.98223508886;3563.6970857476886;612.301975747648;625.4308579193004;632.8544434780026;635.3900255754435;640.2093414632925;548.8161465908966;586.8562202260473;624.4723208888482;653.6404977262487;653.6404977262582;8628.396012279205;9076.455412675261;9131;9413.058694130668;9457.33798634089;537.4061661863662;602.3133627664466;638.814743724324;667.6594936582378;671.8219671786981;4414.602685758297;4544.772761361919;4549.886252843706;4560.224761790503;4658.440987081572;81416.59291703622;105698.41452378221;110873.44563277133;112464;112497.43751281354;79191;79281;79718.80421793678;90973.09026909778;100638;80697;81416;83399.16600834035;83818;85437.14562854292;9530.571124299284;9743.707688769347;9744;9751.804963900824;9790.216782657513;43996.56003440053;46491.76754116208;47969.76015119902;54619.45380546144;54977;52057.73971130272;56078;70500.23749406305;74253.62873185599;74491.13772155739;12690.428930697955;12696.238225706487;13029.15310504814;13074.346282686018;13104;11223.71940701489;14255.073420228067;14270.500532481314;14583.197924114276;14883.553493395215;13306.20347394541;13307.001974852119;13424.261665608485;13847.446102156204;13932.860671393157;13005;13236.602901912958;13336.39986200604;13383.263920484467;13845.930770346084;12840.743185136433;13055.608331750063;13339.13252144681;13382.197068175552;13750.931245343709;8984.775380615536;10421.218408619232;11071.955212316678;11604.94197529007;11829.408529573315;10017.599296028076;10499.527521261409;10566.207534435101;10749.301295415773;11537.365444900612 09:37:39 INFO - PROCESS | 1653 | __end_tp_report 09:37:39 INFO - PROCESS | 1653 | __start_cc_report 09:37:39 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,3483 09:37:39 INFO - PROCESS | 1653 | __end_cc_report 09:37:39 INFO - PROCESS | 1653 | __startTimestamp1477759059247__endTimestamp 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:37:39 INFO - PROCESS | 1653 | Number of tests: 6 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5609.38 Median:5772.13 stddev:624.54 (10.8%) stddev-sans-first:598.78 09:37:39 INFO - PROCESS | 1653 | Values: 3265.3 3277.8 3312.1 3325.1 3325.4 5428.9 5549.3 5549.6 5571.3 5592.2 5537.8 5541.4 5582.3 5592.7 5654.0 5106.2 5115.5 5159.7 5165.8 5186.7 4563.5 5087.4 5184.6 5199.8 5234.8 4992.6 5171.6 5175.0 5225.6 5238.4 5011.2 5097.7 5112.2 5133.9 5150.7 5011.5 5030.6 5066.4 5086.3 5090.6 5456.5 5492.3 5498.2 5519.8 5526.3 5286.3 6109.5 6138.9 6142.0 6145.3 5725.7 5827.1 5832.4 6100.5 6162.2 5641.3 5654.5 5656.1 5680.9 5692.5 6296.6 6304.5 6322.2 6332.3 6333.9 5844.7 5900.9 5984.2 5999.6 6000.5 6095.8 6099.8 6125.0 6125.6 6187.8 6029.5 6096.2 6114.4 6130.2 6139.9 6063.1 6134.3 6140.1 6152.0 6152.8 4760.6 4804.6 4811.3 4817.3 4825.0 4326.9 4334.8 4339.3 4379.0 4421.5 5573.1 5585.6 5587.1 5602.4 5605.2 6003.2 6007.5 6086.3 6165.7 6182.4 5527.3 5556.0 5573.2 5585.1 5626.4 5271.0 5278.3 5285.2 5293.4 5297.6 6178.9 6291.7 6298.7 6323.3 6323.7 6068.8 6074.9 6109.3 6110.1 6114.6 6315.6 6322.6 6329.1 6333.9 6341.7 5832.7 5997.4 6036.0 6043.1 6048.6 5912.8 5996.4 6000.2 6004.1 6048.2 5836.3 5848.2 5860.5 5860.6 5862.2 5818.8 5844.9 5850.7 5855.5 5862.6 5711.3 5746.4 5757.6 5761.7 5772.1 5862.0 5866.5 5870.6 5885.2 5892.8 5748.2 5772.3 5772.6 5776.3 5785.6 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:68752.83 Median:38284.21 stddev:149661.43 (390.9%) stddev-sans-first:149993.45 09:37:39 INFO - PROCESS | 1653 | Values: 465.7 520.7 526.2 526.6 551.3 32807.3 38571.0 39725.8 39786.4 41815.8 40863.8 41205.6 41272.4 41275.6 41286.0 8383.0 9323.3 9513.9 9514.4 9562.6 8423.5 11209.3 11472.5 11482.1 11602.4 11434.3 11497.4 11503.9 11508.8 11623.4 8453.6 8656.4 11286.0 11373.7 11386.0 11115.7 11444.5 11482.8 11561.0 11575.5 39031.8 39362.2 39369.0 39379.2 39448.8 3361.7 3398.4 3512.2 3614.6 3679.4 29144.0 29427.9 30798.7 30851.0 30873.0 2752.2 3165.9 3267.5 3295.2 3336.4 462295.4 465269.7 466731.0 466908.0 483098.0 60839.8 61222.8 61368.7 61545.7 61718.4 62265.7 62381.0 62438.4 62445.0 62459.2 15650.0 15856.9 15891.8 15915.0 15924.4 10957.5 11204.2 11227.6 12180.5 12263.3 13083.9 16175.4 16278.8 16362.6 18054.7 6795.9 7915.4 8018.8 8086.6 8113.8 866.7 898.3 982.6 995.8 1162.7 23827.9 28628.4 29368.0 29835.0 30549.8 872.8 940.0 1063.5 1095.9 1206.1 13302.6 14887.7 15306.2 15479.8 16096.6 643547.0 649133.0 649612.0 650233.0 651670.0 57479.4 58241.0 58350.0 58370.0 58373.1 1368.9 1413.5 1425.9 1426.6 1427.7 28214.6 28764.7 28952.3 29442.3 29787.9 48949.0 49462.8 49563.0 49596.0 49640.5 545806.0 546023.0 547791.0 549760.0 550089.0 25406.4 25535.5 25912.6 25956.5 26045.6 38818.1 39150.0 39293.4 47658.8 48161.3 36323.1 38479.8 39332.4 39418.0 40492.0 31127.3 36395.0 38790.8 38880.0 40039.6 38088.6 38504.8 38516.6 38639.0 38965.4 32093.8 33869.3 34613.3 34813.0 34995.7 20660.5 25208.6 25298.9 25569.3 25573.7 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:32284.59 Median:373.54 stddev:87834.49 (23514.1%) stddev-sans-first:88048.19 09:37:39 INFO - PROCESS | 1653 | Values: 366.5 371.1 375.9 383.8 398.1 19163.5 19770.3 19802.4 20250.8 20458.7 18526.6 19253.8 19260.9 19585.4 20096.4 4682.0 5731.3 5955.6 6020.3 6043.2 5883.2 6003.4 6007.6 6022.4 6022.9 5524.4 5796.3 5825.6 5980.9 5987.8 5862.1 5902.1 5906.0 5908.0 5914.7 5629.7 5890.2 5942.8 5943.3 5949.3 11530.0 12794.9 14053.9 24787.6 25158.7 2114.1 2197.6 2225.6 2290.5 2319.4 9388.7 10203.6 10206.9 12359.8 14659.6 1810.9 1823.8 1935.6 1955.8 1959.8 106231.5 109756.0 112553.4 113070.3 113128.0 10991.1 11093.9 11199.4 11232.3 11369.9 12731.0 13201.7 13688.2 13984.0 14146.4 8106.4 8233.7 8273.6 8358.4 8363.4 8117.6 8141.1 8145.8 8317.1 8343.2 4359.8 4440.1 4454.9 4529.8 4537.3 1769.3 1776.7 1881.7 1908.2 1916.2 846.2 875.0 892.7 954.3 956.0 15621.8 15966.9 21235.7 21281.5 21296.6 803.6 876.8 918.0 931.3 932.4 8366.4 9750.4 10912.4 11329.9 11338.7 449461.8 530510.0 538549.0 542572.0 548165.0 99482.0 100886.0 126448.4 131740.3 132299.0 926.2 959.8 964.4 1002.7 1006.0 18606.6 19000.9 19022.8 19182.2 19221.3 54762.7 55315.9 55542.0 55561.7 55754.7 82144.9 82990.6 83742.6 83748.6 85031.0 7391.3 7480.5 8008.3 8089.4 8227.7 9722.9 12798.9 12974.0 13119.8 13138.2 11071.6 11098.0 11304.9 11318.7 11420.0 10240.6 10570.2 10797.0 10848.7 10903.3 9515.8 11265.4 11303.2 11583.3 11819.0 7876.3 7876.3 7997.6 8311.8 8314.5 8269.4 9758.0 11009.6 11282.3 11303.9 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5406.26 Median:5055.92 stddev:2987.37 (59.1%) stddev-sans-first:2981.55 09:37:39 INFO - PROCESS | 1653 | Values: 1531.0 1568.9 1809.3 1909.4 1975.2 7548.8 7799.8 8098.0 8497.7 8510.8 7677.7 7870.8 8086.2 8275.4 8308.5 1938.4 2118.8 2336.3 2336.4 2338.8 2065.0 2305.2 2340.1 2353.3 2356.1 2083.7 2109.8 2112.3 2113.4 2114.1 1928.3 2226.2 2291.7 2303.1 2304.3 2291.4 2313.1 2323.3 2329.4 2330.1 8350.5 8427.1 8452.0 8458.0 8486.4 4454.2 5089.8 5255.7 5262.1 5263.5 3230.5 3463.8 3546.6 3550.9 3568.2 908.0 1042.1 1079.3 1082.3 1084.6 10848.7 10917.6 10924.2 10937.8 10946.7 4338.7 4583.5 4699.1 4702.5 4705.2 7946.7 9407.1 9411.5 9427.4 9451.9 5222.5 5223.9 5227.8 5228.2 5242.5 3977.6 4618.6 4802.5 4821.0 4822.8 3712.6 3739.6 3771.6 3813.2 3820.6 1253.7 1254.1 1255.8 1271.1 1272.4 886.5 909.3 924.9 937.3 970.7 5645.7 5652.9 5803.6 5848.0 5992.4 425.2 432.3 434.2 446.6 451.4 3078.4 3284.5 3853.9 3949.2 4051.0 9441.5 9910.0 9965.6 9980.8 10183.1 10020.8 10025.5 10051.8 10058.6 10058.9 7664.3 7870.9 7877.8 7878.8 7897.5 4626.8 5365.2 5749.9 5912.3 6109.8 9183.4 9237.4 9321.4 9330.4 9452.3 9255.1 9356.3 9368.7 9403.6 9467.7 7079.0 7204.4 7218.2 7219.5 7223.5 7669.5 7752.5 7766.0 7822.2 7835.9 7027.2 7077.2 7095.7 7099.5 7190.1 6229.3 6986.5 7010.1 7063.0 7074.6 6539.1 6589.4 6655.1 6665.5 6669.5 4453.6 4670.7 4756.5 4864.1 4937.1 4829.4 4930.4 4987.6 5022.0 5122.9 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4298.23 Median:4573.60 stddev:1394.70 (30.5%) stddev-sans-first:1365.29 09:37:39 INFO - PROCESS | 1653 | Values: 260.8 273.6 280.1 297.7 306.5 4288.0 4982.9 5082.6 5272.9 5310.5 4443.6 5212.9 5240.4 5255.7 5258.4 3470.9 3509.3 3705.8 3941.3 3988.0 3611.5 3739.7 3789.9 3798.4 3980.3 3424.7 3434.3 3947.5 3955.8 3974.9 3128.5 3263.7 3283.7 3515.7 3710.8 3432.0 3438.6 3443.9 3463.8 3466.5 4824.1 5019.6 5083.7 5108.6 5116.7 3945.9 4495.6 4538.7 4542.3 4563.2 5475.5 5495.2 5507.4 5512.6 5583.2 3181.6 3625.0 3721.7 3761.3 3768.5 5702.8 5717.4 5795.9 5824.9 5834.9 3211.2 3787.6 3805.5 3834.4 3835.8 3268.4 3426.7 3477.8 3613.5 3698.0 3918.8 4095.8 4274.7 4435.7 4496.5 5587.4 5618.7 5619.9 5622.2 5676.9 1092.9 1299.2 1322.3 1337.6 1346.9 709.8 757.4 760.6 803.0 819.7 3369.3 4324.6 4336.4 4394.0 4409.9 3925.4 4777.5 4784.8 4789.9 4802.4 3647.8 4207.0 4220.1 4319.6 4354.5 2158.8 2244.0 2278.5 2407.9 2445.4 4214.7 4270.4 4552.2 4599.5 4924.4 4264.5 4584.0 4738.6 4792.4 4860.9 4070.8 4422.1 5440.5 5959.6 6057.5 5396.8 5775.0 5801.2 5809.0 5818.0 5524.3 5693.7 5705.1 5709.2 5732.7 4825.9 5099.2 5504.8 5763.3 5961.7 3706.7 3867.0 3881.6 3886.4 3922.9 4905.6 5463.6 5789.4 5838.3 5854.6 4737.8 5564.0 5596.8 5601.4 5616.3 5567.4 5579.8 5603.6 5610.5 5632.8 4191.3 4960.9 5402.3 5434.8 5519.0 5518.4 5591.5 5610.0 5615.3 5623.1 4557.6 5442.4 5457.2 5486.3 5487.1 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20033.88 Median:4531.26 stddev:28775.73 (635.0%) stddev-sans-first:28820.15 09:37:39 INFO - PROCESS | 1653 | Values: 785.5 810.2 816.4 825.2 836.7 14687.1 15161.1 15186.8 15198.2 15235.3 13656.2 13751.0 13759.1 13779.4 13824.2 696.8 720.6 870.1 878.8 891.4 887.5 896.8 897.0 898.0 899.0 923.4 945.3 946.1 947.9 948.4 941.3 941.4 941.5 942.1 942.7 550.3 572.5 575.2 576.4 595.4 11906.0 12213.1 13808.8 14332.9 14697.3 13845.3 14068.4 14124.9 14180.6 14270.8 11501.9 11514.7 11558.4 11893.4 11913.8 3734.8 3743.3 3743.7 3764.3 3900.6 89934.6 93135.5 94870.1 95896.5 96014.5 10304.9 10309.6 10854.0 10900.6 11291.5 21747.5 21960.4 22022.4 22105.2 22117.0 7684.3 7855.2 7868.4 7908.3 7909.3 3552.9 4227.8 4326.9 4475.1 4517.8 2990.2 3457.5 3521.3 3553.0 3563.7 612.3 625.4 632.9 635.4 640.2 548.8 586.9 624.5 653.6 653.6 8628.4 9076.5 9131.0 9413.1 9457.3 537.4 602.3 638.8 667.7 671.8 4414.6 4544.8 4549.9 4560.2 4658.4 81416.6 105698.4 110873.4 112464.0 112497.4 79191.0 79281.0 79718.8 90973.1 100638.0 80697.0 81416.0 83399.2 83818.0 85437.1 9530.6 9743.7 9744.0 9751.8 9790.2 43996.6 46491.8 47969.8 54619.5 54977.0 52057.7 56078.0 70500.2 74253.6 74491.1 12690.4 12696.2 13029.2 13074.3 13104.0 11223.7 14255.1 14270.5 14583.2 14883.6 13306.2 13307.0 13424.3 13847.4 13932.9 13005.0 13236.6 13336.4 13383.3 13845.9 12840.7 13055.6 13339.1 13382.2 13750.9 8984.8 10421.2 11072.0 11604.9 11829.4 10017.6 10499.5 10566.2 10749.3 11537.4 09:37:39 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:37:39 INFO - PROCESS | 1653 | 09:37:39 INFO - TEST-INFO | 1653: exit 0 09:37:39 INFO - TEST-OK | dromaeo_css | took 1119185ms 09:37:39 INFO - TEST-START | kraken 09:37:39 INFO - operating with platform_type : mac_ 09:37:39 INFO - Initialising browser for kraken test... 09:37:39 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmphwjy_o/profile http://localhost:49266/getInfo.html) 09:37:42 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:37:42 INFO - PROCESS | 1663 | colorDepth:24 09:37:42 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:37:42 INFO - PROCESS | 1663 | __metrics 09:37:42 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:42 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:43 INFO - TEST-INFO | 1663: exit 0 09:37:43 INFO - Browser initialized. 09:37:43 INFO - Running cycle 1/1 for kraken test... 09:37:43 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmphwjy_o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:55 INFO - PROCESS | 1664 | RSS: Main: 241373184 09:37:55 INFO - PROCESS | 1664 | 09:37:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:58 INFO - PROCESS | 1664 | RSS: Main: 291889152 09:37:58 INFO - PROCESS | 1664 | 09:38:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 09:38:01 INFO - PROCESS | 1664 | RSS: Main: 293249024 09:38:01 INFO - PROCESS | 1664 | 09:38:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 09:38:05 INFO - PROCESS | 1664 | RSS: Main: 383336448 09:38:05 INFO - PROCESS | 1664 | 09:38:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 09:38:08 INFO - PROCESS | 1664 | RSS: Main: 284819456 09:38:08 INFO - PROCESS | 1664 | 09:38:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:11 INFO - PROCESS | 1664 | RSS: Main: 290070528 09:38:11 INFO - PROCESS | 1664 | 09:38:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:14 INFO - PROCESS | 1664 | RSS: Main: 327426048 09:38:14 INFO - PROCESS | 1664 | 09:38:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:17 INFO - PROCESS | 1664 | RSS: Main: 328196096 09:38:17 INFO - PROCESS | 1664 | 09:38:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 09:38:21 INFO - PROCESS | 1664 | RSS: Main: 326967296 09:38:21 INFO - PROCESS | 1664 | 09:38:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:23 INFO - PROCESS | 1664 | RSS: Main: 301383680 09:38:23 INFO - PROCESS | 1664 | 09:38:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:25 INFO - PROCESS | 1664 | RSS: Main: 306855936 09:38:25 INFO - PROCESS | 1664 | 09:38:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:28 INFO - PROCESS | 1664 | RSS: Main: 314638336 09:38:28 INFO - PROCESS | 1664 | 09:38:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:32 INFO - PROCESS | 1664 | RSS: Main: 321826816 09:38:32 INFO - PROCESS | 1664 | 09:38:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:36 INFO - PROCESS | 1664 | RSS: Main: 320925696 09:38:36 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 09:38:38 INFO - PROCESS | 1664 | RSS: Main: 364511232 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | __start_tp_report 09:38:38 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 09:38:38 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 09:38:38 INFO - PROCESS | 1664 | |i|pagename|runs| 09:38:38 INFO - PROCESS | 1664 | |0;ai-astar;115;114;114;114;113;113;112;113;113;114 09:38:38 INFO - PROCESS | 1664 | |1;audio-beat-detection;145;113;115;148;113;114;111;111;143;114 09:38:38 INFO - PROCESS | 1664 | |2;audio-dft;182;183;184;182;185;183;181;179;181;182 09:38:38 INFO - PROCESS | 1664 | |3;audio-fft;81;59;59;87;61;59;58;59;83;59 09:38:38 INFO - PROCESS | 1664 | |4;audio-oscillator;88;70;91;70;70;68;92;67;69;88 09:38:38 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;91;90;90;85;88;87;95;88;94;85 09:38:38 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;94;93;148;130;93;94;94;94;94 09:38:38 INFO - PROCESS | 1664 | |7;imaging-desaturate;82;84;81;79;84;85;85;83;85;85 09:38:38 INFO - PROCESS | 1664 | |8;json-parse-financial;55;55;56;55;55;57;56;55;55;55 09:38:38 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;71;69;68;78;71;68;68;72;68;71 09:38:38 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;88;90;91;86;91;86;87;87;94;101 09:38:38 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;158;162;149;152;164;147;136;154;216;163 09:38:38 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;173;172;171;171;171;173;170;172;162;170 09:38:38 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;64;68;67;61;61;84;89;87;88;65 09:38:38 INFO - PROCESS | 1664 | __end_tp_report 09:38:38 INFO - PROCESS | 1664 | __start_cc_report 09:38:38 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2089 09:38:38 INFO - PROCESS | 1664 | __end_cc_report 09:38:38 INFO - PROCESS | 1664 | __startTimestamp1477759118321__endTimestamp 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | ------- Summary: start ------- 09:38:38 INFO - PROCESS | 1664 | Number of tests: 14 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 09:38:38 INFO - PROCESS | 1664 | Values: 115.0 114.0 114.0 114.0 113.0 113.0 112.0 113.0 113.0 114.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:114.50 stddev:15.71 (13.7%) stddev-sans-first:14.45 09:38:38 INFO - PROCESS | 1664 | Values: 145.0 113.0 115.0 148.0 113.0 114.0 111.0 111.0 143.0 114.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:182.20 Median:182.50 stddev:1.69 (0.9%) stddev-sans-first:1.79 09:38:38 INFO - PROCESS | 1664 | Values: 182.0 183.0 184.0 182.0 185.0 183.0 181.0 179.0 181.0 182.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.00 stddev:11.96 (19.9%) stddev-sans-first:11.47 09:38:38 INFO - PROCESS | 1664 | Values: 81.0 59.0 59.0 87.0 61.0 59.0 58.0 59.0 83.0 59.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.00 stddev:10.82 (13.7%) stddev-sans-first:10.76 09:38:38 INFO - PROCESS | 1664 | Values: 88.0 70.0 91.0 70.0 70.0 68.0 92.0 67.0 69.0 88.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:90.00 stddev:3.40 (3.8%) stddev-sans-first:3.55 09:38:38 INFO - PROCESS | 1664 | Values: 91.0 90.0 90.0 85.0 88.0 87.0 95.0 88.0 94.0 85.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:94.00 stddev:19.50 (20.7%) stddev-sans-first:20.47 09:38:38 INFO - PROCESS | 1664 | Values: 95.0 94.0 93.0 148.0 130.0 93.0 94.0 94.0 94.0 94.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:83.30 Median:84.50 stddev:2.06 (2.4%) stddev-sans-first:2.13 09:38:38 INFO - PROCESS | 1664 | Values: 82.0 84.0 81.0 79.0 84.0 85.0 85.0 83.0 85.0 85.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 09:38:38 INFO - PROCESS | 1664 | Values: 55.0 55.0 56.0 55.0 55.0 57.0 56.0 55.0 55.0 55.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:3.10 (4.4%) stddev-sans-first:3.28 09:38:38 INFO - PROCESS | 1664 | Values: 71.0 69.0 68.0 78.0 71.0 68.0 68.0 72.0 68.0 71.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:89.00 stddev:4.63 (5.2%) stddev-sans-first:4.85 09:38:38 INFO - PROCESS | 1664 | Values: 88.0 90.0 91.0 86.0 91.0 86.0 87.0 87.0 94.0 101.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:160.10 Median:160.00 stddev:21.43 (13.4%) stddev-sans-first:22.72 09:38:38 INFO - PROCESS | 1664 | Values: 158.0 162.0 149.0 152.0 164.0 147.0 136.0 154.0 216.0 163.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:3.17 (1.8%) stddev-sans-first:3.23 09:38:38 INFO - PROCESS | 1664 | Values: 173.0 172.0 171.0 171.0 171.0 173.0 170.0 172.0 162.0 170.0 09:38:38 INFO - PROCESS | 1664 | 09:38:38 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:76.00 stddev:11.97 (15.8%) stddev-sans-first:12.21 09:38:38 INFO - PROCESS | 1664 | Values: 64.0 68.0 67.0 61.0 61.0 84.0 89.0 87.0 88.0 65.0 09:38:38 INFO - PROCESS | 1664 | -------- Summary: end -------- 09:38:38 INFO - PROCESS | 1664 | 09:38:39 INFO - TEST-INFO | 1664: exit 0 09:38:39 INFO - TEST-OK | kraken | took 59480ms 09:38:39 INFO - SUITE-END | took 1178s 09:38:39 INFO - Completed test suite (00:19:38) 09:38:39 INFO - javascript benchmark 09:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.330607225519, 3277.8197199154038, 3312.138843900585, 3325.135464779158, 3325.401427743005, 5428.864278393033, 5549.278593782808, 5549.639273447233, 5571.331440227168, 5592.189132575779, 5537.750801213945, 5541.445855414457, 5582.330120385559, 5592.664440133584, 5654.0, 5106.1574840151425, 5115.4884511548735, 5159.664621799589, 5165.845024649267, 5186.7147306898105, 4563.520830312803, 5087.389513258414, 5184.585233181337, 5199.844004679866, 5234.790608375661, 4992.600591952653, 5171.586273098162, 5174.974125129369, 5225.63420560559, 5238.423773384925, 5011.223260394645, 5097.745112744348, 5112.156494178456, 5133.871653208681, 5150.742462876841, 5011.498850114959, 5030.622703297267, 5066.392032956032, 5086.3133476980875, 5090.618203634705, 5456.48163424478, 5492.313460817398, 5498.230247765316, 5519.806806761744, 5526.253955716007, 5286.312779338661, 6109.541784366146, 6138.938610613882, 6141.969290153565, 6145.293291271516, 5725.685087320196, 5827.096799996008, 5832.416758324176, 6100.511959043266, 6162.198914141178, 5641.26663533738, 5654.46282603152, 5656.066748986454, 5680.914786278209, 5692.544596432275, 6296.5592408531875, 6304.5271604628915, 6322.241331040213, 6332.271788744261, 6333.904991425133, 5844.678542680108, 5900.940990590125, 5984.222051133324, 5999.610025348338, 6000.519958403404, 6095.770848210712, 6099.817005489843, 6125.021800333839, 6125.571219981323, 6187.783427580013, 6029.517638588903, 6096.184014628394, 6114.38856114385, 6130.233720784902, 6139.907901381483, 6063.060225665029, 6134.325224225332, 6140.078988151724, 6152.046432802833, 6152.815415537541, 4760.595349395271, 4804.567588917014, 4811.27830825372, 4817.27740838877, 4825.0, 4326.891827704269, 4334.761588112684, 4339.327404252346, 4379.0366119453665, 4421.491528474202, 5573.108302671553, 5585.58108141891, 5587.106063029895, 5602.355729091125, 5605.159226116115, 6003.159557661931, 6007.459328660354, 6086.269647642312, 6165.722542485599, 6182.381761823782, 5527.309086364205, 5555.970427899351, 5573.219749235111, 5585.078462053716, 5626.409227031185, 5271.0, 5278.313819203556, 5285.180796976475, 5293.417724050351, 5297.602679799031, 6178.907316390168, 6291.6539590321145, 6298.7480500780375, 6323.272823625342, 6323.747050117944, 6068.757249709962, 6074.90887636677, 6109.283207920342, 6110.133516259585, 6114.633122012693, 6315.55791094619, 6322.557420980487, 6329.050642403677, 6333.904991425225, 6341.682915854281, 5832.650040997553, 5997.430244126801, 6035.969820150871, 6043.09353596964, 6048.637081775108, 5912.793052243323, 5996.370381110095, 6000.21997140369, 6004.0693692477735, 6048.153258543719, 5836.328822185334, 5848.239728835394, 5860.531157507304, 5860.648361098177, 5862.208601838868, 5818.76724930998, 5844.94155058444, 5850.736716847667, 5855.473007429352, 5862.560307976833, 5711.286089238845, 5746.396628353963, 5757.596968212185, 5761.711914404347, 5772.1341798728845, 5862.0, 5866.50134738552, 5870.589058765845, 5885.205497257986, 5892.793752218823, 5748.166515855094, 5772.336181339199, 5772.624779389326, 5776.306843178845, 5785.566082543742], "value": 5569.280657984408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.74616833825564, 520.7188118416055, 526.1581469648561, 526.6366207316951, 551.3273805956732, 32807.343853122926, 38571.0, 39725.80137099314, 39786.40320395193, 41815.79092104543, 40863.79568102163, 41205.58794412055, 41272.38091428631, 41275.58724412762, 41286.0, 8383.035950865667, 9323.254139668827, 9513.857292140588, 9514.381565198275, 9562.569684364185, 8423.452475589067, 11209.271397359187, 11472.541098356098, 11482.081433485342, 11602.419879006058, 11434.313941163557, 11497.425128743529, 11503.94248028763, 11508.777542288173, 11623.360715160663, 8453.619587118534, 8656.437331573428, 11286.0, 11373.658790236223, 11386.032187264092, 11115.72210694731, 11444.542218311257, 11482.82775758356, 11560.959513643813, 11575.53697852085, 39031.8048409759, 39362.21275574501, 39369.0, 39379.21241575181, 39448.802755986035, 3361.6638336166434, 3398.4052790761516, 3512.1921957949558, 3614.6023937366867, 3679.35611268027, 29144.0, 29427.852860735773, 30798.692013079806, 30851.0, 30873.0, 2752.215618548704, 3165.876113979527, 3267.4608689566194, 3295.24209431832, 3336.4494858348344, 462295.3770462286, 465269.67365163297, 466731.0, 466908.0, 483098.0, 60839.78320433655, 61222.77554448886, 61368.69315653393, 61545.69227153925, 61718.38281617216, 62265.68867155726, 62381.0, 62438.375616244164, 62445.0, 62459.192600924885, 15650.0, 15856.920715396349, 15891.841081589268, 15915.0450972942, 15924.442644507619, 10957.452127393757, 11204.15968802343, 11227.607033753779, 12180.451879665436, 12263.325517096646, 13083.934580327228, 16175.352985880669, 16278.75581866273, 16362.590935226715, 18054.74315710536, 6795.898061529081, 7915.366770658334, 8018.839623207503, 8086.555239461886, 8113.837723245502, 866.7226487524058, 898.2903506230006, 982.6020461713018, 995.8050339592373, 1162.7035106048072, 23827.880860595586, 28628.427431451255, 29368.0, 29834.95577654772, 30549.847250763603, 872.7992561710842, 939.9765005874771, 1063.4629512096496, 1095.9397233152094, 1206.1315852586124, 13302.600921972356, 14887.70224595502, 15306.158161301235, 15479.767803482957, 16096.597585060234, 643547.0, 649133.0, 649612.0, 650233.0, 651670.0, 57479.425205748244, 58241.0, 58350.0, 58370.0, 58373.12440313399, 1368.8699573540498, 1413.4770135049891, 1425.8502857199844, 1426.6362077670128, 1427.7215942891037, 28214.576781348707, 28764.71235287704, 28952.276193095342, 29442.263943401587, 29787.851060744557, 48949.0, 49462.75268623634, 49563.008739825724, 49596.0, 49640.503594963586, 545806.0, 546023.0, 547791.0, 549760.0, 550089.0, 25406.364840879127, 25535.489290214464, 25912.611310829976, 25956.480870382864, 26045.609315860656, 38818.06677794621, 39150.0, 39293.41059884161, 47658.761706191246, 48161.27758083701, 36323.091922702144, 38479.807600961816, 39332.41001384924, 39418.0, 40491.98770030773, 31127.279145360288, 36395.0, 38790.80604596959, 38880.0, 40039.599604004754, 38088.61911380962, 38504.80747596244, 38516.6148338513, 38639.0, 38965.41551876781, 32093.839530802197, 33869.32261354809, 34613.307733845686, 34812.9556113317, 34995.65004349924, 20660.483487912923, 25208.621870671588, 25298.873505632353, 25569.269685108313, 25573.744262557135], "value": 19884.222072113334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.50521795575975, 371.1463633642622, 375.93421151298514, 383.79275191396647, 398.06454831146806, 19163.52091197719, 19770.30803921863, 19802.405927822187, 20250.797492025056, 20458.69311960318, 18526.629467410676, 19253.807461925375, 19260.90369548154, 19585.41243762686, 20096.39710808678, 4682.0, 5731.283589551295, 5955.553333499983, 6020.337762846083, 6043.153958445821, 5883.205767221413, 6003.429674180946, 6007.579469437142, 6022.367651396606, 6022.8795424091495, 5524.447555244484, 5796.333421656522, 5825.563082768788, 5980.88038239235, 5987.820365389045, 5862.120681897707, 5902.114682797572, 5906.0, 5908.0, 5914.674692891911, 5629.690367029812, 5890.204822348971, 5942.792002279943, 5943.286805583314, 5949.345571987078, 11530.019948304403, 12794.936025319907, 14053.945954053384, 24787.628185577232, 25158.748412515823, 2114.143771772435, 2197.615417301966, 2225.5660146271484, 2290.4502919299416, 2319.3969567912463, 9388.671396501159, 10203.6428724995, 10206.897931020669, 12359.764023597658, 14659.560213193621, 1810.9094545272683, 1823.7811462624438, 1935.554822390858, 1955.8239758421669, 1959.8138176873174, 106231.46884265529, 109756.0, 112553.43723281413, 113070.30086088838, 113128.0, 10991.120710343153, 11093.944530277458, 11199.440027998568, 11232.269902456477, 11369.886301137049, 12731.045171612166, 13201.735965280832, 13688.247146406844, 13984.021118521607, 14146.363413646204, 8106.432549721463, 8233.670653173926, 8273.627686754111, 8358.414910956297, 8363.372747043995, 8117.634706438106, 8141.1451797561585, 8145.79635509117, 8317.126701696236, 8343.207395297437, 4359.825606975749, 4440.067585806952, 4454.910901781946, 4529.796159172845, 4537.342085397599, 1769.2922830867756, 1776.7068433708293, 1881.7177423386602, 1908.2462427341122, 1916.150914367642, 846.229930763015, 875.0461996423801, 892.6788353237116, 954.2509130332655, 955.9665411710696, 15621.82836287283, 15966.920165399331, 21235.68146477804, 21281.467963300733, 21296.574068518545, 803.6222975201646, 876.776896229756, 917.9724608261763, 931.329442801182, 932.3939439364467, 8366.414350995494, 9750.366226195274, 10912.417699433538, 11329.943350283196, 11338.716532086599, 449461.75269123446, 530510.0, 538549.0, 542572.0, 548165.0, 99482.0, 100886.0, 126448.36775816247, 131740.3412982929, 132299.0, 926.2404828041076, 959.822432849925, 964.3876138652007, 1002.6991902429243, 1005.959761609542, 18606.627867442847, 19000.904995474935, 19022.80977190266, 19182.232710691416, 19221.327253546617, 54762.726186370404, 55315.89368212533, 55542.0, 55561.7221913904, 55754.72122639361, 82144.94637634107, 82990.58504707438, 83742.58128709561, 83748.58125709332, 85031.0, 7391.2978267064545, 7480.513766605153, 8008.319292860172, 8089.433739638169, 8227.670893164206, 9722.854157187789, 12798.936005319914, 12974.0, 13119.75362340576, 13138.211707297593, 11071.557137714723, 11098.0, 11304.943475282571, 11318.717032074264, 11420.0, 10240.590376384862, 10570.2072344576, 10797.028267455968, 10848.67453976382, 10903.29128606638, 9515.762105947406, 11265.380404077854, 11303.1522635801, 11583.305001699924, 11819.0, 7876.267221211324, 7876.330511906552, 7997.640106195351, 8311.750647480585, 8314.542700151549, 8269.421140520106, 9757.951210243904, 11009.61466348674, 11282.266652667551, 11303.943480282545], "value": 9297.964456725223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.012496939474, 1568.945086921958, 1809.3263731048785, 1909.3603642779667, 1975.2296604324306, 7548.81127971801, 7799.805004874881, 8097.959510202448, 8497.660093596256, 8510.787230319238, 7677.731279405222, 7870.763877083697, 8086.231807978247, 8275.379346549003, 8308.54303013334, 1938.37002974034, 2118.8410869184795, 2336.2523992322463, 2336.380859072339, 2338.7895089441945, 2065.0, 2305.2162264829954, 2340.0990618611872, 2353.329301149173, 2356.1046802215133, 2083.6770300603357, 2109.778473260301, 2112.334614596405, 2113.365990202941, 2114.143771772435, 1928.305809908439, 2226.2430773536994, 2291.667708182304, 2303.0557471436796, 2304.2856714418585, 2291.4385975435957, 2313.0747700919596, 2323.314622186442, 2329.3710698111413, 2330.1378489958656, 8350.498970061815, 8427.073021967579, 8451.957740211321, 8458.0, 8486.448380855225, 4454.220511410523, 5089.847304580869, 5255.6583822051825, 5262.05283049051, 5263.526282634582, 3230.450823360011, 3463.79217246966, 3546.627604101584, 3550.928981420383, 3568.232829941549, 907.9682211122579, 1042.0621440703428, 1079.3200283821143, 1082.258652822811, 1084.5878566144893, 10848.67453976382, 10917.617883374123, 10924.235303528756, 10937.781244375148, 10946.671599852018, 4338.674599405057, 4583.54164583539, 4699.130660827758, 4702.482726900038, 4705.247160454379, 7946.721864734706, 9407.106324899123, 9411.4823684698, 9427.387219830689, 9451.858222126673, 5222.477752224747, 5223.895522089537, 5227.817026404134, 5228.163493840967, 5242.52817246442, 3977.6022397759994, 4618.607418369409, 4802.51974802517, 4820.9517904821205, 4822.758862056883, 3712.554493460802, 3739.607341229186, 3771.6228377162615, 3813.218290250492, 3820.6179382061573, 1253.6552448076852, 1254.103316128954, 1255.7802384582844, 1271.1419791640606, 1272.4210484229654, 886.5257087458178, 909.3043821476575, 924.9213816825511, 937.3482754178966, 970.7427531704104, 5645.6694866896405, 5652.886942261214, 5803.5979338597535, 5848.0350742127075, 5992.400759923973, 425.20698896557695, 432.3406804622975, 434.24224727850105, 446.57129156009944, 451.3883687603316, 3078.3843231353817, 3284.5201872586044, 3853.9016380331473, 3949.2101579683604, 4051.0, 9441.527923603793, 9909.950450247703, 9965.55155018026, 9980.800383992424, 10183.134433573081, 10020.849687254697, 10025.498725063864, 10051.798964020678, 10058.59765609382, 10058.949705251427, 7664.271894170045, 7870.921290787019, 7877.803054923673, 7878.763637090897, 7897.526148431112, 4626.83806066786, 5365.1949915545765, 5749.91375129365, 5912.260967379078, 6109.84725381869, 9183.357164998386, 9237.353385262966, 9321.39410938314, 9330.440173589606, 9452.338336316667, 9255.120763527455, 9356.251499880129, 9368.718938431857, 9403.623855045722, 9467.715968520955, 7078.964605177147, 7204.351608355273, 7218.205997340184, 7219.45854060937, 7223.494355395072, 7669.5398276103615, 7752.457327987212, 7765.990421245202, 7822.178671239438, 7835.921640783519, 7027.191872934473, 7077.186123595852, 7095.680694368869, 7099.538529995534, 7190.137183538009, 6229.314775374796, 6986.47601429905, 7010.123734533184, 7062.975868499142, 7074.575525468488, 6539.149910511603, 6589.4069533742195, 6655.068290439245, 6665.50008749336, 6669.53313268086, 4453.621442177451, 4670.696404733681, 4756.548127927841, 4864.124457597666, 4937.1113199624415, 4829.396325459317, 4930.359053323045, 4987.551120399182, 5022.0, 5122.899611159407], "value": 4310.720473342059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.8107031934379, 273.55137574378017, 280.07435425917333, 297.7409653601367, 306.52029573717135, 4287.978560107195, 4982.928670335881, 5082.567981721553, 5272.947270527294, 5310.495502927225, 4443.60007599316, 5212.853172302097, 5240.37115546135, 5255.658382205154, 5258.368995720519, 3470.861165553375, 3509.3332266869215, 3705.794487768088, 3941.251162279165, 3987.9601203988022, 3611.4763359312883, 3739.719521035933, 3789.9009287306785, 3798.4112462568346, 3980.2835489611857, 3424.708899743512, 3434.2616337487434, 3947.5460322063045, 3955.821988010532, 3974.94663914063, 3128.499440089586, 3263.7389008879472, 3283.688049635281, 3515.716763381373, 3710.7939919526125, 3432.031292931621, 3438.6045604755523, 3443.9311213775586, 3463.79217246966, 3466.4626982817704, 4824.1316563018645, 5019.598432125457, 5083.661515702781, 5108.646208754683, 5116.69299842007, 3945.9013524661827, 4495.64034877209, 4538.686758666159, 4542.341360502742, 4563.224251877155, 5475.534579560742, 5495.230667706524, 5507.449255074501, 5512.645010441746, 5583.157558005848, 3181.5704879841155, 3625.024361722841, 3721.7394782365245, 3761.2665530221616, 3768.4926029588382, 5702.781954511617, 5717.371089180187, 5795.942040579583, 5824.912626310609, 5834.883302333972, 3211.245357341023, 3787.62123787619, 3805.46723458716, 3834.405667121601, 3835.753380151462, 3268.3790079884748, 3426.749236528699, 3477.826108694555, 3613.4941108244866, 3697.9845983938817, 3918.8040597970557, 4095.7952102395357, 4274.7435153890865, 4435.711678740871, 4496.505384407713, 5587.38538760736, 5618.6628802272, 5619.8595035124445, 5622.240997465372, 5676.858078548069, 1092.9398883061508, 1299.1750238598559, 1322.2661422910378, 1337.6155678872321, 1346.8989825763108, 709.8464994384126, 757.3978686943783, 760.5968836516655, 802.9882348241258, 819.6557445872747, 3369.3261347730554, 4324.567543245713, 4336.441499515301, 4393.956060439355, 4409.889752756207, 3925.430812532167, 4777.474477807438, 4784.808607655725, 4789.856304310876, 4802.351682522814, 3647.7628954118427, 4206.957930420656, 4220.07158425146, 4319.611234988866, 4354.538142176977, 2158.758713739606, 2243.9804176241187, 2278.5101203241384, 2407.882520889264, 2445.4008767851633, 4214.726042807208, 4270.402143699885, 4552.2488789350045, 4599.494055653875, 4924.384451943507, 4264.460497786829, 4583.968607063384, 4738.597219236334, 4792.448868380111, 4860.902781944341, 4070.8398106539494, 4422.137683151819, 5440.537554307928, 5959.553033522417, 6057.545684073624, 5396.78412863481, 5774.971125144515, 5801.245838041028, 5809.0, 5818.040023396092, 5524.348312809793, 5693.686847223443, 5705.060279504988, 5709.172170035405, 5732.71336433185, 4825.876614289701, 5099.209622508517, 5504.779808807602, 5763.33721622002, 5961.731722072604, 3706.7034637229494, 3867.0332416895776, 3881.5536213335827, 3886.397608370707, 3922.9019274518364, 4905.607551395951, 5463.579469337921, 5789.421057894346, 5838.2702162229725, 5854.619449735754, 4737.8341758038305, 5564.0, 5596.796688711946, 5601.41185175567, 5616.297962754656, 5567.383329834971, 5579.804706835242, 5603.55171586264, 5610.495055444866, 5632.774689012557, 4191.3293872980175, 4960.900781984412, 5402.297701298806, 5434.83695489136, 5518.972405137949, 5518.448155184449, 5591.496765291144, 5610.018246806874, 5615.326160860723, 5623.128415095667, 4557.589816916494, 5442.401335852974, 5457.235986961908, 5486.286782718221, 5487.067198576172], "value": 3850.5033721664076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.5326080981815, 810.2302812328289, 816.3713940265995, 825.150095401736, 836.6653338664534, 14687.118772873635, 15161.090334579932, 15186.848131518682, 15198.164100974442, 15235.31441085151, 13656.24890631015, 13751.0, 13759.105658132214, 13779.379927903243, 13824.239666818321, 696.7944456385353, 720.5748608321089, 870.0994470722803, 878.8462019146656, 891.3849443883732, 887.4542156573725, 896.7758060484879, 896.9730908072736, 897.9775505612347, 898.9685361012366, 923.4413180026088, 945.3288165402572, 946.096477863642, 947.9383840050375, 948.4404201521102, 941.2893265584509, 941.3928016429434, 941.5433514745378, 942.0814705661993, 942.6606421688186, 550.3066136667827, 572.4962033410613, 575.2435547255346, 576.435093608262, 595.4313630482878, 11906.0, 12213.145079844415, 13808.792868106986, 14332.928335358256, 14697.338619762137, 13845.30773461333, 14068.366923488467, 14124.858751412457, 14180.574582762534, 14270.785938210935, 11501.884981150166, 11514.654560363202, 11558.422078896021, 11893.405329733565, 11913.761724765456, 3734.7572407793405, 3743.32878242522, 3743.700503959704, 3764.3224219640456, 3900.6294402031763, 89934.55032724794, 93135.53432232795, 94870.05129948682, 95896.52051739766, 96014.51992739992, 10304.948475257575, 10309.587616495257, 10854.0, 10900.618478353219, 11291.49188286529, 21747.456313592287, 21960.388318452984, 22022.44943876416, 22105.226317078825, 22117.0, 7684.346830519356, 7855.175206603339, 7868.449208555347, 7908.288254057163, 7909.327707144842, 3552.91117722059, 4227.8097485613225, 4326.935095973563, 4475.1273501666865, 4517.75152366623, 2990.2374894401787, 3457.533233013561, 3521.3133438979153, 3552.98223508886, 3563.6970857476886, 612.301975747648, 625.4308579193004, 632.8544434780026, 635.3900255754435, 640.2093414632925, 548.8161465908966, 586.8562202260473, 624.4723208888482, 653.6404977262487, 653.6404977262582, 8628.396012279205, 9076.455412675261, 9131.0, 9413.058694130668, 9457.33798634089, 537.4061661863662, 602.3133627664466, 638.814743724324, 667.6594936582378, 671.8219671786981, 4414.602685758297, 4544.772761361919, 4549.886252843706, 4560.224761790503, 4658.440987081572, 81416.59291703622, 105698.41452378221, 110873.44563277133, 112464.0, 112497.43751281354, 79191.0, 79281.0, 79718.80421793678, 90973.09026909778, 100638.0, 80697.0, 81416.0, 83399.16600834035, 83818.0, 85437.14562854292, 9530.571124299284, 9743.707688769347, 9744.0, 9751.804963900824, 9790.216782657513, 43996.56003440053, 46491.76754116208, 47969.76015119902, 54619.45380546144, 54977.0, 52057.73971130272, 56078.0, 70500.23749406305, 74253.62873185599, 74491.13772155739, 12690.428930697955, 12696.238225706487, 13029.15310504814, 13074.346282686018, 13104.0, 11223.71940701489, 14255.073420228067, 14270.500532481314, 14583.197924114276, 14883.553493395215, 13306.20347394541, 13307.001974852119, 13424.261665608485, 13847.446102156204, 13932.860671393157, 13005.0, 13236.602901912958, 13336.39986200604, 13383.263920484467, 13845.930770346084, 12840.743185136433, 13055.608331750063, 13339.13252144681, 13382.197068175552, 13750.931245343709, 8984.775380615536, 10421.218408619232, 11071.955212316678, 11604.94197529007, 11829.408529573315, 10017.599296028076, 10499.527521261409, 10566.207534435101, 10749.301295415773, 11537.365444900612], "value": 7350.514696278858, "unit": "score"}], "name": "dromaeo_css", "value": 7077.099066608511, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 115.0, 148.0, 113.0, 114.0, 111.0, 111.0, 143.0, 114.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 182.0, 185.0, 183.0, 181.0, 179.0, 181.0, 182.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 87.0, 61.0, 59.0, 58.0, 59.0, 83.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 91.0, 70.0, 70.0, 68.0, 92.0, 67.0, 69.0, 88.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 90.0, 85.0, 88.0, 87.0, 95.0, 88.0, 94.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 148.0, 130.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 79.0, 84.0, 85.0, 85.0, 83.0, 85.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 78.0, 71.0, 68.0, 68.0, 72.0, 68.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 91.0, 86.0, 91.0, 86.0, 87.0, 87.0, 94.0, 101.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 149.0, 152.0, 164.0, 147.0, 136.0, 154.0, 216.0, 163.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 171.0, 171.0, 171.0, 173.0, 170.0, 172.0, 162.0, 170.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 67.0, 61.0, 61.0, 84.0, 89.0, 87.0, 88.0, 65.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1457.5999999999997, "alertThreshold": 2.0}]} 09:38:39 INFO - Return code: 0 09:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:39 INFO - # TBPL SUCCESS # 09:38:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:39 INFO - 2016-10-29 09:38:39.654 screenresolution[1668:10045] starting screenresolution argv=screenresolution get 09:38:39 INFO - 2016-10-29 09:38:39.657 screenresolution[1668:10045] Display 0: 1600x1200x32@60 09:38:39 INFO - 2016-10-29 09:38:39.663 screenresolution[1669:10048] starting screenresolution argv=screenresolution list 09:38:39 INFO - Available Modes on Display 0 09:38:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:39 INFO - Intel Iris: 09:38:39 INFO - Chipset Model: Intel Iris 09:38:39 INFO - Type: GPU 09:38:39 INFO - Bus: Built-In 09:38:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:39 INFO - Vendor: Intel (0x8086) 09:38:39 INFO - Device ID: 0x0a2e 09:38:39 INFO - Revision ID: 0x0009 09:38:39 INFO - Displays: 09:38:39 INFO - Display: 09:38:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:39 INFO - Display Serial Number: 1600x1200 60 09:38:39 INFO - Main Display: Yes 09:38:39 INFO - Mirror: Off 09:38:39 INFO - Online: Yes 09:38:39 INFO - Rotation: Supported 09:38:39 INFO - Return code: 0 09:38:39 INFO - Running post-action listener: _resource_record_post_action 09:38:39 INFO - [mozharness: 2016-10-29 16:38:39.912579Z] Finished run-tests step (success) 09:38:39 INFO - Running post-run listener: _resource_record_post_run 09:38:39 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37532672; Write bytes: 708402176; Read time: 248; Write time: 1971 09:38:39 INFO - TinderboxPrint: CPU usage
53.6% 09:38:39 INFO - TinderboxPrint: I/O read bytes / time
37,532,672 / 248 09:38:39 INFO - TinderboxPrint: I/O write bytes / time
708,402,176 / 1,971 09:38:39 INFO - TinderboxPrint: CPU idle
2,254.6 (46.4%) 09:38:39 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 09:38:39 INFO - TinderboxPrint: CPU user
1,631.6 (33.6%) 09:38:39 INFO - TinderboxPrint: Swap in / out
444,198,912 / 0 09:38:39 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389413376; Write bytes: 384435712; Read time: 29486; Write time: 803 09:38:39 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36578304; Write bytes: 298063360; Read time: 236; Write time: 1106 09:38:40 INFO - Running post-run listener: _upload_blobber_files 09:38:40 INFO - Blob upload gear active. 09:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:38:40 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:40 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:41 INFO - (blobuploader) - INFO - Done attempting. 09:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:42 INFO - (blobuploader) - INFO - Done attempting. 09:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:44 INFO - (blobuploader) - INFO - Done attempting. 09:38:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:44 INFO - Return code: 0 09:38:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9645b52cd6bef992219aa74788a588d5c5ae9a410e526d776a917f3721b29e8d50319ad5179612daa6112042e8fc199600cd29d4c1e9063e8796c162965785b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca41659aa4cbed6bd8ca5306a65f0721ca649b1b07089a0f613b0b21173e335016a483ca1d1394cd5eeb30c3be663221f741393a1dcdeda6af245305253423b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74a42f007e84acf6c3b1bab5841669c194207e60a2a7d58661fff0a12e914e2f1c7c4ebbadc45a29ad7e50f8b651c96fd118fa6e25ee520279a1aab283697751"} 09:38:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:44 INFO - Contents: 09:38:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9645b52cd6bef992219aa74788a588d5c5ae9a410e526d776a917f3721b29e8d50319ad5179612daa6112042e8fc199600cd29d4c1e9063e8796c162965785b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca41659aa4cbed6bd8ca5306a65f0721ca649b1b07089a0f613b0b21173e335016a483ca1d1394cd5eeb30c3be663221f741393a1dcdeda6af245305253423b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74a42f007e84acf6c3b1bab5841669c194207e60a2a7d58661fff0a12e914e2f1c7c4ebbadc45a29ad7e50f8b651c96fd118fa6e25ee520279a1aab283697751"} 09:38:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:44 INFO - Copying logs to upload dir... 09:38:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.475538 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-29 09:38:44.590226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:38:44.593747) ========= 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.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/Firefox/sha512/a9645b52cd6bef992219aa74788a588d5c5ae9a410e526d776a917f3721b29e8d50319ad5179612daa6112042e8fc199600cd29d4c1e9063e8796c162965785b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca41659aa4cbed6bd8ca5306a65f0721ca649b1b07089a0f613b0b21173e335016a483ca1d1394cd5eeb30c3be663221f741393a1dcdeda6af245305253423b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74a42f007e84acf6c3b1bab5841669c194207e60a2a7d58661fff0a12e914e2f1c7c4ebbadc45a29ad7e50f8b651c96fd118fa6e25ee520279a1aab283697751"} build_url:https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/RhrWpSubQsS1SHtTePwsdw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9645b52cd6bef992219aa74788a588d5c5ae9a410e526d776a917f3721b29e8d50319ad5179612daa6112042e8fc199600cd29d4c1e9063e8796c162965785b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca41659aa4cbed6bd8ca5306a65f0721ca649b1b07089a0f613b0b21173e335016a483ca1d1394cd5eeb30c3be663221f741393a1dcdeda6af245305253423b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74a42f007e84acf6c3b1bab5841669c194207e60a2a7d58661fff0a12e914e2f1c7c4ebbadc45a29ad7e50f8b651c96fd118fa6e25ee520279a1aab283697751"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:38:44.627075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:38:44.627451) ========= 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.VvRWtliehs/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.dH9SDP9up3/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.004967 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:38:44.676182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:38:44.676500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:38:44.676846) ========= ========= Total master_lag: 0.18 =========